builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0032 starttime: 1486416239.82 results: success (0) buildid: 20170206103455 builduid: 5ee3934bf05c4ef19c963ab591b9e365 revision: dcdc85ecb2f31204d00686f88e8f452bf2526b65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 13:23:59.819097) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 13:23:59.819557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 13:23:59.819855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 13:23:59.846280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:23:59.846645) ========= 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.5I6bv8QBkq/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.q7PRmD56FL/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-06 13:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.0M=0.001s 2017-02-06 13:24:00 (16.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:00.047950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:00.048260) ========= 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.5I6bv8QBkq/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.q7PRmD56FL/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.027241 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:00.097485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 13:24:00.097848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcdc85ecb2f31204d00686f88e8f452bf2526b65 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcdc85ecb2f31204d00686f88e8f452bf2526b65 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5I6bv8QBkq/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.q7PRmD56FL/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-06 13:24:00,200 truncating revision to first 12 chars 2017-02-06 13:24:00,201 Setting DEBUG logging. 2017-02-06 13:24:00,201 attempt 1/10 2017-02-06 13:24:00,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dcdc85ecb2f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 13:24:01,235 unpacking tar archive at: mozilla-beta-dcdc85ecb2f3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.299280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 13:24:01.420251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:01.420574) ========= script_repo_revision: dcdc85ecb2f31204d00686f88e8f452bf2526b65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:01.420970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:01.421234) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 13:24:01.446052) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-06 13:24:01.446425) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5I6bv8QBkq/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.q7PRmD56FL/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:24:01 INFO - MultiFileLogger online at 20170206 13:24:01 in /builds/slave/test 13:24:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:24:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:24:01 INFO - {'append_to_log': False, 13:24:01 INFO - 'base_work_dir': '/builds/slave/test', 13:24:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:24:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:24:01 INFO - 'branch': 'Mozilla-Beta', 13:24:01 INFO - 'buildbot_json_path': 'buildprops.json', 13:24:01 INFO - 'config_files': ('talos/mac_config.py',), 13:24:01 INFO - 'default_actions': ('clobber', 13:24:01 INFO - 'read-buildbot-config', 13:24:01 INFO - 'download-and-extract', 13:24:01 INFO - 'populate-webroot', 13:24:01 INFO - 'create-virtualenv', 13:24:01 INFO - 'install', 13:24:01 INFO - 'run-tests'), 13:24:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:24:01 INFO - 'download_minidump_stackwalk': True, 13:24:01 INFO - 'download_symbols': 'ondemand', 13:24:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:24:01 INFO - 'tooltool.py': '/tools/tooltool.py', 13:24:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:24:01 INFO - '/tools/misc-python/virtualenv.py')}, 13:24:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:24:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:24:01 INFO - 'installer_path': 'installer.exe', 13:24:01 INFO - 'log_level': 'info', 13:24:01 INFO - 'log_name': 'talos', 13:24:01 INFO - 'log_to_console': True, 13:24:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:24:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:24:01 INFO - 'opt_config_files': (), 13:24:01 INFO - 'pip_index': False, 13:24:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:24:01 INFO - 'cmd': ('bash', 13:24:01 INFO - '-c', 13:24:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:24:01 INFO - 'enabled': True, 13:24:01 INFO - 'halt_on_failure': False, 13:24:01 INFO - 'name': 'check_screen_resolution'},), 13:24:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:24:01 INFO - 'cmd': ('bash', 13:24:01 INFO - '-c', 13:24:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:24:01 INFO - 'enabled': True, 13:24:01 INFO - 'halt_on_failure': False, 13:24:01 INFO - 'name': 'check_screen_resolution'},), 13:24:01 INFO - 'run_cmd_checks_enabled': True, 13:24:01 INFO - 'sps_profile': False, 13:24:01 INFO - 'sps_profile_interval': 0, 13:24:01 INFO - 'suite': 'dromaeojs-e10s', 13:24:01 INFO - 'system_bits': '32', 13:24:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:24:01 INFO - 'title': 't-yosemite-r7-0032', 13:24:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:24:01 INFO - 'use_talos_json': True, 13:24:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:24:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:24:01 INFO - 'work_dir': 'build'} 13:24:01 INFO - [mozharness: 2017-02-06 21:24:01.661940Z] Running clobber step. 13:24:01 INFO - Running pre-action listener: _resource_record_pre_action 13:24:01 INFO - Running main action method: clobber 13:24:01 INFO - rmtree: /builds/slave/test/build 13:24:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:24:04 INFO - Running post-action listener: _resource_record_post_action 13:24:04 INFO - [mozharness: 2017-02-06 21:24:04.143000Z] Finished clobber step (success) 13:24:04 INFO - [mozharness: 2017-02-06 21:24:04.143161Z] Running read-buildbot-config step. 13:24:04 INFO - Running pre-action listener: _resource_record_pre_action 13:24:04 INFO - Running main action method: read_buildbot_config 13:24:04 INFO - Using buildbot properties: 13:24:04 INFO - { 13:24:04 INFO - "project": "", 13:24:04 INFO - "product": "firefox", 13:24:04 INFO - "script_repo_revision": "production", 13:24:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:24:04 INFO - "repository": "", 13:24:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:24:04 INFO - "buildid": "20170206103455", 13:24:04 INFO - "pgo_build": "False", 13:24:04 INFO - "basedir": "/builds/slave/test", 13:24:04 INFO - "buildnumber": 14, 13:24:04 INFO - "slavename": "t-yosemite-r7-0032", 13:24:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 13:24:04 INFO - "platform": "yosemite_r7", 13:24:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:24:04 INFO - "branch": "mozilla-beta", 13:24:04 INFO - "repo_path": "releases/mozilla-beta", 13:24:04 INFO - "revision": "dcdc85ecb2f31204d00686f88e8f452bf2526b65", 13:24:04 INFO - "stage_platform": "macosx64", 13:24:04 INFO - "builduid": "5ee3934bf05c4ef19c963ab591b9e365", 13:24:04 INFO - "slavebuilddir": "test" 13:24:04 INFO - } 13:24:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:24:04 INFO - Running post-action listener: _resource_record_post_action 13:24:04 INFO - [mozharness: 2017-02-06 21:24:04.146530Z] Finished read-buildbot-config step (success) 13:24:04 INFO - [mozharness: 2017-02-06 21:24:04.146661Z] Running download-and-extract step. 13:24:04 INFO - Running pre-action listener: _resource_record_pre_action 13:24:04 INFO - Running main action method: download_and_extract 13:24:04 INFO - mkdir: /builds/slave/test/build/tests 13:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:04 INFO - trying https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:24:04 INFO - Downloading https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 13:24:05 INFO - Downloaded 1165 bytes. 13:24:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:24:05 INFO - Using the following test package requirements: 13:24:05 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:24:05 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:24:05 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:24:05 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:24:05 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:24:05 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:24:05 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:24:05 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:24:05 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:24:05 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:24:05 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:24:05 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:24:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:24:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:24:05 INFO - Fetch https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:24:06 INFO - Http code: 200 13:24:06 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 13:24:06 INFO - x-amz-cf-id: 5-3KE5KptXDte27EzZNbdUCu-PnjpF1LhiXu8Ch8hw28WTcD9rq-uw== 13:24:06 INFO - x-amz-version-id: hXhOm1pRXscPAfW1Qub_mUcKYa2zmc.0 13:24:06 INFO - Expected file size: 16091807 13:24:06 INFO - Obtained file size: 16091807 13:24:13 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:24:13 INFO - Http code: 200 13:24:13 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 13:24:13 INFO - x-amz-cf-id: 7vf-ufKAWHLmbFka21_YJPRCURHrz3zA9KW1qS5Zc8LhLhWGD7cVWA== 13:24:13 INFO - x-amz-version-id: hXhOm1pRXscPAfW1Qub_mUcKYa2zmc.0 13:24:14 INFO - Expected file size: 16091807 13:24:14 INFO - Obtained file size: 16091807 13:24:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:24:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:24:20 INFO - Fetch https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:24:21 INFO - Http code: 200 13:24:21 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 13:24:21 INFO - x-amz-cf-id: z0YJPv5KDr6D6oq2JeN6cplq1qwrq42JtEhA-JGCQOYSuV9an4X-Sw== 13:24:21 INFO - x-amz-version-id: m7zQqshnEBWnivlMH1N0YWkVoqspaz8g 13:24:21 INFO - Expected file size: 14403005 13:24:21 INFO - Obtained file size: 14403005 13:24: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')]} 13:24:21 INFO - trying https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:24:21 INFO - Downloading https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 13:24:23 INFO - Downloaded 82135824 bytes. 13:24:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:24:23 INFO - mkdir: /builds/slave/test/properties 13:24:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:24:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:24:23 INFO - Contents: 13:24:23 INFO - build_url:https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:24:25 INFO - Running post-action listener: _resource_record_post_action 13:24:25 INFO - Running post-action listener: set_extra_try_arguments 13:24:25 INFO - [mozharness: 2017-02-06 21:24:25.066497Z] Finished download-and-extract step (success) 13:24:25 INFO - [mozharness: 2017-02-06 21:24:25.066632Z] Running populate-webroot step. 13:24:25 INFO - Running pre-action listener: _resource_record_pre_action 13:24:25 INFO - Running main action method: populate_webroot 13:24:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:24:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:24:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:24:25 INFO - '--tppagecycles', 13:24:25 INFO - '7'], 13:24:25 INFO - 'tests': ['tsvgm']}}, 13:24:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:24:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:24:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:24:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:24:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:24:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:24:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['damp', 'tps']}, 13:24:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'tests': ['damp', 'tps']}, 13:24:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['dromaeo_dom']}, 13:24:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:24:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['basic_compositor_video']}, 13:24:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:24:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['a11yr', 13:24:25 INFO - 'ts_paint', 13:24:25 INFO - 'tpaint', 13:24:25 INFO - 'sessionrestore', 13:24:25 INFO - 'sessionrestore_no_auto_restore', 13:24:25 INFO - 'tabpaint']}, 13:24:25 INFO - 'other-e10s': {'tests': ['a11yr', 13:24:25 INFO - 'ts_paint', 13:24:25 INFO - 'tpaint', 13:24:25 INFO - 'sessionrestore', 13:24:25 INFO - 'sessionrestore_no_auto_restore', 13:24:25 INFO - 'tabpaint']}, 13:24:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:24:25 INFO - 'ts_paint', 13:24:25 INFO - 'tpaint', 13:24:25 INFO - 'sessionrestore', 13:24:25 INFO - 'sessionrestore_no_auto_restore', 13:24:25 INFO - 'tabpaint']}, 13:24:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:24:25 INFO - 'ts_paint', 13:24:25 INFO - 'tpaint', 13:24:25 INFO - 'sessionrestore', 13:24:25 INFO - 'sessionrestore_no_auto_restore', 13:24:25 INFO - 'tabpaint']}, 13:24:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['a11yr', 13:24:25 INFO - 'ts_paint', 13:24:25 INFO - 'tpaint', 13:24:25 INFO - 'sessionrestore', 13:24:25 INFO - 'sessionrestore_no_auto_restore', 13:24:25 INFO - 'tabpaint']}, 13:24:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['a11yr', 13:24:25 INFO - 'ts_paint', 13:24:25 INFO - 'tpaint', 13:24:25 INFO - 'sessionrestore', 13:24:25 INFO - 'sessionrestore_no_auto_restore', 13:24:25 INFO - 'tabpaint']}, 13:24:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['tsvgx', 13:24:25 INFO - 'tsvgr_opacity', 13:24:25 INFO - 'tart', 13:24:25 INFO - 'tscrollx', 13:24:25 INFO - 'cart']}, 13:24:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:24:25 INFO - 'tsvgr_opacity', 13:24:25 INFO - 'tart', 13:24:25 INFO - 'tscrollx', 13:24:25 INFO - 'cart']}, 13:24:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'talos_options': ['--disable-e10s'], 13:24:25 INFO - 'tests': ['tp5o']}, 13:24:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'tests': ['tp5o']}, 13:24:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'talos_options': ['--disable-e10s', 13:24:25 INFO - '--xperf_path', 13:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:24:25 INFO - 'tests': ['tp5n']}, 13:24:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:24:25 INFO - 'talos_options': ['--xperf_path', 13:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:24:25 INFO - 'tests': ['tp5n']}}, 13:24:25 INFO - 'talos.zip': {'path': '', 13:24:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:24:25 INFO - Running post-action listener: _resource_record_post_action 13:24:25 INFO - [mozharness: 2017-02-06 21:24:25.085570Z] Finished populate-webroot step (success) 13:24:25 INFO - [mozharness: 2017-02-06 21:24:25.085676Z] Running create-virtualenv step. 13:24:25 INFO - Running pre-action listener: _resource_record_pre_action 13:24:25 INFO - Running main action method: create_virtualenv 13:24:25 INFO - Creating virtualenv /builds/slave/test/build/venv 13:24:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:24:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:24:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:24:25 INFO - Using real prefix '/tools/python27' 13:24:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:24:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:24:28 INFO - Installing pip.................done. 13:24:28 INFO - Return code: 0 13:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:24:29 INFO - Reading from file tmpfile_stdout 13:24:29 INFO - Output received: 13:24:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:24:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:24: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')]} 13:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24: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')]} 13:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24: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', 'pip>=1.5'] in /builds/slave/test/build 13:24: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 pip>=1.5 13:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:29 INFO - 'HOME': '/Users/cltbld', 13:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:29 INFO - 'LOGNAME': 'cltbld', 13:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:29 INFO - 'MOZ_NO_REMOTE': '1', 13:24:29 INFO - 'NO_EM_RESTART': '1', 13:24:29 INFO - 'PAGER': '/bin/cat', 13:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:29 INFO - 'PWD': '/builds/slave/test', 13:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:29 INFO - 'SHELL': '/bin/bash', 13:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:29 INFO - 'USER': 'cltbld', 13:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:29 INFO - 'XPC_FLAGS': '0x0', 13:24:29 INFO - 'XPC_SERVICE_NAME': '0', 13:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24: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 13:24:29 INFO - Cleaning up... 13:24:29 INFO - Return code: 0 13:24:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:24: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')]} 13:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24: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')]} 13:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24: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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24: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 13:24: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 13:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:29 INFO - 'HOME': '/Users/cltbld', 13:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:29 INFO - 'LOGNAME': 'cltbld', 13:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:29 INFO - 'MOZ_NO_REMOTE': '1', 13:24:29 INFO - 'NO_EM_RESTART': '1', 13:24:29 INFO - 'PAGER': '/bin/cat', 13:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:29 INFO - 'PWD': '/builds/slave/test', 13:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:29 INFO - 'SHELL': '/bin/bash', 13:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:29 INFO - 'USER': 'cltbld', 13:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:29 INFO - 'XPC_FLAGS': '0x0', 13:24:29 INFO - 'XPC_SERVICE_NAME': '0', 13:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:29 INFO - Downloading/unpacking psutil>=3.1.1 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:24:32 INFO - Installing collected packages: psutil 13:24:32 INFO - Running setup.py install for psutil 13:24:33 INFO - building 'psutil._psutil_osx' extension 13:24: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:24: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 13:24: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 13:24: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 13:24:33 INFO - building 'psutil._psutil_posix' extension 13:24: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 13:24:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:24:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:24:34 INFO - ^ 13:24:34 INFO - 1 warning generated. 13:24:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:24:34 INFO - Successfully installed psutil 13:24:34 INFO - Cleaning up... 13:24:34 INFO - Return code: 0 13:24:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:34 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:34 INFO - 'HOME': '/Users/cltbld', 13:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:34 INFO - 'LOGNAME': 'cltbld', 13:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:34 INFO - 'MOZ_NO_REMOTE': '1', 13:24:34 INFO - 'NO_EM_RESTART': '1', 13:24:34 INFO - 'PAGER': '/bin/cat', 13:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:34 INFO - 'PWD': '/builds/slave/test', 13:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:34 INFO - 'SHELL': '/bin/bash', 13:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:34 INFO - 'USER': 'cltbld', 13:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:34 INFO - 'XPC_FLAGS': '0x0', 13:24:34 INFO - 'XPC_SERVICE_NAME': '0', 13:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:24:37 INFO - Installing collected packages: mozsystemmonitor 13:24:37 INFO - Running setup.py install for mozsystemmonitor 13:24:37 INFO - Successfully installed mozsystemmonitor 13:24:37 INFO - Cleaning up... 13:24:37 INFO - Return code: 0 13:24:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:24: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')]} 13:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24: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')]} 13:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24: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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24: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 13:24: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 13:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:37 INFO - 'HOME': '/Users/cltbld', 13:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:37 INFO - 'LOGNAME': 'cltbld', 13:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:37 INFO - 'MOZ_NO_REMOTE': '1', 13:24:37 INFO - 'NO_EM_RESTART': '1', 13:24:37 INFO - 'PAGER': '/bin/cat', 13:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:37 INFO - 'PWD': '/builds/slave/test', 13:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:37 INFO - 'SHELL': '/bin/bash', 13:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:37 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:37 INFO - 'USER': 'cltbld', 13:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:37 INFO - 'XPC_FLAGS': '0x0', 13:24:37 INFO - 'XPC_SERVICE_NAME': '0', 13:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:24:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:24:40 INFO - warning: no files found matching '*.txt' 13:24:40 INFO - no previously-included directories found matching 'build' 13:24:40 INFO - no previously-included directories found matching 'dist' 13:24:40 INFO - no previously-included directories found matching '.git*' 13:24:40 INFO - Installing collected packages: jsonschema, functools32 13:24:40 INFO - Running setup.py install for functools32 13:24:41 INFO - warning: no files found matching '*.txt' 13:24:41 INFO - no previously-included directories found matching 'build' 13:24:41 INFO - no previously-included directories found matching 'dist' 13:24:41 INFO - no previously-included directories found matching '.git*' 13:24:41 INFO - Successfully installed jsonschema functools32 13:24:41 INFO - Cleaning up... 13:24:41 INFO - Return code: 0 13:24:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:41 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:41 INFO - 'HOME': '/Users/cltbld', 13:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:41 INFO - 'LOGNAME': 'cltbld', 13:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:41 INFO - 'MOZ_NO_REMOTE': '1', 13:24:41 INFO - 'NO_EM_RESTART': '1', 13:24:41 INFO - 'PAGER': '/bin/cat', 13:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:41 INFO - 'PWD': '/builds/slave/test', 13:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:41 INFO - 'SHELL': '/bin/bash', 13:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:41 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:41 INFO - 'USER': 'cltbld', 13:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:41 INFO - 'XPC_FLAGS': '0x0', 13:24:41 INFO - 'XPC_SERVICE_NAME': '0', 13:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:24:41 INFO - Cleaning up... 13:24:41 INFO - Return code: 0 13:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:41 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:41 INFO - 'HOME': '/Users/cltbld', 13:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:41 INFO - 'LOGNAME': 'cltbld', 13:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:41 INFO - 'MOZ_NO_REMOTE': '1', 13:24:41 INFO - 'NO_EM_RESTART': '1', 13:24:41 INFO - 'PAGER': '/bin/cat', 13:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:41 INFO - 'PWD': '/builds/slave/test', 13:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:41 INFO - 'SHELL': '/bin/bash', 13:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:41 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:41 INFO - 'USER': 'cltbld', 13:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:41 INFO - 'XPC_FLAGS': '0x0', 13:24:41 INFO - 'XPC_SERVICE_NAME': '0', 13:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:24:44 INFO - Downloading blobuploader-1.2.4.tar.gz 13:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:24:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24: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 13:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:24:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:24:45 INFO - Downloading docopt-0.6.1.tar.gz 13:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:24:45 INFO - Installing collected packages: blobuploader, requests, docopt 13:24:45 INFO - Running setup.py install for blobuploader 13:24:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:24:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:24:45 INFO - Running setup.py install for requests 13:24:46 INFO - Running setup.py install for docopt 13:24:46 INFO - Successfully installed blobuploader requests docopt 13:24:46 INFO - Cleaning up... 13:24:46 INFO - Return code: 0 13:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:46 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:46 INFO - 'HOME': '/Users/cltbld', 13:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:46 INFO - 'LOGNAME': 'cltbld', 13:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:46 INFO - 'MOZ_NO_REMOTE': '1', 13:24:46 INFO - 'NO_EM_RESTART': '1', 13:24:46 INFO - 'PAGER': '/bin/cat', 13:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:46 INFO - 'PWD': '/builds/slave/test', 13:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:46 INFO - 'SHELL': '/bin/bash', 13:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:46 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:46 INFO - 'USER': 'cltbld', 13:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:46 INFO - 'XPC_FLAGS': '0x0', 13:24:46 INFO - 'XPC_SERVICE_NAME': '0', 13:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:24:46 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qsBqbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:24:46 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cyqE1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lPGfgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-IUETTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6GWuVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-FlCPZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Y31s8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CMnOjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YVdaZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zq9hFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VudaXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:24:47 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BTwMB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:24:48 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-FHH9FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:24:48 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BhRGw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:24:48 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-unL1UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:24:48 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-0xyihi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:24:48 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Zg6J3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:24:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:24:48 INFO - Running setup.py install for manifestparser 13:24:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:24:48 INFO - Running setup.py install for mozcrash 13:24:48 INFO - Running setup.py install for mozdebug 13:24:49 INFO - Running setup.py install for mozdevice 13:24:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Running setup.py install for mozfile 13:24:49 INFO - Running setup.py install for mozhttpd 13:24:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Running setup.py install for mozinfo 13:24:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Running setup.py install for mozInstall 13:24:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:24:49 INFO - Running setup.py install for mozleak 13:24:49 INFO - Running setup.py install for mozlog 13:24:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:24:50 INFO - Running setup.py install for moznetwork 13:24:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:24:50 INFO - Running setup.py install for mozprocess 13:24:50 INFO - Running setup.py install for mozprofile 13:24:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:24:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:24:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:24:50 INFO - Running setup.py install for mozrunner 13:24:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:24:50 INFO - Running setup.py install for mozscreenshot 13:24:50 INFO - Running setup.py install for moztest 13:24:51 INFO - Running setup.py install for mozversion 13:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:24:51 INFO - Cleaning up... 13:24:51 INFO - Return code: 0 13:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:51 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:51 INFO - 'HOME': '/Users/cltbld', 13:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:51 INFO - 'LOGNAME': 'cltbld', 13:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:51 INFO - 'MOZ_NO_REMOTE': '1', 13:24:51 INFO - 'NO_EM_RESTART': '1', 13:24:51 INFO - 'PAGER': '/bin/cat', 13:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:51 INFO - 'PWD': '/builds/slave/test', 13:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:51 INFO - 'SHELL': '/bin/bash', 13:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:51 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:51 INFO - 'USER': 'cltbld', 13:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:51 INFO - 'XPC_FLAGS': '0x0', 13:24:51 INFO - 'XPC_SERVICE_NAME': '0', 13:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:24:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-WXVnXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:24:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ou99C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:24:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-f1na8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:24:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sFPK5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:24: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)) 13:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:24:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sYZ9LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lnw3Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-m_8PxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6IOF6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Z_db_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lVPaYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-y2IWub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-07vIhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-RKgCVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:24: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)) 13:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:24:52 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SLQcoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:24:53 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-h3TgEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:24:53 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-5GMP6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:24:53 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ITBDEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:24:56 INFO - Downloading blessings-1.6.tar.gz 13:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:24:56 INFO - Installing collected packages: blessings 13:24:56 INFO - Running setup.py install for blessings 13:24:56 INFO - Successfully installed blessings 13:24:56 INFO - Cleaning up... 13:24:56 INFO - Return code: 0 13:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:24:57 INFO - Reading from file tmpfile_stdout 13:24:57 INFO - Current package versions: 13:24:57 INFO - blessings == 1.6 13:24:57 INFO - blobuploader == 1.2.4 13:24:57 INFO - docopt == 0.6.1 13:24:57 INFO - functools32 == 3.2.3-2 13:24:57 INFO - jsonschema == 2.5.1 13:24:57 INFO - manifestparser == 1.1 13:24:57 INFO - mozInstall == 1.12 13:24:57 INFO - mozcrash == 1.0 13:24:57 INFO - mozdebug == 0.1 13:24:57 INFO - mozdevice == 0.48 13:24:57 INFO - mozfile == 1.2 13:24:57 INFO - mozhttpd == 0.7 13:24:57 INFO - mozinfo == 0.9 13:24:57 INFO - mozleak == 0.1 13:24:57 INFO - mozlog == 3.4 13:24:57 INFO - moznetwork == 0.27 13:24:57 INFO - mozprocess == 0.23 13:24:57 INFO - mozprofile == 0.28 13:24:57 INFO - mozrunner == 6.13 13:24:57 INFO - mozscreenshot == 0.1 13:24:57 INFO - mozsystemmonitor == 0.3 13:24:57 INFO - moztest == 0.8 13:24:57 INFO - mozversion == 1.4 13:24:57 INFO - psutil == 3.1.1 13:24:57 INFO - requests == 1.2.3 13:24:57 INFO - wsgiref == 0.1.2 13:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:57 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:57 INFO - 'HOME': '/Users/cltbld', 13:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:57 INFO - 'LOGNAME': 'cltbld', 13:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:57 INFO - 'MOZ_NO_REMOTE': '1', 13:24:57 INFO - 'NO_EM_RESTART': '1', 13:24:57 INFO - 'PAGER': '/bin/cat', 13:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:57 INFO - 'PWD': '/builds/slave/test', 13:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:57 INFO - 'SHELL': '/bin/bash', 13:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:57 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:57 INFO - 'USER': 'cltbld', 13:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:57 INFO - 'XPC_FLAGS': '0x0', 13:24:57 INFO - 'XPC_SERVICE_NAME': '0', 13:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:24:57 INFO - Cleaning up... 13:24:57 INFO - Return code: 0 13:24:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:24:57 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 0x10278b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102701570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0b0d8d0d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, '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.5I6bv8QBkq/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.q7PRmD56FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:24:57 INFO - 'HOME': '/Users/cltbld', 13:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:24:57 INFO - 'LOGNAME': 'cltbld', 13:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:24:57 INFO - 'MOZ_NO_REMOTE': '1', 13:24:57 INFO - 'NO_EM_RESTART': '1', 13:24:57 INFO - 'PAGER': '/bin/cat', 13:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:24:57 INFO - 'PWD': '/builds/slave/test', 13:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:24:57 INFO - 'SHELL': '/bin/bash', 13:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:24:57 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:24:57 INFO - 'USER': 'cltbld', 13:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:24:57 INFO - 'XPC_FLAGS': '0x0', 13:24:57 INFO - 'XPC_SERVICE_NAME': '0', 13:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:24:57 INFO - Cleaning up... 13:24:57 INFO - Return code: 0 13:24:57 INFO - Running post-action listener: _resource_record_post_action 13:24:57 INFO - Running post-action listener: _start_resource_monitoring 13:24:58 INFO - Starting resource monitoring. 13:24:58 INFO - [mozharness: 2017-02-06 21:24:58.025824Z] Finished create-virtualenv step (success) 13:24:58 INFO - [mozharness: 2017-02-06 21:24:58.026848Z] Running install step. 13:24:58 INFO - Running pre-action listener: _resource_record_pre_action 13:24:58 INFO - Running main action method: install 13:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:24:58 INFO - Reading from file tmpfile_stdout 13:24:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:24:58 INFO - Reading from file tmpfile_stdout 13:24:58 INFO - Output received: 13:24:58 INFO - Usage: mozinstall [options] installer 13:24:58 INFO - Options: 13:24:58 INFO - -h, --help show this help message and exit 13:24:58 INFO - -d DEST, --destination=DEST 13:24:58 INFO - Directory to install application into. [default: 13:24:58 INFO - "/builds/slave/test"] 13:24:58 INFO - --app=APP Application being installed. [default: firefox] 13:24:58 INFO - mkdir: /builds/slave/test/build/application 13:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:25:19 INFO - Reading from file tmpfile_stdout 13:25:19 INFO - Output received: 13:25:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:25:19 INFO - Running post-action listener: _resource_record_post_action 13:25:19 INFO - [mozharness: 2017-02-06 21:25:19.694761Z] Finished install step (success) 13:25:19 INFO - [mozharness: 2017-02-06 21:25:19.694889Z] Running run-tests step. 13:25:19 INFO - Running pre-action listener: _resource_record_pre_action 13:25:19 INFO - Running main action method: run_tests 13:25:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:25:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:25:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:25:19 INFO - 2017-02-06 13:25:19.709 screenresolution[1624:7370] starting screenresolution argv=screenresolution get 13:25:19 INFO - 2017-02-06 13:25:19.711 screenresolution[1624:7370] Display 0: 1600x1200x32@60 13:25:19 INFO - 2017-02-06 13:25:19.717 screenresolution[1625:7373] starting screenresolution argv=screenresolution list 13:25:19 INFO - Available Modes on Display 0 13:25:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:25:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:25:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:25:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:25:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:25:19 INFO - Intel Iris: 13:25:19 INFO - Chipset Model: Intel Iris 13:25:19 INFO - Type: GPU 13:25:19 INFO - Bus: Built-In 13:25:19 INFO - VRAM (Dynamic, Max): 1536 MB 13:25:19 INFO - Vendor: Intel (0x8086) 13:25:19 INFO - Device ID: 0x0a2e 13:25:19 INFO - Revision ID: 0x0009 13:25:19 INFO - Displays: 13:25:19 INFO - Display: 13:25:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:25:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:25:19 INFO - Display Serial Number: 1600x1200 60 13:25:19 INFO - Main Display: Yes 13:25:19 INFO - Mirror: Off 13:25:19 INFO - Online: Yes 13:25:19 INFO - Rotation: Supported 13:25:19 INFO - Return code: 0 13:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:25:19 INFO - Python 2.7.3 13:25:19 INFO - Return code: 0 13:25:19 INFO - grabbing minidump binary from tooltool 13:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:19 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 0x10259fd30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102597b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:25:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:25:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:25:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:25:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:25:20 INFO - Return code: 0 13:25:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:25:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:25:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:25:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:25:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:25:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5I6bv8QBkq/Render', 13:25:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:20 INFO - 'HOME': '/Users/cltbld', 13:25:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:20 INFO - 'LOGNAME': 'cltbld', 13:25:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:25:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:20 INFO - 'MOZ_NO_REMOTE': '1', 13:25:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:25:20 INFO - 'NO_EM_RESTART': '1', 13:25:20 INFO - 'PAGER': '/bin/cat', 13:25:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:20 INFO - 'PWD': '/builds/slave/test', 13:25:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:25:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:20 INFO - 'SHELL': '/bin/bash', 13:25:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q7PRmD56FL/Listeners', 13:25:20 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:25:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:20 INFO - 'USER': 'cltbld', 13:25:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:20 INFO - 'XPC_FLAGS': '0x0', 13:25:20 INFO - 'XPC_SERVICE_NAME': '0', 13:25:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:25:20 INFO - mozversion application_buildid: 20170206103455 13:25:20 INFO - mozversion application_changeset: dcdc85ecb2f31204d00686f88e8f452bf2526b65 13:25:20 INFO - mozversion application_display_name: Firefox 13:25:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:25:20 INFO - mozversion application_name: Firefox 13:25:20 INFO - mozversion application_remotingname: firefox 13:25:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:25:20 INFO - mozversion application_vendor: Mozilla 13:25:20 INFO - mozversion application_version: 52.0 13:25:20 INFO - mozversion platform_buildid: 20170206103455 13:25:20 INFO - mozversion platform_changeset: dcdc85ecb2f31204d00686f88e8f452bf2526b65 13:25:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:25:20 INFO - mozversion platform_version: 52.0 13:25:20 INFO - using testdate: 1486416320 13:25:20 INFO - actual date: 1486416320 13:25:20 INFO - starting webserver on 'localhost:49247' 13:25:20 INFO - SUITE-START | Running 2 tests 13:25:20 INFO - TEST-START | dromaeo_css 13:25:20 INFO - operating with platform_type : mac_ 13:25:20 INFO - Initialising browser for dromaeo_css test... 13:25:20 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpkLIP3w/profile http://localhost:49247/getInfo.html) 13:25:23 INFO - PROCESS | 1635 | 2017-02-06 13:25:23.132 plugin-container[1638:7558] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a43, name = 'com.apple.tsm.portname' 13:25:23 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:25:23 INFO - PROCESS | 1635 | 2017-02-06 13:25:23.132 plugin-container[1638:7558] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 13:25:23 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:25:23 INFO - PROCESS | 1635 | 2017-02-06 13:25:23.132 plugin-container[1638:7558] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:25:23 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 13:25:23 INFO - PROCESS | 1635 | colorDepth:24 13:25:23 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 13:25:23 INFO - PROCESS | 1635 | __metrics 13:25:23 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:25:23 INFO - TEST-INFO | 1635: exit 0 13:25:23 INFO - Browser initialized. 13:25:23 INFO - Running cycle 1/1 for dromaeo_css test... 13:25:23 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpkLIP3w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:25:26 INFO - PROCESS | 1639 | 2017-02-06 13:25:26.351 plugin-container[1640:7686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 13:25:26 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:25:26 INFO - PROCESS | 1639 | 2017-02-06 13:25:26.351 plugin-container[1640:7686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 13:25:26 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:25:26 INFO - PROCESS | 1639 | 2017-02-06 13:25:26.351 plugin-container[1640:7686] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:25:36 INFO - PROCESS | 1639 | RSS: Main: 177352704 13:25:36 INFO - PROCESS | 1639 | 13:28:38 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 13:28:39 INFO - PROCESS | 1639 | RSS: Main: 183115776 13:28:39 INFO - PROCESS | 1639 | 13:31:41 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 13:31:42 INFO - PROCESS | 1639 | RSS: Main: 193519616 13:31:42 INFO - PROCESS | 1639 | 13:34:44 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 13:34:45 INFO - PROCESS | 1639 | RSS: Main: 195256320 13:34:45 INFO - PROCESS | 1639 | 13:37:47 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 13:37:47 INFO - PROCESS | 1639 | RSS: Main: 198369280 13:37:47 INFO - PROCESS | 1639 | 13:40:50 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 13:40:51 INFO - PROCESS | 1639 | RSS: Main: 200949760 13:40:51 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 13:43:53 INFO - PROCESS | 1639 | RSS: Main: 201768960 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | __start_tp_report 13:43:53 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 13:43:53 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 13:43:53 INFO - PROCESS | 1639 | |i|pagename|runs| 13:43:53 INFO - PROCESS | 1639 | |0;dojo.html;3033.2113650450874;3616.5479315085613;3628.8911332660014;3654.2691461707664;3666.3767159582867;5940.76236950522;5967.761289548418;5967.955607768645;5970.850728731784;5979.701014949246;4704.600108990731;5572.721363931797;5928.614640048394;5949.940500594993;6036.064410016444;4670.462896766881;5327.760250788714;5381.81163659272;5421.457854214566;5421.891562168754;5408.513233808956;5434.864128396802;5447.428020057877;5449.964506743726;5491.313585801775;5308.9469105308835;5323.121684922003;5421.620486565942;5430.755615997289;5434.0218760623075;5351.170568561879;5382.515573598375;5400.108982017962;5443.836684899459;5485.807996720136;5292.576593872481;5374.27447294618;5397.460253974571;5401.756920938567;5409.972950135263;6039.788607398764;6069.514438844882;6092;6147.016477363645;6150.630962142286;6177.444030037318;6188.1027251048345;6190.102435146923;6252.6561039142825;6283.528735344822;6324.146240257553;6325.652089135096;6329.68351582419;6338.271098823602;6341.619502829799;6058.121572372025;6087.05650624154;6091.329953705089;6098.054801505774;6110.08348747687;6192.256929168529;6292.8426789329715;6318.778842740482;6333.398327158912;6413.422791948747;6219.533534984895;6279.246490421087;6291.937080629226;6304.148939893055;6305.8108256752375;6323.52573556985;6346.555741098171;6353;6356.682165891687;6357.650329231937;6190.876182476325;6194.256689197326;6207.968960155261;6269.216347956505;6279.277883043417;6188.907166392508;6190.721417536221;6247.375262473716;6254.593451425642;6264.843378915472;5084.618653600995;5094.057599344059;5101.69389836611;5112.207607820794;5113.565346945476;3703.5926048134684;4470.284754439339;4607.58531732139;4608.539146085364;4636.79134438951;4809.927851082237;4988.6009119270375;6042.879142417215;6061.363556826558;6078.513718902477;5248.370195576479;5313.946860531422;6326.68366581669;6347.809565713036;6352.4918006559365;5960.642361458326;6028.9397106029255;6051.818445446644;6054.273487181478;6138.324784273726;5563.36021357541;5579.721013949286;5579.7489112990015;5598.1322894951345;5611.298587676541;6442.130312407765;6489.253735820346;6501.9674901625185;6522.836929076811;6528.608283503005;6180.721867515883;6191.690415479118;6243.001119820807;6313.305536390902;6326.367363263636;5493.505584497414;6362.3319551448285;6434.581752186093;6506.089147519257;6513.5114866384265;6250.437460628384;6258.374162583706;6265.655388953469;6286.245650521967;6290.339514350927;6084.209052823105;6240.687965601611;6244.875102498016;6305.495560355253;6326.778562750465;6168.784092556739;6188.845278868064;6201.976673848764;6263.592866463665;6270;6220.0047992321015;6240.937590624036;6241.21984751906;6241.531885108726;6274.435300822948;6028.336882942785;6099.66451845135;6147.938520614736;6212.596181248205;6257.56197066201;6149.893019256577;6181.81454556364;6190.535709821871;6232.18981532416;6278.905816412849;6134.11055396956;6191.597546159485;6198.101275315144;6220.440160385587;6255.624662520263 13:43:53 INFO - PROCESS | 1639 | |1;ext.html;465.02113052025487;489.46892621505674;528.5401700520547;534.4601952028451;541.3909351979023;38053.04867378314;39643;39659;39730.60269397309;39931.00172495682;41431.585684143225;41535.792321038425;41889.16221675565;41947.79026104873;42281.36577951333;9618.278629102793;9755.02449755026;9764.609415623367;9842.311038227326;9857.753556161082;9650.951745241264;9751.561179746928;9754.707358779247;9771.853422198637;9786.755331116743;9712.66005689801;9766.414015159078;9798.804023919518;9808.970058143863;9820.656277030306;9605.615775368977;9702.708918732415;9775.462349570771;9778.266630002778;9788.972157923423;9720.90279097207;9730.318877678565;9743.610255589769;9794.755131121708;9815.950920245425;39359;39569.010774730865;39704;39727.60272397268;39735.40396894049;3152.5428812822242;3229.564008858821;3231.353729254135;3459.6713312235297;3493.109257139439;29969.550456743167;30140.24649383783;30159.698403015907;30763.76944922223;31019.53470697941;3249.772515923886;3301.158204657821;3314.005798260512;3315.303786204876;3350.597928248626;396250;396744;399376;400389;401501;57101.71449142811;57506.7124664374;57516;57604.42395575991;57608.42391576031;55435.445645543026;55648.44351556433;55678.443215568135;55684.16473752897;55917;14479.78280325796;15556;15632.296546655427;15667.216639167997;15695.29371178277;12025.098117641212;12063.336516491501;12148.392580370946;12151.513939442324;12170.634880953585;14846.18345990981;14981.176035317943;15162.469313574193;15187.544373668808;15329.540113796604;3241.756868234892;5248.6325957182635;6281.434670879643;6317.4946004319545;6322.6489960321105;869.7173418638841;889.5374405309333;999.7600575861741;1006.33079002464;1023.81059503992;28995.42009159805;29912.55131173034;30019.849900750793;30499;30548;1053.3363980692268;1053.4258828938248;1077.719792853848;1089.9128069754402;1230.4585982167816;9915.553800079013;16072.517824465285;16342.346306147621;16366.83633163653;16496.92769969948;567312;674650;682905;683179;684834;56752.71623641938;57162.57093572694;57164.14253786197;57422;57548;1370.1915869636962;1371.6502291915697;1389.979150312746;1414.679924923127;1417.1992824054375;29346.559801602565;29816.10551683453;30232.546511801902;30302.696973029986;30625;47405.52594474011;47817.76091119522;47968.80077998078;47998.28002580034;48124.518754813405;573530;576770;577545;580509;580904;22411.663825042313;26396.340091497867;26539.80570874354;26600.8669956649;26842.06052788221;43795.12409751723;43877.90305242394;44382.77808611065;44492.11015779731;44590.77704611586;36451.359688813536;36720.63279367172;36752.713655021944;37093.6290637101;37913.4312985311;36844.26311473809;36982;37080.62919370772;37709.622903770614;37854;35446.759363422156;35825.64174358223;36186.914392568266;36343.27313453769;36548.63451365452;31670;33439.49840752439;33489.49765753564;33588.66411335855;33718.831405842815;24632;25041.624375634015;25051;25109.32276835459;25286.24141275765 13:43:53 INFO - PROCESS | 1639 | |2;jquery.html;363.58006502489627;386.45316876619586;397.43564138922727;398.3665971105941;417.7827529684564;14824.55526334209;18879;19724.112414941326;20354.08406621702;20445.284415045477;14838.851611483882;19849.503762405948;20005.399838004883;20473;20498.385048448534;5847.298324201101;5858.648481091138;6012.759489620432;6098.542609304298;6112.327643959161;5895.410458954113;6010.398960103998;6053.424924632153;6055.818325450244;6082.330943596201;5954.4938680212235;6029.306629737593;6044.425779550936;6051.697415129248;6056.727447264883;5173.9741301293625;5470.550304169398;5685.033544297458;6009;6049.879002419971;5210.088234558937;5223.921641175385;5260.342457192851;5299.5760339172775;5314.282571852789;24686.876565617236;24944.376390590198;25422.491550168892;25562.488750224893;25981.870090649427;2315.6063469210108;2395.006072479936;2585.9870700646375;2850.1734496995846;3022.9848850755825;11806.88193118075;12540.184887982252;13498.932505337509;15250.161241131733;15766.132862692548;1605.727026405514;1864.6643604151247;1867.365095867398;1870.2705944681586;1898.411492437335;114928;116921;118199.40900295529;123479;125802.37098814538;10535;11030.393328367018;11921.046316294676;11930.940345298219;11941.582044628396;11986.400679965967;12683.175593586388;14999.625009374853;15209.695806083817;15216.239188040554;6367.554271201064;8105.392095592736;8193.262606365455;8220.876686849702;8235.917640823634;8392.79018024542;8406.957965210135;8419.326453883674;8519.701810436605;8557.315414766803;3984.960150398517;3992.121733218687;4025.4565633639086;4050.3721923101966;4085.9795701021303;1684.4188754879792;1924.7786504551875;1955.3840540229783;1972.7435433393566;1980.2870517002978;875.991240087591;906.1708536688988;939.7697564096703;975.1467465967279;989.5596459575564;20673.069711863;21015.78984210169;21214.15143394247;21230.893845530674;21326.253581124587;838.9664413423395;942.7548837302351;955.0974329258922;960.1550635440907;1002.3785253143097;10597.25819192649;11176.60881869147;11206.21556491054;11209.495572699248;11213.439328033566;421379;471393.2860671418;591310;619195;642639;117712.64574708458;118997;122207;125304.37347813202;130456;955.8996305387973;980.0542476510202;982.29274922056;997.7705127820497;1003.0571263012745;18327.816721833144;18515.907420462812;18689.813101869353;18767.530811729815;18847.434576962714;42737;52394;53533;53761.655958601346;56285.718571406884;79440.20559794328;81612.77580836411;81827;81946.03718321142;82028.17971820205;7769.184235655175;7847.568383738949;8041.276285134366;8167.83664326722;8209.384296177692;9328.347015708836;11646.417679116179;11805.468753906267;12026.639200823989;12069.75860482803;10283.537240824031;10300.381977081399;10379.792404152025;10510.527026283682;10603.41681207541;8662.91337086621;10050.19598432109;10275;10380.013898679614;10513.9474302628;10496.527656255334;10592.675915510561;10699.679009629723;10706.089982351587;11003.119750419786;7885.233541013596;7978.481398709066;7988.680452781824;8280.378971577034;8281.171882811912;10254.974502549983;10268.64059757905;10474.371537707762;10491.790164196826;10565.683029509128 13:43:53 INFO - PROCESS | 1639 | |3;mootools.html;1497.3262032085565;1539.191924239774;1767.1429356761969;1797.1912639312313;1931.2854243929748;7778.105517865447;8023.759287221378;8310.210529999647;8774.561271936394;8794.780130496742;8281.089080201173;8533.445326053803;8558.957205213965;8638.09300023498;8641.91358086419;2356.281334193066;2404.2907342333965;2406.0736616402637;2408.915687950922;2411.168146989286;2368.4789346343778;2434.257551446808;2434.817388695855;2441.4872876695913;2442.1696623148127;2374.3470545599926;2377.0967032527615;2394.4133687246563;2400.927972160838;2409.7349291578;2343.5078633486987;2370.9881450592725;2387.55830171418;2391.629297458897;2407.1334319645002;2403.795677367426;2406.975930240693;2420.8426452280546;2430.829841911067;2436.549238390903;8581.313494920392;8652.04827468978;8711.912880871174;8717.825643487158;8718.564071796385;5247.816326428595;5372.328458942632;5417.052015897241;5422.674639521641;5424.1321388577635;3506.9649303506894;3547.5388199534154;3576.588692300367;3601.567811862567;3615.8192090395637;1045.9110975567087;1066.2376400873336;1097.8956999085153;1109.4175557832123;1112.0991996482874;11340.546378144863;11400.429978501043;11410.657680269605;11422.657320280405;11472.369019703912;4610.907781844345;4733.810647574127;4814.759262036884;4817.98822247325;4886.096072226649;9822.901770982342;9840.704778856645;9842.606295748234;9861.112499874902;9873.40759554429;5315.176147697036;5392.838214853561;5395.568354531628;5400.729963501809;5407.594430417735;4443.0669559392245;4498.752568608693;4897.926531102036;4939.580135688435;4940.604751619861;3974.2448934702315;4008.398740188995;4059.6143366380147;4111.465509483748;4129.380592911028;1124.9325040497597;1313.2448841915746;1325.15190278222;1330.3614265152587;1331.8534961154264;791.6318911705969;804.818915743953;836.6277006731946;917.1653795046476;939.769756409684;4805.3512775775525;5522.779088836482;5685.914711279334;5811.186433899257;5841.503472204825;885.8892638420198;940.4357385568741;954.1031430455349;966.7728083900278;971.5773638467148;3693.1874987502706;3913.7064720146104;4020.9195816083516;4090.4682391288943;4094.529129150126;10347.27569070158;10365;10550.419726914939;10558.841617375745;10561.260711750258;10061.949690251502;10479.895201047892;10502.789944201073;10546.472676366151;10549.156067514581;7994.920050799417;8196.54918979462;8224.136465671138;8225.917740822635;8241.217084376975;5605.635633683797;5729.713514324184;5775.768969241183;5781.4218578141845;6141.877162456815;9482.336236463381;9487.383320084173;9537.23702103844;9694.5152742364;9779.022097790164;8075.353971682134;9497.477638729937;9818.65634702782;9854.359466634645;9951.601935922772;6847.726090956306;7047.154341479055;7109.964450177923;7360;7519.774406767806;8115;8298.668053277801;8361.95819020901;8367.539785311867;8383.664653413794;7327.0841144856895;7370.189279179179;7371.447141464304;7405.925940740523;7605.847883042197;7321.926780732125;7363.858601916711;7384.9261507384235;7413.147488038944;7421.517601355895;6890.896636550356;6971.128608923885;6983.441324694114;7021.789346319414;7023.929760702532;4199.286121359437;4771.761411929459;4811.711297322172;4830.975845120752;4872.074305882013;4755.571998520011;4820.204666230033;4877.463479017376;4887.975560122177;4890.926636100533 13:43:53 INFO - PROCESS | 1639 | |4;prototype.html;274.1009488876485;311.6836411042792;317.90145055032934;321.1489552685385;322.9874343931773;4160.895977600561;4463.464384273888;4519.796609152588;5475.370332411764;5494.417623716851;5512.228288039678;5536;5571.300753270251;5588.385277619469;5590.301212348457;3879.5926427725108;4090.9954122480067;4248.065425606369;4259.510156332015;4260;3905.3638793814202;4131.8967025824295;4242.809073591696;4265.909704244913;4268.445102136718;3534.6642069003406;4066.471358723362;4103.8563650272245;4116.423700681907;4127.793610319487;3318.6061854021127;4061.8578349757618;4107.979460102695;4134.255833949888;4141.937870931938;3590.438159400669;3605.152789094561;3613.1509095362567;3618.6924111450558;3625.23869987303;4151.294279972412;4438.958079283533;5357.973210133963;5360.60624237701;5378.838634840961;4778.116048531033;4796.928046079312;4799.400074990626;4813.302071199656;4827.372441582607;4775.355327030841;5053.317802096743;5460.481254280837;5598.524125449342;5849.181114643953;3809.466674665549;3951.644352008333;3972.82122304497;3993.800309984489;3998.800059997018;6046.213992181032;6083.813656337016;6144.3717414885095;6191.814245572595;6205.6897155142515;3676.522052133259;4061.268971585143;4066.6949978751713;4073.572274911151;4079.91840163201;3459.619441861393;3893.9610603894166;4077.103037331782;4083.8570650027104;4099.85650502231;3986.80065996699;4523.303761089592;4708.717476951394;4781.856544303677;4788.233882578771;5859.53123750099;5865.501432378295;5876.44173803488;5880.176775251468;5884.941150588525;1233.3155098920186;1263.8420197475316;1315.7697402954636;1324.7414955791844;1335.4925128451127;772.5519198864645;875.7022612311845;893.8882639670041;906.7959709065408;908.6365453818394;4644.170063134303;5031.496850314939;5287.920681189786;5294.7352632369;5308.548773354308;4826.61387089032;4841.709497430165;5639.802606908738;5709.660657899943;5729.7340515905535;4758.857234282977;5020.548150666457;5169.327987361619;5275.470113666994;5292;2544.536891287517;2826.5160790585105;2826.844523551183;2889.508783506809;2910.2142421546064;5879.706014699248;5921.585489015728;5940.6435613863305;5961.612495187799;6024.969875150597;4926.827561035347;5153.665011774223;5163.896722065613;5784.946344047887;5841.357450680422;5315.501714194323;5588.640860129106;5886.764529418775;5917.674527900921;5974.970125149346;4921.778519966539;5338.119210330252;5691.914621280767;5731.054376028075;5817;4540.341650460598;4962.652614316963;5625.46558076982;5630.49442997862;5644.9435505644415;5001.698878740014;5446.863828404322;5608.355039170548;5973.701314934323;6010.3088144863905;3318.4026875162704;3320.684534969174;3729.869454569077;3875.224955008953;3877.6122387760997;5229.947700522946;5906.7341969612335;5989.880202396015;6025;6035.849103772441;4876.146674332049;5940.227770389822;5942.702864856827;5951.28584569837;5993;5322.828977624917;5385.488378604026;5901.3213480450295;5946.583739138218;5983.282006159288;4543.454785425638;4621.237495813153;5308.628396012242;5720.74256658443;5806.371018113679;5381.811636592701;5891.203183029217;5914.319853216935;5917.674527900835;5917.822465326047;4783.234682450791;5444.930926248;5690.857728556819;5711.942880571141;5849.795257165979 13:43:53 INFO - PROCESS | 1639 | |5;yui.html;707.4658632732287;719.9244079371666;762.0931092000519;811.2941740685598;833.604038081911;13024.153430027041;14635.853641463582;14945.25273736313;15403.152826594533;15409.69180616387;13059.673508162301;13948.02363834532;14050;14062.789058164135;14111.012229143938;841.5623875584693;847.7033038436529;862.1163307609719;864.1315477944656;867.4274978514181;867.6963062927988;867.7093173786789;873.7990262239657;875.5359659380539;876.4609764994547;863.2532859076916;910.3854897943894;910.8679241509977;911.2527727263647;911.3028533172129;863.1282404771194;895.38218629146;895.5925054100434;900.5362238447204;902.6615019367737;650.3756393861898;650.7006776882592;661.3023260460212;671.2817285504512;673.9789219332715;12353.444095015746;12382.504699811996;12714.23714577119;12850.807237891438;12861;12019.939900300442;12076.21504602207;12174.939125304405;12196.14626976112;12247;10838.891611083945;10858.511366988505;10870.130389568816;10996.670099896935;11103.777924441465;3667.4132138857653;3716.349638813224;3717.3866312058476;3720.6465385788306;3726.1988672435555;90355.54822225847;92566.53716731441;92586;92920;94435.52782236045;7400;9079.863802042975;9098.909010909807;9116.726498205064;9225.630974760934;18808.81191188098;18875.716864247046;18883;18969.43091707251;19035.04824758784;7797.727079552188;7813.960930195312;7878.212178782076;7930.920690793018;8044.597770111471;4371.978140109342;4426.601605855489;4481.282994720829;4526.615237704832;4544.590986811203;3370.612379576331;3438.896833095011;3579.731520136;3705.981470092632;3880.7865567394065;703.9824004399931;713.5076797010047;716.3123401534585;721.9494635375473;732.0885497555578;634.8000379880323;654.2345455816705;655.8098151536096;661.3485716569176;675.1054852320694;9081.091890810865;9088.545572721338;9554.426734395958;9618.230541556659;9695.272854535939;447.7089891570505;462.41273582549974;524.5646113725599;562.6314763829698;579.44373401535;3645.7630254033934;4512.706674066175;4669.229577119805;4741.431028276629;4742.288656701522;104135;107499.46250268699;107554.46222768836;113651.86348136413;115048.42475787568;35053.29893402118;70528.2947170532;77988;92116;100765.49617251867;85997.57001214953;89077;89973.10026899647;91497;93146.60280095803;9452.952735236555;9904.306698531034;9976.650817221362;10112.898871011195;10151.7462063449;45580;53976.46023539714;54936.175957359876;55944.72027639836;56130.719346403006;75893.62053189699;77455;79647;80582.3883522338;83177.58411207906;12343.19769214998;12667.93666031664;12741.683978737172;12859.742805144031;12961.611151665466;13827.308634568433;14186.077904936146;14391.208483533506;14417.423303068179;14609.634759131106;12746.171498852545;12824.679383015125;13711.314434278047;14252.002359834712;14267.64330891736;12619.810702839648;13465.124766890121;13495;13513.864861351261;13610.455581777014;11981.520739170335;12806.935965320487;13074.150180238254;13235.32327458029;13453;8639.395242332976;10900.182486313717;11260.493277802354;11391.715207119556;11408.657740267805;11265.605703800327;11449.313041217554;11574.768504630028;11631.709207269885;11651.533938642699 13:43:53 INFO - PROCESS | 1639 | __end_tp_report 13:43:53 INFO - PROCESS | 1639 | __start_cc_report 13:43:53 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,364 13:43:53 INFO - PROCESS | 1639 | __end_cc_report 13:43:53 INFO - PROCESS | 1639 | __startTimestamp1486417433627__endTimestamp 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | ------- Summary: start ------- 13:43:53 INFO - PROCESS | 1639 | Number of tests: 6 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5857.98 Median:6149.89 stddev:651.23 (10.6%) stddev-sans-first:614.37 13:43:53 INFO - PROCESS | 1639 | Values: 3033.2 3616.5 3628.9 3654.3 3666.4 5940.8 5967.8 5968.0 5970.9 5979.7 4704.6 5572.7 5928.6 5949.9 6036.1 4670.5 5327.8 5381.8 5421.5 5421.9 5408.5 5434.9 5447.4 5450.0 5491.3 5308.9 5323.1 5421.6 5430.8 5434.0 5351.2 5382.5 5400.1 5443.8 5485.8 5292.6 5374.3 5397.5 5401.8 5410.0 6039.8 6069.5 6092.0 6147.0 6150.6 6177.4 6188.1 6190.1 6252.7 6283.5 6324.1 6325.7 6329.7 6338.3 6341.6 6058.1 6087.1 6091.3 6098.1 6110.1 6192.3 6292.8 6318.8 6333.4 6413.4 6219.5 6279.2 6291.9 6304.1 6305.8 6323.5 6346.6 6353.0 6356.7 6357.7 6190.9 6194.3 6208.0 6269.2 6279.3 6188.9 6190.7 6247.4 6254.6 6264.8 5084.6 5094.1 5101.7 5112.2 5113.6 3703.6 4470.3 4607.6 4608.5 4636.8 4809.9 4988.6 6042.9 6061.4 6078.5 5248.4 5313.9 6326.7 6347.8 6352.5 5960.6 6028.9 6051.8 6054.3 6138.3 5563.4 5579.7 5579.7 5598.1 5611.3 6442.1 6489.3 6502.0 6522.8 6528.6 6180.7 6191.7 6243.0 6313.3 6326.4 5493.5 6362.3 6434.6 6506.1 6513.5 6250.4 6258.4 6265.7 6286.2 6290.3 6084.2 6240.7 6244.9 6305.5 6326.8 6168.8 6188.8 6202.0 6263.6 6270.0 6220.0 6240.9 6241.2 6241.5 6274.4 6028.3 6099.7 6147.9 6212.6 6257.6 6149.9 6181.8 6190.5 6232.2 6278.9 6134.1 6191.6 6198.1 6220.4 6255.6 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:67384.75 Median:217946.50 stddev:148992.41 (68.4%) stddev-sans-first:149325.66 13:43:53 INFO - PROCESS | 1639 | Values: 465.0 489.5 528.5 534.5 541.4 38053.0 39643.0 39659.0 39730.6 39931.0 41431.6 41535.8 41889.2 41947.8 42281.4 9618.3 9755.0 9764.6 9842.3 9857.8 9651.0 9751.6 9754.7 9771.9 9786.8 9712.7 9766.4 9798.8 9809.0 9820.7 9605.6 9702.7 9775.5 9778.3 9789.0 9720.9 9730.3 9743.6 9794.8 9816.0 39359.0 39569.0 39704.0 39727.6 39735.4 3152.5 3229.6 3231.4 3459.7 3493.1 29969.6 30140.2 30159.7 30763.8 31019.5 3249.8 3301.2 3314.0 3315.3 3350.6 396250.0 396744.0 399376.0 400389.0 401501.0 57101.7 57506.7 57516.0 57604.4 57608.4 55435.4 55648.4 55678.4 55684.2 55917.0 14479.8 15556.0 15632.3 15667.2 15695.3 12025.1 12063.3 12148.4 12151.5 12170.6 14846.2 14981.2 15162.5 15187.5 15329.5 3241.8 5248.6 6281.4 6317.5 6322.6 869.7 889.5 999.8 1006.3 1023.8 28995.4 29912.6 30019.8 30499.0 30548.0 1053.3 1053.4 1077.7 1089.9 1230.5 9915.6 16072.5 16342.3 16366.8 16496.9 567312.0 674650.0 682905.0 683179.0 684834.0 56752.7 57162.6 57164.1 57422.0 57548.0 1370.2 1371.7 1390.0 1414.7 1417.2 29346.6 29816.1 30232.5 30302.7 30625.0 47405.5 47817.8 47968.8 47998.3 48124.5 573530.0 576770.0 577545.0 580509.0 580904.0 22411.7 26396.3 26539.8 26600.9 26842.1 43795.1 43877.9 44382.8 44492.1 44590.8 36451.4 36720.6 36752.7 37093.6 37913.4 36844.3 36982.0 37080.6 37709.6 37854.0 35446.8 35825.6 36186.9 36343.3 36548.6 31670.0 33439.5 33489.5 33588.7 33718.8 24632.0 25041.6 25051.0 25109.3 25286.2 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:33509.04 Median:14074.24 stddev:93266.87 (662.7%) stddev-sans-first:93495.31 13:43:53 INFO - PROCESS | 1639 | Values: 363.6 386.5 397.4 398.4 417.8 14824.6 18879.0 19724.1 20354.1 20445.3 14838.9 19849.5 20005.4 20473.0 20498.4 5847.3 5858.6 6012.8 6098.5 6112.3 5895.4 6010.4 6053.4 6055.8 6082.3 5954.5 6029.3 6044.4 6051.7 6056.7 5174.0 5470.6 5685.0 6009.0 6049.9 5210.1 5223.9 5260.3 5299.6 5314.3 24686.9 24944.4 25422.5 25562.5 25981.9 2315.6 2395.0 2586.0 2850.2 3023.0 11806.9 12540.2 13498.9 15250.2 15766.1 1605.7 1864.7 1867.4 1870.3 1898.4 114928.0 116921.0 118199.4 123479.0 125802.4 10535.0 11030.4 11921.0 11930.9 11941.6 11986.4 12683.2 14999.6 15209.7 15216.2 6367.6 8105.4 8193.3 8220.9 8235.9 8392.8 8407.0 8419.3 8519.7 8557.3 3985.0 3992.1 4025.5 4050.4 4086.0 1684.4 1924.8 1955.4 1972.7 1980.3 876.0 906.2 939.8 975.1 989.6 20673.1 21015.8 21214.2 21230.9 21326.3 839.0 942.8 955.1 960.2 1002.4 10597.3 11176.6 11206.2 11209.5 11213.4 421379.0 471393.3 591310.0 619195.0 642639.0 117712.6 118997.0 122207.0 125304.4 130456.0 955.9 980.1 982.3 997.8 1003.1 18327.8 18515.9 18689.8 18767.5 18847.4 42737.0 52394.0 53533.0 53761.7 56285.7 79440.2 81612.8 81827.0 81946.0 82028.2 7769.2 7847.6 8041.3 8167.8 8209.4 9328.3 11646.4 11805.5 12026.6 12069.8 10283.5 10300.4 10379.8 10510.5 10603.4 8662.9 10050.2 10275.0 10380.0 10513.9 10496.5 10592.7 10699.7 10706.1 11003.1 7885.2 7978.5 7988.7 8280.4 8281.2 10255.0 10268.6 10474.4 10491.8 10565.7 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5633.79 Median:5094.21 stddev:3093.84 (60.7%) stddev-sans-first:3086.90 13:43:53 INFO - PROCESS | 1639 | Values: 1497.3 1539.2 1767.1 1797.2 1931.3 7778.1 8023.8 8310.2 8774.6 8794.8 8281.1 8533.4 8559.0 8638.1 8641.9 2356.3 2404.3 2406.1 2408.9 2411.2 2368.5 2434.3 2434.8 2441.5 2442.2 2374.3 2377.1 2394.4 2400.9 2409.7 2343.5 2371.0 2387.6 2391.6 2407.1 2403.8 2407.0 2420.8 2430.8 2436.5 8581.3 8652.0 8711.9 8717.8 8718.6 5247.8 5372.3 5417.1 5422.7 5424.1 3507.0 3547.5 3576.6 3601.6 3615.8 1045.9 1066.2 1097.9 1109.4 1112.1 11340.5 11400.4 11410.7 11422.7 11472.4 4610.9 4733.8 4814.8 4818.0 4886.1 9822.9 9840.7 9842.6 9861.1 9873.4 5315.2 5392.8 5395.6 5400.7 5407.6 4443.1 4498.8 4897.9 4939.6 4940.6 3974.2 4008.4 4059.6 4111.5 4129.4 1124.9 1313.2 1325.2 1330.4 1331.9 791.6 804.8 836.6 917.2 939.8 4805.4 5522.8 5685.9 5811.2 5841.5 885.9 940.4 954.1 966.8 971.6 3693.2 3913.7 4020.9 4090.5 4094.5 10347.3 10365.0 10550.4 10558.8 10561.3 10061.9 10479.9 10502.8 10546.5 10549.2 7994.9 8196.5 8224.1 8225.9 8241.2 5605.6 5729.7 5775.8 5781.4 6141.9 9482.3 9487.4 9537.2 9694.5 9779.0 8075.4 9497.5 9818.7 9854.4 9951.6 6847.7 7047.2 7110.0 7360.0 7519.8 8115.0 8298.7 8362.0 8367.5 8383.7 7327.1 7370.2 7371.4 7405.9 7605.8 7321.9 7363.9 7384.9 7413.1 7421.5 6890.9 6971.1 6983.4 7021.8 7023.9 4199.3 4771.8 4811.7 4831.0 4872.1 4755.6 4820.2 4877.5 4888.0 4890.9 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4596.04 Median:5042.41 stddev:1430.29 (28.4%) stddev-sans-first:1397.03 13:43:53 INFO - PROCESS | 1639 | Values: 274.1 311.7 317.9 321.1 323.0 4160.9 4463.5 4519.8 5475.4 5494.4 5512.2 5536.0 5571.3 5588.4 5590.3 3879.6 4091.0 4248.1 4259.5 4260.0 3905.4 4131.9 4242.8 4265.9 4268.4 3534.7 4066.5 4103.9 4116.4 4127.8 3318.6 4061.9 4108.0 4134.3 4141.9 3590.4 3605.2 3613.2 3618.7 3625.2 4151.3 4439.0 5358.0 5360.6 5378.8 4778.1 4796.9 4799.4 4813.3 4827.4 4775.4 5053.3 5460.5 5598.5 5849.2 3809.5 3951.6 3972.8 3993.8 3998.8 6046.2 6083.8 6144.4 6191.8 6205.7 3676.5 4061.3 4066.7 4073.6 4079.9 3459.6 3894.0 4077.1 4083.9 4099.9 3986.8 4523.3 4708.7 4781.9 4788.2 5859.5 5865.5 5876.4 5880.2 5884.9 1233.3 1263.8 1315.8 1324.7 1335.5 772.6 875.7 893.9 906.8 908.6 4644.2 5031.5 5287.9 5294.7 5308.5 4826.6 4841.7 5639.8 5709.7 5729.7 4758.9 5020.5 5169.3 5275.5 5292.0 2544.5 2826.5 2826.8 2889.5 2910.2 5879.7 5921.6 5940.6 5961.6 6025.0 4926.8 5153.7 5163.9 5784.9 5841.4 5315.5 5588.6 5886.8 5917.7 5975.0 4921.8 5338.1 5691.9 5731.1 5817.0 4540.3 4962.7 5625.5 5630.5 5644.9 5001.7 5446.9 5608.4 5973.7 6010.3 3318.4 3320.7 3729.9 3875.2 3877.6 5229.9 5906.7 5989.9 6025.0 6035.8 4876.1 5940.2 5942.7 5951.3 5993.0 5322.8 5385.5 5901.3 5946.6 5983.3 4543.5 4621.2 5308.6 5720.7 5806.4 5381.8 5891.2 5914.3 5917.7 5917.8 4783.2 5444.9 5690.9 5711.9 5849.8 13:43:53 INFO - PROCESS | 1639 | 13:43:53 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20314.59 Median:25062.30 stddev:29857.71 (119.1%) stddev-sans-first:29905.18 13:43:53 INFO - PROCESS | 1639 | Values: 707.5 719.9 762.1 811.3 833.6 13024.2 14635.9 14945.3 15403.2 15409.7 13059.7 13948.0 14050.0 14062.8 14111.0 841.6 847.7 862.1 864.1 867.4 867.7 867.7 873.8 875.5 876.5 863.3 910.4 910.9 911.3 911.3 863.1 895.4 895.6 900.5 902.7 650.4 650.7 661.3 671.3 674.0 12353.4 12382.5 12714.2 12850.8 12861.0 12019.9 12076.2 12174.9 12196.1 12247.0 10838.9 10858.5 10870.1 10996.7 11103.8 3667.4 3716.3 3717.4 3720.6 3726.2 90355.5 92566.5 92586.0 92920.0 94435.5 7400.0 9079.9 9098.9 9116.7 9225.6 18808.8 18875.7 18883.0 18969.4 19035.0 7797.7 7814.0 7878.2 7930.9 8044.6 4372.0 4426.6 4481.3 4526.6 4544.6 3370.6 3438.9 3579.7 3706.0 3880.8 704.0 713.5 716.3 721.9 732.1 634.8 654.2 655.8 661.3 675.1 9081.1 9088.5 9554.4 9618.2 9695.3 447.7 462.4 524.6 562.6 579.4 3645.8 4512.7 4669.2 4741.4 4742.3 104135.0 107499.5 107554.5 113651.9 115048.4 35053.3 70528.3 77988.0 92116.0 100765.5 85997.6 89077.0 89973.1 91497.0 93146.6 9453.0 9904.3 9976.7 10112.9 10151.7 45580.0 53976.5 54936.2 55944.7 56130.7 75893.6 77455.0 79647.0 80582.4 83177.6 12343.2 12667.9 12741.7 12859.7 12961.6 13827.3 14186.1 14391.2 14417.4 14609.6 12746.2 12824.7 13711.3 14252.0 14267.6 12619.8 13465.1 13495.0 13513.9 13610.5 11981.5 12806.9 13074.2 13235.3 13453.0 8639.4 10900.2 11260.5 11391.7 11408.7 11265.6 11449.3 11574.8 11631.7 11651.5 13:43:53 INFO - PROCESS | 1639 | -------- Summary: end -------- 13:43:53 INFO - PROCESS | 1639 | 13:43:54 INFO - TEST-INFO | 1639: exit 0 13:43:54 INFO - TEST-OK | dromaeo_css | took 1113923ms 13:43:54 INFO - TEST-START | kraken 13:43:54 INFO - operating with platform_type : mac_ 13:43:54 INFO - Initialising browser for kraken test... 13:43:54 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpfG7_aF/profile http://localhost:49247/getInfo.html) 13:43:57 INFO - PROCESS | 1651 | 2017-02-06 13:43:57.033 plugin-container[1653:9939] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 13:43:57 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:43:57 INFO - PROCESS | 1651 | 2017-02-06 13:43:57.034 plugin-container[1653:9939] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 13:43:57 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:43:57 INFO - PROCESS | 1651 | 2017-02-06 13:43:57.034 plugin-container[1653:9939] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:43:57 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 13:43:57 INFO - PROCESS | 1651 | colorDepth:24 13:43:57 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 13:43:57 INFO - PROCESS | 1651 | __metrics 13:43:57 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:43:57 INFO - TEST-INFO | 1651: exit 0 13:43:57 INFO - Browser initialized. 13:43:57 INFO - Running cycle 1/1 for kraken test... 13:43:57 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpfG7_aF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:44:00 INFO - PROCESS | 1654 | 2017-02-06 13:44:00.408 plugin-container[1655:10066] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 13:44:00 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:44:00 INFO - PROCESS | 1654 | 2017-02-06 13:44:00.408 plugin-container[1655:10066] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8917, name = 'com.apple.CFPasteboardClient' 13:44:00 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:44:00 INFO - PROCESS | 1654 | 2017-02-06 13:44:00.408 plugin-container[1655:10066] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:44:10 INFO - PROCESS | 1654 | RSS: Main: 177491968 13:44:10 INFO - PROCESS | 1654 | 13:44:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 13:44:14 INFO - PROCESS | 1654 | RSS: Main: 190328832 13:44:14 INFO - PROCESS | 1654 | 13:44:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 13:44:17 INFO - PROCESS | 1654 | RSS: Main: 198254592 13:44:17 INFO - PROCESS | 1654 | 13:44:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 13:44:21 INFO - PROCESS | 1654 | RSS: Main: 202014720 13:44:21 INFO - PROCESS | 1654 | 13:44:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 13:44:23 INFO - PROCESS | 1654 | RSS: Main: 203325440 13:44:23 INFO - PROCESS | 1654 | 13:44:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:44:26 INFO - PROCESS | 1654 | RSS: Main: 203735040 13:44:26 INFO - PROCESS | 1654 | 13:44:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 13:44:29 INFO - PROCESS | 1654 | RSS: Main: 207716352 13:44:29 INFO - PROCESS | 1654 | 13:44:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 13:44:33 INFO - PROCESS | 1654 | RSS: Main: 207659008 13:44:33 INFO - PROCESS | 1654 | 13:44:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 13:44:36 INFO - PROCESS | 1654 | RSS: Main: 207130624 13:44:36 INFO - PROCESS | 1654 | 13:44:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:44:39 INFO - PROCESS | 1654 | RSS: Main: 206372864 13:44:39 INFO - PROCESS | 1654 | 13:44:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:44:41 INFO - PROCESS | 1654 | RSS: Main: 206393344 13:44:41 INFO - PROCESS | 1654 | 13:44:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:44:44 INFO - PROCESS | 1654 | RSS: Main: 206356480 13:44:44 INFO - PROCESS | 1654 | 13:44:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:44:47 INFO - PROCESS | 1654 | RSS: Main: 206364672 13:44:47 INFO - PROCESS | 1654 | 13:44:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:44:51 INFO - PROCESS | 1654 | RSS: Main: 206692352 13:44:51 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 13:44:53 INFO - PROCESS | 1654 | RSS: Main: 208437248 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | __start_tp_report 13:44:53 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 13:44:53 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 13:44:53 INFO - PROCESS | 1654 | |i|pagename|runs| 13:44:53 INFO - PROCESS | 1654 | |0;ai-astar;104;118;96;174;172;172;118;117;118;117 13:44:53 INFO - PROCESS | 1654 | |1;audio-beat-detection;140;114;139;179;144;135;112;116;167;114 13:44:53 INFO - PROCESS | 1654 | |2;audio-dft;193;193;196;202;192;198;195;198;203;194 13:44:53 INFO - PROCESS | 1654 | |3;audio-fft;81;57;58;81;58;58;59;57;76;60 13:44:53 INFO - PROCESS | 1654 | |4;audio-oscillator;87;71;88;72;70;88;92;68;71;85 13:44:53 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;88;89;86;107;131;89;100;90;86 13:44:53 INFO - PROCESS | 1654 | |6;imaging-darkroom;154;105;153;158;109;95;95;99;93;104 13:44:53 INFO - PROCESS | 1654 | |7;imaging-desaturate;87;88;91;77;136;137;90;95;76;132 13:44:53 INFO - PROCESS | 1654 | |8;json-parse-financial;56;56;55;58;59;61;59;59;58;57 13:44:53 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;67;68;66;83;75;72;67;68;68;68 13:44:53 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;80;100;82;82;82;83;85;88;84;101 13:44:53 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;138;140;140;144;142;139;144;144;183;144 13:44:53 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;165;170;162;230;217;163;161;166;175;229 13:44:53 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;69;83;89;65;60;74;85;86;69;67 13:44:53 INFO - PROCESS | 1654 | __end_tp_report 13:44:53 INFO - PROCESS | 1654 | __start_cc_report 13:44:53 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,928 13:44:53 INFO - PROCESS | 1654 | __end_cc_report 13:44:53 INFO - PROCESS | 1654 | __startTimestamp1486417493455__endTimestamp 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | ------- Summary: start ------- 13:44:53 INFO - PROCESS | 1654 | Number of tests: 14 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:130.60 Median:145.00 stddev:29.93 (20.6%) stddev-sans-first:30.16 13:44:53 INFO - PROCESS | 1654 | Values: 104.0 118.0 96.0 174.0 172.0 172.0 118.0 117.0 118.0 117.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:139.50 stddev:23.20 (16.6%) stddev-sans-first:24.56 13:44:53 INFO - PROCESS | 1654 | Values: 140.0 114.0 139.0 179.0 144.0 135.0 112.0 116.0 167.0 114.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:196.40 Median:197.00 stddev:3.81 (1.9%) stddev-sans-first:3.83 13:44:53 INFO - PROCESS | 1654 | Values: 193.0 193.0 196.0 202.0 192.0 198.0 195.0 198.0 203.0 194.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:64.50 Median:59.50 stddev:10.36 (17.4%) stddev-sans-first:9.11 13:44:53 INFO - PROCESS | 1654 | Values: 81.0 57.0 58.0 81.0 58.0 58.0 59.0 57.0 76.0 60.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:86.00 stddev:9.48 (11.0%) stddev-sans-first:9.63 13:44:53 INFO - PROCESS | 1654 | Values: 87.0 71.0 88.0 72.0 70.0 88.0 92.0 68.0 71.0 85.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:95.40 Median:88.00 stddev:14.22 (16.2%) stddev-sans-first:14.83 13:44:53 INFO - PROCESS | 1654 | Values: 88.0 88.0 89.0 86.0 107.0 131.0 89.0 100.0 90.0 86.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:125.50 stddev:27.06 (21.6%) stddev-sans-first:25.06 13:44:53 INFO - PROCESS | 1654 | Values: 154.0 105.0 153.0 158.0 109.0 95.0 95.0 99.0 93.0 104.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:100.90 Median:87.50 stddev:24.28 (27.7%) stddev-sans-first:25.22 13:44:53 INFO - PROCESS | 1654 | Values: 87.0 88.0 91.0 77.0 136.0 137.0 90.0 95.0 76.0 132.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.50 stddev:1.81 (3.1%) stddev-sans-first:1.80 13:44:53 INFO - PROCESS | 1654 | Values: 56.0 56.0 55.0 58.0 59.0 61.0 59.0 59.0 58.0 57.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:68.00 stddev:5.25 (7.7%) stddev-sans-first:5.43 13:44:53 INFO - PROCESS | 1654 | Values: 67.0 68.0 66.0 83.0 75.0 72.0 67.0 68.0 68.0 68.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:82.50 stddev:7.59 (9.2%) stddev-sans-first:7.65 13:44:53 INFO - PROCESS | 1654 | Values: 80.0 100.0 82.0 82.0 82.0 83.0 85.0 88.0 84.0 101.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:144.00 stddev:13.27 (9.2%) stddev-sans-first:13.77 13:44:53 INFO - PROCESS | 1654 | Values: 138.0 140.0 140.0 144.0 142.0 139.0 144.0 144.0 183.0 144.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:172.50 stddev:29.15 (16.9%) stddev-sans-first:30.11 13:44:53 INFO - PROCESS | 1654 | Values: 165.0 170.0 162.0 230.0 217.0 163.0 161.0 166.0 175.0 229.0 13:44:53 INFO - PROCESS | 1654 | 13:44:53 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:78.50 stddev:10.23 (13.0%) stddev-sans-first:10.64 13:44:53 INFO - PROCESS | 1654 | Values: 69.0 83.0 89.0 65.0 60.0 74.0 85.0 86.0 69.0 67.0 13:44:53 INFO - PROCESS | 1654 | -------- Summary: end -------- 13:44:53 INFO - PROCESS | 1654 | 13:44:54 INFO - TEST-INFO | 1654: exit 0 13:44:54 INFO - TEST-OK | kraken | took 60181ms 13:44:54 INFO - SUITE-END | took 1174s 13:44:54 INFO - Completed test suite (00:19:34) 13:44:54 INFO - javascript benchmark 13:44:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7262.570534921326, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.2113650450874, 3616.5479315085613, 3628.8911332660014, 3654.2691461707664, 3666.3767159582867, 5940.76236950522, 5967.761289548418, 5967.955607768645, 5970.850728731784, 5979.701014949246, 4704.600108990731, 5572.721363931797, 5928.614640048394, 5949.940500594993, 6036.064410016444, 4670.462896766881, 5327.760250788714, 5381.81163659272, 5421.457854214566, 5421.891562168754, 5408.513233808956, 5434.864128396802, 5447.428020057877, 5449.964506743726, 5491.313585801775, 5308.9469105308835, 5323.121684922003, 5421.620486565942, 5430.755615997289, 5434.0218760623075, 5351.170568561879, 5382.515573598375, 5400.108982017962, 5443.836684899459, 5485.807996720136, 5292.576593872481, 5374.27447294618, 5397.460253974571, 5401.756920938567, 5409.972950135263, 6039.788607398764, 6069.514438844882, 6092.0, 6147.016477363645, 6150.630962142286, 6177.444030037318, 6188.1027251048345, 6190.102435146923, 6252.6561039142825, 6283.528735344822, 6324.146240257553, 6325.652089135096, 6329.68351582419, 6338.271098823602, 6341.619502829799, 6058.121572372025, 6087.05650624154, 6091.329953705089, 6098.054801505774, 6110.08348747687, 6192.256929168529, 6292.8426789329715, 6318.778842740482, 6333.398327158912, 6413.422791948747, 6219.533534984895, 6279.246490421087, 6291.937080629226, 6304.148939893055, 6305.8108256752375, 6323.52573556985, 6346.555741098171, 6353.0, 6356.682165891687, 6357.650329231937, 6190.876182476325, 6194.256689197326, 6207.968960155261, 6269.216347956505, 6279.277883043417, 6188.907166392508, 6190.721417536221, 6247.375262473716, 6254.593451425642, 6264.843378915472, 5084.618653600995, 5094.057599344059, 5101.69389836611, 5112.207607820794, 5113.565346945476, 3703.5926048134684, 4470.284754439339, 4607.58531732139, 4608.539146085364, 4636.79134438951, 4809.927851082237, 4988.6009119270375, 6042.879142417215, 6061.363556826558, 6078.513718902477, 5248.370195576479, 5313.946860531422, 6326.68366581669, 6347.809565713036, 6352.4918006559365, 5960.642361458326, 6028.9397106029255, 6051.818445446644, 6054.273487181478, 6138.324784273726, 5563.36021357541, 5579.721013949286, 5579.7489112990015, 5598.1322894951345, 5611.298587676541, 6442.130312407765, 6489.253735820346, 6501.9674901625185, 6522.836929076811, 6528.608283503005, 6180.721867515883, 6191.690415479118, 6243.001119820807, 6313.305536390902, 6326.367363263636, 5493.505584497414, 6362.3319551448285, 6434.581752186093, 6506.089147519257, 6513.5114866384265, 6250.437460628384, 6258.374162583706, 6265.655388953469, 6286.245650521967, 6290.339514350927, 6084.209052823105, 6240.687965601611, 6244.875102498016, 6305.495560355253, 6326.778562750465, 6168.784092556739, 6188.845278868064, 6201.976673848764, 6263.592866463665, 6270.0, 6220.0047992321015, 6240.937590624036, 6241.21984751906, 6241.531885108726, 6274.435300822948, 6028.336882942785, 6099.66451845135, 6147.938520614736, 6212.596181248205, 6257.56197066201, 6149.893019256577, 6181.81454556364, 6190.535709821871, 6232.18981532416, 6278.905816412849, 6134.11055396956, 6191.597546159485, 6198.101275315144, 6220.440160385587, 6255.624662520263], "value": 5818.998507349774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.02113052025487, 489.46892621505674, 528.5401700520547, 534.4601952028451, 541.3909351979023, 38053.04867378314, 39643.0, 39659.0, 39730.60269397309, 39931.00172495682, 41431.585684143225, 41535.792321038425, 41889.16221675565, 41947.79026104873, 42281.36577951333, 9618.278629102793, 9755.02449755026, 9764.609415623367, 9842.311038227326, 9857.753556161082, 9650.951745241264, 9751.561179746928, 9754.707358779247, 9771.853422198637, 9786.755331116743, 9712.66005689801, 9766.414015159078, 9798.804023919518, 9808.970058143863, 9820.656277030306, 9605.615775368977, 9702.708918732415, 9775.462349570771, 9778.266630002778, 9788.972157923423, 9720.90279097207, 9730.318877678565, 9743.610255589769, 9794.755131121708, 9815.950920245425, 39359.0, 39569.010774730865, 39704.0, 39727.60272397268, 39735.40396894049, 3152.5428812822242, 3229.564008858821, 3231.353729254135, 3459.6713312235297, 3493.109257139439, 29969.550456743167, 30140.24649383783, 30159.698403015907, 30763.76944922223, 31019.53470697941, 3249.772515923886, 3301.158204657821, 3314.005798260512, 3315.303786204876, 3350.597928248626, 396250.0, 396744.0, 399376.0, 400389.0, 401501.0, 57101.71449142811, 57506.7124664374, 57516.0, 57604.42395575991, 57608.42391576031, 55435.445645543026, 55648.44351556433, 55678.443215568135, 55684.16473752897, 55917.0, 14479.78280325796, 15556.0, 15632.296546655427, 15667.216639167997, 15695.29371178277, 12025.098117641212, 12063.336516491501, 12148.392580370946, 12151.513939442324, 12170.634880953585, 14846.18345990981, 14981.176035317943, 15162.469313574193, 15187.544373668808, 15329.540113796604, 3241.756868234892, 5248.6325957182635, 6281.434670879643, 6317.4946004319545, 6322.6489960321105, 869.7173418638841, 889.5374405309333, 999.7600575861741, 1006.33079002464, 1023.81059503992, 28995.42009159805, 29912.55131173034, 30019.849900750793, 30499.0, 30548.0, 1053.3363980692268, 1053.4258828938248, 1077.719792853848, 1089.9128069754402, 1230.4585982167816, 9915.553800079013, 16072.517824465285, 16342.346306147621, 16366.83633163653, 16496.92769969948, 567312.0, 674650.0, 682905.0, 683179.0, 684834.0, 56752.71623641938, 57162.57093572694, 57164.14253786197, 57422.0, 57548.0, 1370.1915869636962, 1371.6502291915697, 1389.979150312746, 1414.679924923127, 1417.1992824054375, 29346.559801602565, 29816.10551683453, 30232.546511801902, 30302.696973029986, 30625.0, 47405.52594474011, 47817.76091119522, 47968.80077998078, 47998.28002580034, 48124.518754813405, 573530.0, 576770.0, 577545.0, 580509.0, 580904.0, 22411.663825042313, 26396.340091497867, 26539.80570874354, 26600.8669956649, 26842.06052788221, 43795.12409751723, 43877.90305242394, 44382.77808611065, 44492.11015779731, 44590.77704611586, 36451.359688813536, 36720.63279367172, 36752.713655021944, 37093.6290637101, 37913.4312985311, 36844.26311473809, 36982.0, 37080.62919370772, 37709.622903770614, 37854.0, 35446.759363422156, 35825.64174358223, 36186.914392568266, 36343.27313453769, 36548.63451365452, 31670.0, 33439.49840752439, 33489.49765753564, 33588.66411335855, 33718.831405842815, 24632.0, 25041.624375634015, 25051.0, 25109.32276835459, 25286.24141275765], "value": 19299.520962069626, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.58006502489627, 386.45316876619586, 397.43564138922727, 398.3665971105941, 417.7827529684564, 14824.55526334209, 18879.0, 19724.112414941326, 20354.08406621702, 20445.284415045477, 14838.851611483882, 19849.503762405948, 20005.399838004883, 20473.0, 20498.385048448534, 5847.298324201101, 5858.648481091138, 6012.759489620432, 6098.542609304298, 6112.327643959161, 5895.410458954113, 6010.398960103998, 6053.424924632153, 6055.818325450244, 6082.330943596201, 5954.4938680212235, 6029.306629737593, 6044.425779550936, 6051.697415129248, 6056.727447264883, 5173.9741301293625, 5470.550304169398, 5685.033544297458, 6009.0, 6049.879002419971, 5210.088234558937, 5223.921641175385, 5260.342457192851, 5299.5760339172775, 5314.282571852789, 24686.876565617236, 24944.376390590198, 25422.491550168892, 25562.488750224893, 25981.870090649427, 2315.6063469210108, 2395.006072479936, 2585.9870700646375, 2850.1734496995846, 3022.9848850755825, 11806.88193118075, 12540.184887982252, 13498.932505337509, 15250.161241131733, 15766.132862692548, 1605.727026405514, 1864.6643604151247, 1867.365095867398, 1870.2705944681586, 1898.411492437335, 114928.0, 116921.0, 118199.40900295529, 123479.0, 125802.37098814538, 10535.0, 11030.393328367018, 11921.046316294676, 11930.940345298219, 11941.582044628396, 11986.400679965967, 12683.175593586388, 14999.625009374853, 15209.695806083817, 15216.239188040554, 6367.554271201064, 8105.392095592736, 8193.262606365455, 8220.876686849702, 8235.917640823634, 8392.79018024542, 8406.957965210135, 8419.326453883674, 8519.701810436605, 8557.315414766803, 3984.960150398517, 3992.121733218687, 4025.4565633639086, 4050.3721923101966, 4085.9795701021303, 1684.4188754879792, 1924.7786504551875, 1955.3840540229783, 1972.7435433393566, 1980.2870517002978, 875.991240087591, 906.1708536688988, 939.7697564096703, 975.1467465967279, 989.5596459575564, 20673.069711863, 21015.78984210169, 21214.15143394247, 21230.893845530674, 21326.253581124587, 838.9664413423395, 942.7548837302351, 955.0974329258922, 960.1550635440907, 1002.3785253143097, 10597.25819192649, 11176.60881869147, 11206.21556491054, 11209.495572699248, 11213.439328033566, 421379.0, 471393.2860671418, 591310.0, 619195.0, 642639.0, 117712.64574708458, 118997.0, 122207.0, 125304.37347813202, 130456.0, 955.8996305387973, 980.0542476510202, 982.29274922056, 997.7705127820497, 1003.0571263012745, 18327.816721833144, 18515.907420462812, 18689.813101869353, 18767.530811729815, 18847.434576962714, 42737.0, 52394.0, 53533.0, 53761.655958601346, 56285.718571406884, 79440.20559794328, 81612.77580836411, 81827.0, 81946.03718321142, 82028.17971820205, 7769.184235655175, 7847.568383738949, 8041.276285134366, 8167.83664326722, 8209.384296177692, 9328.347015708836, 11646.417679116179, 11805.468753906267, 12026.639200823989, 12069.75860482803, 10283.537240824031, 10300.381977081399, 10379.792404152025, 10510.527026283682, 10603.41681207541, 8662.91337086621, 10050.19598432109, 10275.0, 10380.013898679614, 10513.9474302628, 10496.527656255334, 10592.675915510561, 10699.679009629723, 10706.089982351587, 11003.119750419786, 7885.233541013596, 7978.481398709066, 7988.680452781824, 8280.378971577034, 8281.171882811912, 10254.974502549983, 10268.64059757905, 10474.371537707762, 10491.790164196826, 10565.683029509128], "value": 9465.221936464055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.3262032085565, 1539.191924239774, 1767.1429356761969, 1797.1912639312313, 1931.2854243929748, 7778.105517865447, 8023.759287221378, 8310.210529999647, 8774.561271936394, 8794.780130496742, 8281.089080201173, 8533.445326053803, 8558.957205213965, 8638.09300023498, 8641.91358086419, 2356.281334193066, 2404.2907342333965, 2406.0736616402637, 2408.915687950922, 2411.168146989286, 2368.4789346343778, 2434.257551446808, 2434.817388695855, 2441.4872876695913, 2442.1696623148127, 2374.3470545599926, 2377.0967032527615, 2394.4133687246563, 2400.927972160838, 2409.7349291578, 2343.5078633486987, 2370.9881450592725, 2387.55830171418, 2391.629297458897, 2407.1334319645002, 2403.795677367426, 2406.975930240693, 2420.8426452280546, 2430.829841911067, 2436.549238390903, 8581.313494920392, 8652.04827468978, 8711.912880871174, 8717.825643487158, 8718.564071796385, 5247.816326428595, 5372.328458942632, 5417.052015897241, 5422.674639521641, 5424.1321388577635, 3506.9649303506894, 3547.5388199534154, 3576.588692300367, 3601.567811862567, 3615.8192090395637, 1045.9110975567087, 1066.2376400873336, 1097.8956999085153, 1109.4175557832123, 1112.0991996482874, 11340.546378144863, 11400.429978501043, 11410.657680269605, 11422.657320280405, 11472.369019703912, 4610.907781844345, 4733.810647574127, 4814.759262036884, 4817.98822247325, 4886.096072226649, 9822.901770982342, 9840.704778856645, 9842.606295748234, 9861.112499874902, 9873.40759554429, 5315.176147697036, 5392.838214853561, 5395.568354531628, 5400.729963501809, 5407.594430417735, 4443.0669559392245, 4498.752568608693, 4897.926531102036, 4939.580135688435, 4940.604751619861, 3974.2448934702315, 4008.398740188995, 4059.6143366380147, 4111.465509483748, 4129.380592911028, 1124.9325040497597, 1313.2448841915746, 1325.15190278222, 1330.3614265152587, 1331.8534961154264, 791.6318911705969, 804.818915743953, 836.6277006731946, 917.1653795046476, 939.769756409684, 4805.3512775775525, 5522.779088836482, 5685.914711279334, 5811.186433899257, 5841.503472204825, 885.8892638420198, 940.4357385568741, 954.1031430455349, 966.7728083900278, 971.5773638467148, 3693.1874987502706, 3913.7064720146104, 4020.9195816083516, 4090.4682391288943, 4094.529129150126, 10347.27569070158, 10365.0, 10550.419726914939, 10558.841617375745, 10561.260711750258, 10061.949690251502, 10479.895201047892, 10502.789944201073, 10546.472676366151, 10549.156067514581, 7994.920050799417, 8196.54918979462, 8224.136465671138, 8225.917740822635, 8241.217084376975, 5605.635633683797, 5729.713514324184, 5775.768969241183, 5781.4218578141845, 6141.877162456815, 9482.336236463381, 9487.383320084173, 9537.23702103844, 9694.5152742364, 9779.022097790164, 8075.353971682134, 9497.477638729937, 9818.65634702782, 9854.359466634645, 9951.601935922772, 6847.726090956306, 7047.154341479055, 7109.964450177923, 7360.0, 7519.774406767806, 8115.0, 8298.668053277801, 8361.95819020901, 8367.539785311867, 8383.664653413794, 7327.0841144856895, 7370.189279179179, 7371.447141464304, 7405.925940740523, 7605.847883042197, 7321.926780732125, 7363.858601916711, 7384.9261507384235, 7413.147488038944, 7421.517601355895, 6890.896636550356, 6971.128608923885, 6983.441324694114, 7021.789346319414, 7023.929760702532, 4199.286121359437, 4771.761411929459, 4811.711297322172, 4830.975845120752, 4872.074305882013, 4755.571998520011, 4820.204666230033, 4877.463479017376, 4887.975560122177, 4890.926636100533], "value": 4563.729151842562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.1009488876485, 311.6836411042792, 317.90145055032934, 321.1489552685385, 322.9874343931773, 4160.895977600561, 4463.464384273888, 4519.796609152588, 5475.370332411764, 5494.417623716851, 5512.228288039678, 5536.0, 5571.300753270251, 5588.385277619469, 5590.301212348457, 3879.5926427725108, 4090.9954122480067, 4248.065425606369, 4259.510156332015, 4260.0, 3905.3638793814202, 4131.8967025824295, 4242.809073591696, 4265.909704244913, 4268.445102136718, 3534.6642069003406, 4066.471358723362, 4103.8563650272245, 4116.423700681907, 4127.793610319487, 3318.6061854021127, 4061.8578349757618, 4107.979460102695, 4134.255833949888, 4141.937870931938, 3590.438159400669, 3605.152789094561, 3613.1509095362567, 3618.6924111450558, 3625.23869987303, 4151.294279972412, 4438.958079283533, 5357.973210133963, 5360.60624237701, 5378.838634840961, 4778.116048531033, 4796.928046079312, 4799.400074990626, 4813.302071199656, 4827.372441582607, 4775.355327030841, 5053.317802096743, 5460.481254280837, 5598.524125449342, 5849.181114643953, 3809.466674665549, 3951.644352008333, 3972.82122304497, 3993.800309984489, 3998.800059997018, 6046.213992181032, 6083.813656337016, 6144.3717414885095, 6191.814245572595, 6205.6897155142515, 3676.522052133259, 4061.268971585143, 4066.6949978751713, 4073.572274911151, 4079.91840163201, 3459.619441861393, 3893.9610603894166, 4077.103037331782, 4083.8570650027104, 4099.85650502231, 3986.80065996699, 4523.303761089592, 4708.717476951394, 4781.856544303677, 4788.233882578771, 5859.53123750099, 5865.501432378295, 5876.44173803488, 5880.176775251468, 5884.941150588525, 1233.3155098920186, 1263.8420197475316, 1315.7697402954636, 1324.7414955791844, 1335.4925128451127, 772.5519198864645, 875.7022612311845, 893.8882639670041, 906.7959709065408, 908.6365453818394, 4644.170063134303, 5031.496850314939, 5287.920681189786, 5294.7352632369, 5308.548773354308, 4826.61387089032, 4841.709497430165, 5639.802606908738, 5709.660657899943, 5729.7340515905535, 4758.857234282977, 5020.548150666457, 5169.327987361619, 5275.470113666994, 5292.0, 2544.536891287517, 2826.5160790585105, 2826.844523551183, 2889.508783506809, 2910.2142421546064, 5879.706014699248, 5921.585489015728, 5940.6435613863305, 5961.612495187799, 6024.969875150597, 4926.827561035347, 5153.665011774223, 5163.896722065613, 5784.946344047887, 5841.357450680422, 5315.501714194323, 5588.640860129106, 5886.764529418775, 5917.674527900921, 5974.970125149346, 4921.778519966539, 5338.119210330252, 5691.914621280767, 5731.054376028075, 5817.0, 4540.341650460598, 4962.652614316963, 5625.46558076982, 5630.49442997862, 5644.9435505644415, 5001.698878740014, 5446.863828404322, 5608.355039170548, 5973.701314934323, 6010.3088144863905, 3318.4026875162704, 3320.684534969174, 3729.869454569077, 3875.224955008953, 3877.6122387760997, 5229.947700522946, 5906.7341969612335, 5989.880202396015, 6025.0, 6035.849103772441, 4876.146674332049, 5940.227770389822, 5942.702864856827, 5951.28584569837, 5993.0, 5322.828977624917, 5385.488378604026, 5901.3213480450295, 5946.583739138218, 5983.282006159288, 4543.454785425638, 4621.237495813153, 5308.628396012242, 5720.74256658443, 5806.371018113679, 5381.811636592701, 5891.203183029217, 5914.319853216935, 5917.674527900835, 5917.822465326047, 4783.234682450791, 5444.930926248, 5690.857728556819, 5711.942880571141, 5849.795257165979], "value": 4137.552034332594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.4658632732287, 719.9244079371666, 762.0931092000519, 811.2941740685598, 833.604038081911, 13024.153430027041, 14635.853641463582, 14945.25273736313, 15403.152826594533, 15409.69180616387, 13059.673508162301, 13948.02363834532, 14050.0, 14062.789058164135, 14111.012229143938, 841.5623875584693, 847.7033038436529, 862.1163307609719, 864.1315477944656, 867.4274978514181, 867.6963062927988, 867.7093173786789, 873.7990262239657, 875.5359659380539, 876.4609764994547, 863.2532859076916, 910.3854897943894, 910.8679241509977, 911.2527727263647, 911.3028533172129, 863.1282404771194, 895.38218629146, 895.5925054100434, 900.5362238447204, 902.6615019367737, 650.3756393861898, 650.7006776882592, 661.3023260460212, 671.2817285504512, 673.9789219332715, 12353.444095015746, 12382.504699811996, 12714.23714577119, 12850.807237891438, 12861.0, 12019.939900300442, 12076.21504602207, 12174.939125304405, 12196.14626976112, 12247.0, 10838.891611083945, 10858.511366988505, 10870.130389568816, 10996.670099896935, 11103.777924441465, 3667.4132138857653, 3716.349638813224, 3717.3866312058476, 3720.6465385788306, 3726.1988672435555, 90355.54822225847, 92566.53716731441, 92586.0, 92920.0, 94435.52782236045, 7400.0, 9079.863802042975, 9098.909010909807, 9116.726498205064, 9225.630974760934, 18808.81191188098, 18875.716864247046, 18883.0, 18969.43091707251, 19035.04824758784, 7797.727079552188, 7813.960930195312, 7878.212178782076, 7930.920690793018, 8044.597770111471, 4371.978140109342, 4426.601605855489, 4481.282994720829, 4526.615237704832, 4544.590986811203, 3370.612379576331, 3438.896833095011, 3579.731520136, 3705.981470092632, 3880.7865567394065, 703.9824004399931, 713.5076797010047, 716.3123401534585, 721.9494635375473, 732.0885497555578, 634.8000379880323, 654.2345455816705, 655.8098151536096, 661.3485716569176, 675.1054852320694, 9081.091890810865, 9088.545572721338, 9554.426734395958, 9618.230541556659, 9695.272854535939, 447.7089891570505, 462.41273582549974, 524.5646113725599, 562.6314763829698, 579.44373401535, 3645.7630254033934, 4512.706674066175, 4669.229577119805, 4741.431028276629, 4742.288656701522, 104135.0, 107499.46250268699, 107554.46222768836, 113651.86348136413, 115048.42475787568, 35053.29893402118, 70528.2947170532, 77988.0, 92116.0, 100765.49617251867, 85997.57001214953, 89077.0, 89973.10026899647, 91497.0, 93146.60280095803, 9452.952735236555, 9904.306698531034, 9976.650817221362, 10112.898871011195, 10151.7462063449, 45580.0, 53976.46023539714, 54936.175957359876, 55944.72027639836, 56130.719346403006, 75893.62053189699, 77455.0, 79647.0, 80582.3883522338, 83177.58411207906, 12343.19769214998, 12667.93666031664, 12741.683978737172, 12859.742805144031, 12961.611151665466, 13827.308634568433, 14186.077904936146, 14391.208483533506, 14417.423303068179, 14609.634759131106, 12746.171498852545, 12824.679383015125, 13711.314434278047, 14252.002359834712, 14267.64330891736, 12619.810702839648, 13465.124766890121, 13495.0, 13513.864861351261, 13610.455581777014, 11981.520739170335, 12806.935965320487, 13074.150180238254, 13235.32327458029, 13453.0, 8639.395242332976, 10900.182486313717, 11260.493277802354, 11391.715207119556, 11408.657740267805, 11265.605703800327, 11449.313041217554, 11574.768504630028, 11631.709207269885, 11651.533938642699], "value": 7309.867758228066, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 96.0, 174.0, 172.0, 172.0, 118.0, 117.0, 118.0, 117.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 139.0, 179.0, 144.0, 135.0, 112.0, 116.0, 167.0, 114.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 193.0, 196.0, 202.0, 192.0, 198.0, 195.0, 198.0, 203.0, 194.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 81.0, 58.0, 58.0, 59.0, 57.0, 76.0, 60.0], "value": 64.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 88.0, 72.0, 70.0, 88.0, 92.0, 68.0, 71.0, 85.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 86.0, 107.0, 131.0, 89.0, 100.0, 90.0, 86.0], "value": 95.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 105.0, 153.0, 158.0, 109.0, 95.0, 95.0, 99.0, 93.0, 104.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 91.0, 77.0, 136.0, 137.0, 90.0, 95.0, 76.0, 132.0], "value": 100.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 58.0, 59.0, 61.0, 59.0, 59.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 83.0, 75.0, 72.0, 67.0, 68.0, 68.0, 68.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 100.0, 82.0, 82.0, 82.0, 83.0, 85.0, 88.0, 84.0, 101.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 140.0, 144.0, 142.0, 139.0, 144.0, 144.0, 183.0, 144.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 162.0, 230.0, 217.0, 163.0, 161.0, 166.0, 175.0, 229.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 83.0, 89.0, 65.0, 60.0, 74.0, 85.0, 86.0, 69.0, 67.0], "value": 74.7, "unit": "score"}]}]} 13:44:54 INFO - Return code: 0 13:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:44:54 ERROR - # TBPL SUCCESS # 13:44:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:44:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:44:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:44:54 INFO - 2017-02-06 13:44:54.822 screenresolution[1659:10444] starting screenresolution argv=screenresolution get 13:44:54 INFO - 2017-02-06 13:44:54.824 screenresolution[1659:10444] Display 0: 1600x1200x32@60 13:44:54 INFO - 2017-02-06 13:44:54.830 screenresolution[1660:10447] starting screenresolution argv=screenresolution list 13:44:54 INFO - Available Modes on Display 0 13:44:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:44:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:44:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:44:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:44:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:44:55 INFO - Intel Iris: 13:44:55 INFO - Chipset Model: Intel Iris 13:44:55 INFO - Type: GPU 13:44:55 INFO - Bus: Built-In 13:44:55 INFO - VRAM (Dynamic, Max): 1536 MB 13:44:55 INFO - Vendor: Intel (0x8086) 13:44:55 INFO - Device ID: 0x0a2e 13:44:55 INFO - Revision ID: 0x0009 13:44:55 INFO - Displays: 13:44:55 INFO - Display: 13:44:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:44:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:44:55 INFO - Display Serial Number: 1600x1200 60 13:44:55 INFO - Main Display: Yes 13:44:55 INFO - Mirror: Off 13:44:55 INFO - Online: Yes 13:44:55 INFO - Rotation: Supported 13:44:55 INFO - Return code: 0 13:44:55 INFO - Running post-action listener: _resource_record_post_action 13:44:55 INFO - [mozharness: 2017-02-06 21:44:55.069115Z] Finished run-tests step (success) 13:44:55 INFO - Running post-run listener: _resource_record_post_run 13:44:55 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40511488; Write bytes: 501593088; Read time: 389; Write time: 1513 13:44:55 INFO - TinderboxPrint: CPU usage
54.3% 13:44:55 INFO - TinderboxPrint: I/O read bytes / time
40,511,488 / 389 13:44:55 INFO - TinderboxPrint: I/O write bytes / time
501,593,088 / 1,513 13:44:55 INFO - TinderboxPrint: CPU idle
2,187.7 (45.7%) 13:44:55 INFO - TinderboxPrint: CPU system
968.0 (20.2%) 13:44:55 INFO - TinderboxPrint: CPU user
1,630.0 (34.1%) 13:44:55 INFO - TinderboxPrint: Swap in / out
232,095,744 / 0 13:44:55 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183251456; Write bytes: 175513600; Read time: 16875; Write time: 322 13:44:55 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 38696960; Write bytes: 308532224; Read time: 369; Write time: 1140 13:44:55 INFO - Running post-run listener: _upload_blobber_files 13:44:55 INFO - Blob upload gear active. 13:44:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:44:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:44:55 INFO - (blobuploader) - INFO - Open directory for files ... 13:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:44:56 INFO - (blobuploader) - INFO - Done attempting. 13:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:44:57 INFO - (blobuploader) - INFO - Done attempting. 13:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:44:59 INFO - (blobuploader) - INFO - Done attempting. 13:44:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:44:59 INFO - Return code: 0 13:44:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:44:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:44:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1be0159a0ff4fcf5cdbbc3a2ef0d7aca203cbdbc961eb936c24c8b3d04f320e766ca23bac56a21b1795abf9383a1bdcf74454358a1573d8024d5e1e6cafbe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d9e589de2c5e9872def291baf02ae306b08098b2fe3e7b18aa0ffa76404eaa6dcd969d481b81d9b73773d13484380c17ffa06a18bf11d0f483f4924bda80236", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4b585834f9a9d3a3115fbd43ad3ad9db35ee5b4f2ad838c659d2875a6e16775cb4f1317f45bd89952338af9cca19987a22d89e95669fc6c845c2bfd8f4edb56"} 13:44:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:44:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:44:59 INFO - Contents: 13:44:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1be0159a0ff4fcf5cdbbc3a2ef0d7aca203cbdbc961eb936c24c8b3d04f320e766ca23bac56a21b1795abf9383a1bdcf74454358a1573d8024d5e1e6cafbe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d9e589de2c5e9872def291baf02ae306b08098b2fe3e7b18aa0ffa76404eaa6dcd969d481b81d9b73773d13484380c17ffa06a18bf11d0f483f4924bda80236", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4b585834f9a9d3a3115fbd43ad3ad9db35ee5b4f2ad838c659d2875a6e16775cb4f1317f45bd89952338af9cca19987a22d89e95669fc6c845c2bfd8f4edb56"} 13:44:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:44:59 INFO - Copying logs to upload dir... 13:44:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:44:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.541242 ========= master_lag: 2.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-06 13:45:02.225707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 13:45:02.233332) ========= 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.5I6bv8QBkq/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.q7PRmD56FL/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1be0159a0ff4fcf5cdbbc3a2ef0d7aca203cbdbc961eb936c24c8b3d04f320e766ca23bac56a21b1795abf9383a1bdcf74454358a1573d8024d5e1e6cafbe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d9e589de2c5e9872def291baf02ae306b08098b2fe3e7b18aa0ffa76404eaa6dcd969d481b81d9b73773d13484380c17ffa06a18bf11d0f483f4924bda80236", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4b585834f9a9d3a3115fbd43ad3ad9db35ee5b4f2ad838c659d2875a6e16775cb4f1317f45bd89952338af9cca19987a22d89e95669fc6c845c2bfd8f4edb56"} build_url:https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/d7q0TA3mSkOmy9hTgXn7LA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1be0159a0ff4fcf5cdbbc3a2ef0d7aca203cbdbc961eb936c24c8b3d04f320e766ca23bac56a21b1795abf9383a1bdcf74454358a1573d8024d5e1e6cafbe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d9e589de2c5e9872def291baf02ae306b08098b2fe3e7b18aa0ffa76404eaa6dcd969d481b81d9b73773d13484380c17ffa06a18bf11d0f483f4924bda80236", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d4b585834f9a9d3a3115fbd43ad3ad9db35ee5b4f2ad838c659d2875a6e16775cb4f1317f45bd89952338af9cca19987a22d89e95669fc6c845c2bfd8f4edb56"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 13:45:02.272751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:45:02.273101) ========= 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.5I6bv8QBkq/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.q7PRmD56FL/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:45:02.321591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 13:45:02.324937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 13:45:02.325281) ========= ========= Total master_lag: 2.38 =========