builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0245 starttime: 1491565312.57 results: success (0) buildid: 20170407030233 builduid: b4a97fc9b11b4429acc014da5a036589 revision: 10ea10d9993c9701e5525928257a589dea2c05d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.571060) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.571546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.571843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.597300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.597686) ========= 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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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-04-07 04:41:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.8M=0.001s 2017-04-07 04:41:52 (14.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094315 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.716867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.717364) ========= 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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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.020563 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:52.765995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 04:41:52.766368) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10ea10d9993c9701e5525928257a589dea2c05d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 10ea10d9993c9701e5525928257a589dea2c05d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BZoNOT3JxW/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.67KS8Hi1i7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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-04-07 04:41:52,998 truncating revision to first 12 chars 2017-04-07 04:41:52,998 Setting DEBUG logging. 2017-04-07 04:41:52,998 attempt 1/10 2017-04-07 04:41:52,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10ea10d9993c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 04:41:55,210 unpacking tar archive at: mozilla-central-10ea10d9993c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.476375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 04:41:55.264821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:55.265220) ========= script_repo_revision: 10ea10d9993c9701e5525928257a589dea2c05d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:55.265629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:55.265901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 04:41:55.284088) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-07 04:41:55.284488) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BZoNOT3JxW/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.67KS8Hi1i7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:41:55 INFO - MultiFileLogger online at 20170407 04:41:55 in /builds/slave/test 04:41:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:41:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:55 INFO - {'append_to_log': False, 04:41:55 INFO - 'base_work_dir': '/builds/slave/test', 04:41:55 INFO - 'blob_upload_branch': 'Firefox', 04:41:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:55 INFO - 'branch': 'Firefox', 04:41:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:55 INFO - 'config_files': ('talos/mac_config.py',), 04:41:55 INFO - 'default_actions': ('clobber', 04:41:55 INFO - 'read-buildbot-config', 04:41:55 INFO - 'download-and-extract', 04:41:55 INFO - 'populate-webroot', 04:41:55 INFO - 'create-virtualenv', 04:41:55 INFO - 'install', 04:41:55 INFO - 'run-tests'), 04:41:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:55 INFO - 'download_minidump_stackwalk': True, 04:41:55 INFO - 'download_symbols': 'ondemand', 04:41:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:55 INFO - 'gecko_profile': False, 04:41:55 INFO - 'gecko_profile_interval': 0, 04:41:55 INFO - 'installer_path': 'installer.exe', 04:41:55 INFO - 'log_level': 'info', 04:41:55 INFO - 'log_name': 'talos', 04:41:55 INFO - 'log_to_console': True, 04:41:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:41:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:41:55 INFO - 'opt_config_files': (), 04:41:55 INFO - 'pip_index': False, 04:41:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:55 INFO - 'cmd': ('bash', 04:41:55 INFO - '-c', 04:41:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:55 INFO - 'enabled': True, 04:41:55 INFO - 'halt_on_failure': False, 04:41:55 INFO - 'name': 'check_screen_resolution'},), 04:41:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:55 INFO - 'cmd': ('bash', 04:41:55 INFO - '-c', 04:41:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:55 INFO - 'enabled': True, 04:41:55 INFO - 'halt_on_failure': False, 04:41:55 INFO - 'name': 'check_screen_resolution'},), 04:41:55 INFO - 'run_cmd_checks_enabled': True, 04:41:55 INFO - 'suite': 'dromaeojs-e10s', 04:41:55 INFO - 'system_bits': '32', 04:41:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:55 INFO - 'title': 't-yosemite-r7-0245', 04:41:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:55 INFO - 'use_talos_json': True, 04:41:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:55 INFO - 'work_dir': 'build'} 04:41:55 INFO - [mozharness: 2017-04-07 11:41:55.620055Z] Running clobber step. 04:41:55 INFO - Running pre-action listener: _resource_record_pre_action 04:41:55 INFO - Running main action method: clobber 04:41:55 INFO - rmtree: /builds/slave/test/build 04:41:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:55 INFO - Running post-action listener: _resource_record_post_action 04:41:55 INFO - [mozharness: 2017-04-07 11:41:55.811102Z] Finished clobber step (success) 04:41:55 INFO - [mozharness: 2017-04-07 11:41:55.811238Z] Running read-buildbot-config step. 04:41:55 INFO - Running pre-action listener: _resource_record_pre_action 04:41:55 INFO - Running main action method: read_buildbot_config 04:41:55 INFO - Using buildbot properties: 04:41:55 INFO - { 04:41:55 INFO - "project": "", 04:41:55 INFO - "product": "firefox", 04:41:55 INFO - "script_repo_revision": "production", 04:41:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:41:55 INFO - "repository": "", 04:41:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:41:55 INFO - "buildid": "20170407030233", 04:41:55 INFO - "stage_platform": "macosx64", 04:41:55 INFO - "basedir": "/builds/slave/test", 04:41:55 INFO - "nightly_build": "True", 04:41:55 INFO - "buildnumber": 36, 04:41:55 INFO - "slavename": "t-yosemite-r7-0245", 04:41:55 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:41:55 INFO - "platform": "yosemite_r7", 04:41:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:41:55 INFO - "branch": "mozilla-central", 04:41:55 INFO - "repo_path": "mozilla-central", 04:41:55 INFO - "revision": "10ea10d9993c9701e5525928257a589dea2c05d8", 04:41:55 INFO - "pgo_build": "False", 04:41:55 INFO - "builduid": "b4a97fc9b11b4429acc014da5a036589", 04:41:55 INFO - "slavebuilddir": "test" 04:41:55 INFO - } 04:41:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:41:55 INFO - Running post-action listener: _resource_record_post_action 04:41:55 INFO - [mozharness: 2017-04-07 11:41:55.814693Z] Finished read-buildbot-config step (success) 04:41:55 INFO - [mozharness: 2017-04-07 11:41:55.814818Z] Running download-and-extract step. 04:41:55 INFO - Running pre-action listener: _resource_record_pre_action 04:41:55 INFO - Running main action method: download_and_extract 04:41:55 INFO - mkdir: /builds/slave/test/build/tests 04:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:55 INFO - trying https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:55 INFO - Downloading https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:41:57 INFO - Downloaded 1325 bytes. 04:41:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:57 INFO - Using the following test package requirements: 04:41:57 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:41:57 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:41:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:41:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:41:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'jsshell-mac.zip'], 04:41:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:41:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:41:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:41:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:41:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:41:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:41:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:41:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:41:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:41:57 INFO - Fetch https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:41:58 INFO - Expected file size: 52519695 04:41:58 INFO - Obtained file size: 52519695 04:42:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:15 INFO - Fetch https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:17 INFO - Expected file size: 52519695 04:42:17 INFO - Obtained file size: 52519695 04:42:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:42:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:32 INFO - Fetch https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:42:33 INFO - Expected file size: 14404138 04:42:33 INFO - Obtained file size: 14404138 04:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:33 INFO - trying https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:33 INFO - Downloading https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:42:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:42:35 INFO - Downloaded 70954656 bytes. 04:42:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:35 INFO - mkdir: /builds/slave/test/properties 04:42:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:35 INFO - Contents: 04:42:35 INFO - build_url:https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:36 INFO - Running post-action listener: _resource_record_post_action 04:42:36 INFO - Running post-action listener: set_extra_try_arguments 04:42:36 INFO - [mozharness: 2017-04-07 11:42:36.527764Z] Finished download-and-extract step (success) 04:42:36 INFO - [mozharness: 2017-04-07 11:42:36.527892Z] Running populate-webroot step. 04:42:36 INFO - Running pre-action listener: _resource_record_pre_action 04:42:36 INFO - Running main action method: populate_webroot 04:42:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:36 INFO - '--tppagecycles', 04:42:36 INFO - '7'], 04:42:36 INFO - 'tests': ['tsvgm']}}, 04:42:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['damp', 'tps']}, 04:42:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'tests': ['damp', 'tps']}, 04:42:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['dromaeo_dom']}, 04:42:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['basic_compositor_video']}, 04:42:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:42:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['a11yr', 04:42:36 INFO - 'ts_paint', 04:42:36 INFO - 'tpaint', 04:42:36 INFO - 'sessionrestore', 04:42:36 INFO - 'sessionrestore_no_auto_restore', 04:42:36 INFO - 'tabpaint']}, 04:42:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:36 INFO - 'ts_paint', 04:42:36 INFO - 'tpaint', 04:42:36 INFO - 'sessionrestore', 04:42:36 INFO - 'sessionrestore_no_auto_restore', 04:42:36 INFO - 'tabpaint']}, 04:42:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:36 INFO - 'ts_paint', 04:42:36 INFO - 'tpaint', 04:42:36 INFO - 'sessionrestore', 04:42:36 INFO - 'sessionrestore_no_auto_restore', 04:42:36 INFO - 'tabpaint']}, 04:42:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:36 INFO - 'ts_paint', 04:42:36 INFO - 'tpaint', 04:42:36 INFO - 'sessionrestore', 04:42:36 INFO - 'sessionrestore_no_auto_restore', 04:42:36 INFO - 'tabpaint']}, 04:42:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['a11yr', 04:42:36 INFO - 'ts_paint', 04:42:36 INFO - 'tpaint', 04:42:36 INFO - 'sessionrestore', 04:42:36 INFO - 'sessionrestore_no_auto_restore', 04:42:36 INFO - 'tabpaint']}, 04:42:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['a11yr', 04:42:36 INFO - 'ts_paint', 04:42:36 INFO - 'tpaint', 04:42:36 INFO - 'sessionrestore', 04:42:36 INFO - 'sessionrestore_no_auto_restore', 04:42:36 INFO - 'tabpaint']}, 04:42:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['tsvgx', 04:42:36 INFO - 'tsvgr_opacity', 04:42:36 INFO - 'tart', 04:42:36 INFO - 'tscrollx', 04:42:36 INFO - 'cart', 04:42:36 INFO - 'tsvg_static']}, 04:42:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:36 INFO - 'tsvgr_opacity', 04:42:36 INFO - 'tart', 04:42:36 INFO - 'tscrollx', 04:42:36 INFO - 'cart', 04:42:36 INFO - 'tsvg_static']}, 04:42:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'talos_options': ['--disable-e10s'], 04:42:36 INFO - 'tests': ['tp5o']}, 04:42:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'talos_options': ['--disable-e10s', 04:42:36 INFO - '--xperf_path', 04:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:36 INFO - 'tests': ['tp5n']}, 04:42:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:36 INFO - 'talos_options': ['--xperf_path', 04:42:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:36 INFO - 'tests': ['tp5n']}}, 04:42:36 INFO - 'talos.zip': {'path': '', 04:42:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:36 INFO - Running post-action listener: _resource_record_post_action 04:42:36 INFO - [mozharness: 2017-04-07 11:42:36.546296Z] Finished populate-webroot step (success) 04:42:36 INFO - [mozharness: 2017-04-07 11:42:36.546413Z] Running create-virtualenv step. 04:42:36 INFO - Running pre-action listener: _resource_record_pre_action 04:42:36 INFO - Running main action method: create_virtualenv 04:42:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:42:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:36 INFO - Using real prefix '/tools/python27' 04:42:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:40 INFO - Installing pip.................done. 04:42:40 INFO - Return code: 0 04:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:40 INFO - Reading from file tmpfile_stdout 04:42:40 INFO - Output received: 04:42:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:42:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42: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', 'pip>=1.5'] in /builds/slave/test/build 04:42: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 pip>=1.5 04:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:41 INFO - 'HOME': '/Users/cltbld', 04:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PAGER': '/bin/cat', 04:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test', 04:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:41 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - 'XPC_FLAGS': '0x0', 04:42:41 INFO - 'XPC_SERVICE_NAME': '0', 04:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:42:41 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:42 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:42 INFO - 'HOME': '/Users/cltbld', 04:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:42 INFO - 'LOGNAME': 'cltbld', 04:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:42 INFO - 'MOZ_NO_REMOTE': '1', 04:42:42 INFO - 'NO_EM_RESTART': '1', 04:42:42 INFO - 'PAGER': '/bin/cat', 04:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:42 INFO - 'PWD': '/builds/slave/test', 04:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:42 INFO - 'SHELL': '/bin/bash', 04:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:42 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:42 INFO - 'USER': 'cltbld', 04:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:42 INFO - 'XPC_FLAGS': '0x0', 04:42:42 INFO - 'XPC_SERVICE_NAME': '0', 04:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:42 INFO - Downloading/unpacking psutil>=3.1.1 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:46 INFO - Installing collected packages: psutil 04:42:46 INFO - Running setup.py install for psutil 04:42:46 INFO - building 'psutil._psutil_osx' extension 04:42:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:42:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:42:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:42:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:42:46 INFO - building 'psutil._psutil_posix' extension 04:42:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:42:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:46 INFO - ^ 04:42:46 INFO - 1 warning generated. 04:42:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:46 INFO - Successfully installed psutil 04:42:46 INFO - Cleaning up... 04:42:47 INFO - Return code: 0 04:42:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:47 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:47 INFO - 'HOME': '/Users/cltbld', 04:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:47 INFO - 'LOGNAME': 'cltbld', 04:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:47 INFO - 'MOZ_NO_REMOTE': '1', 04:42:47 INFO - 'NO_EM_RESTART': '1', 04:42:47 INFO - 'PAGER': '/bin/cat', 04:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:47 INFO - 'PWD': '/builds/slave/test', 04:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:47 INFO - 'SHELL': '/bin/bash', 04:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:47 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:47 INFO - 'USER': 'cltbld', 04:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:47 INFO - 'XPC_FLAGS': '0x0', 04:42:47 INFO - 'XPC_SERVICE_NAME': '0', 04:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:49 INFO - Installing collected packages: mozsystemmonitor 04:42:49 INFO - Running setup.py install for mozsystemmonitor 04:42:50 INFO - Successfully installed mozsystemmonitor 04:42:50 INFO - Cleaning up... 04:42:50 INFO - Return code: 0 04:42:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:50 INFO - 'HOME': '/Users/cltbld', 04:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:50 INFO - 'LOGNAME': 'cltbld', 04:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:50 INFO - 'MOZ_NO_REMOTE': '1', 04:42:50 INFO - 'NO_EM_RESTART': '1', 04:42:50 INFO - 'PAGER': '/bin/cat', 04:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:50 INFO - 'PWD': '/builds/slave/test', 04:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:50 INFO - 'SHELL': '/bin/bash', 04:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:50 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:50 INFO - 'USER': 'cltbld', 04:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:50 INFO - 'XPC_FLAGS': '0x0', 04:42:50 INFO - 'XPC_SERVICE_NAME': '0', 04:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:53 INFO - warning: no files found matching '*.txt' 04:42:53 INFO - no previously-included directories found matching 'build' 04:42:53 INFO - no previously-included directories found matching 'dist' 04:42:53 INFO - no previously-included directories found matching '.git*' 04:42:53 INFO - Installing collected packages: jsonschema, functools32 04:42:53 INFO - Running setup.py install for functools32 04:42:53 INFO - warning: no files found matching '*.txt' 04:42:53 INFO - no previously-included directories found matching 'build' 04:42:53 INFO - no previously-included directories found matching 'dist' 04:42:53 INFO - no previously-included directories found matching '.git*' 04:42:53 INFO - Successfully installed jsonschema functools32 04:42:53 INFO - Cleaning up... 04:42:53 INFO - Return code: 0 04:42:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:53 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:42:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:53 INFO - 'HOME': '/Users/cltbld', 04:42:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:53 INFO - 'LOGNAME': 'cltbld', 04:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:53 INFO - 'MOZ_NO_REMOTE': '1', 04:42:53 INFO - 'NO_EM_RESTART': '1', 04:42:53 INFO - 'PAGER': '/bin/cat', 04:42:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:53 INFO - 'PWD': '/builds/slave/test', 04:42:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:53 INFO - 'SHELL': '/bin/bash', 04:42:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:53 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:53 INFO - 'USER': 'cltbld', 04:42:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:53 INFO - 'XPC_FLAGS': '0x0', 04:42:53 INFO - 'XPC_SERVICE_NAME': '0', 04:42:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:42:54 INFO - Cleaning up... 04:42:54 INFO - Return code: 0 04:42:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:54 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:54 INFO - 'HOME': '/Users/cltbld', 04:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:54 INFO - 'LOGNAME': 'cltbld', 04:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:54 INFO - 'MOZ_NO_REMOTE': '1', 04:42:54 INFO - 'NO_EM_RESTART': '1', 04:42:54 INFO - 'PAGER': '/bin/cat', 04:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:54 INFO - 'PWD': '/builds/slave/test', 04:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:54 INFO - 'SHELL': '/bin/bash', 04:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:54 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:54 INFO - 'USER': 'cltbld', 04:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:54 INFO - 'XPC_FLAGS': '0x0', 04:42:54 INFO - 'XPC_SERVICE_NAME': '0', 04:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:58 INFO - Downloading docopt-0.6.1.tar.gz 04:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:58 INFO - Running setup.py install for blobuploader 04:42:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:58 INFO - Running setup.py install for requests 04:42:58 INFO - Running setup.py install for docopt 04:42:59 INFO - Successfully installed blobuploader requests docopt 04:42:59 INFO - Cleaning up... 04:42:59 INFO - Return code: 0 04:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:59 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:59 INFO - 'HOME': '/Users/cltbld', 04:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:59 INFO - 'LOGNAME': 'cltbld', 04:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:59 INFO - 'MOZ_NO_REMOTE': '1', 04:42:59 INFO - 'NO_EM_RESTART': '1', 04:42:59 INFO - 'PAGER': '/bin/cat', 04:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:59 INFO - 'PWD': '/builds/slave/test', 04:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:59 INFO - 'SHELL': '/bin/bash', 04:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:42:59 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:59 INFO - 'USER': 'cltbld', 04:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:59 INFO - 'XPC_FLAGS': '0x0', 04:42:59 INFO - 'XPC_SERVICE_NAME': '0', 04:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:59 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-SFK5EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:59 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-z2yiBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:59 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-5tzd8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:59 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-2ULu22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:59 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-r85yzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:59 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-55QiaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-QMcsVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-xI7py6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-tlrwQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-nYRQ5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-8OaSYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-jRSKYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-v_TRWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-z3ZcuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:00 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Yz5E2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:01 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-QC1Sas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:01 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-NXgCkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:01 INFO - Running setup.py install for manifestparser 04:43:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:01 INFO - Running setup.py install for mozcrash 04:43:01 INFO - Running setup.py install for mozdebug 04:43:01 INFO - Running setup.py install for mozdevice 04:43:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:01 INFO - Running setup.py install for mozfile 04:43:01 INFO - Running setup.py install for mozhttpd 04:43:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Running setup.py install for mozinfo 04:43:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Running setup.py install for mozInstall 04:43:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Running setup.py install for mozleak 04:43:02 INFO - Running setup.py install for mozlog 04:43:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Running setup.py install for moznetwork 04:43:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:02 INFO - Running setup.py install for mozprocess 04:43:03 INFO - Running setup.py install for mozprofile 04:43:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:03 INFO - Running setup.py install for mozrunner 04:43:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:03 INFO - Running setup.py install for mozscreenshot 04:43:03 INFO - Running setup.py install for moztest 04:43:03 INFO - Running setup.py install for mozversion 04:43:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:03 INFO - Cleaning up... 04:43:03 INFO - Return code: 0 04:43:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:03 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:03 INFO - 'HOME': '/Users/cltbld', 04:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:03 INFO - 'LOGNAME': 'cltbld', 04:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:03 INFO - 'MOZ_NO_REMOTE': '1', 04:43:03 INFO - 'NO_EM_RESTART': '1', 04:43:03 INFO - 'PAGER': '/bin/cat', 04:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:03 INFO - 'PWD': '/builds/slave/test', 04:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:03 INFO - 'SHELL': '/bin/bash', 04:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:43:03 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:03 INFO - 'USER': 'cltbld', 04:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:03 INFO - 'XPC_FLAGS': '0x0', 04:43:03 INFO - 'XPC_SERVICE_NAME': '0', 04:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-2uT5tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-_FTtA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-4BXWa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-OkxlJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-7akOHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-E37Lsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-wlbzy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-kKSnGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:04 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-OPvrUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-R6bFDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-l4nDiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-7NROdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-mbQ4T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Ke2LCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-pn8DgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-UXJKCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:05 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-wulUJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:05 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:05 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:08 INFO - Downloading blessings-1.6.tar.gz 04:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:08 INFO - Installing collected packages: blessings 04:43:08 INFO - Running setup.py install for blessings 04:43:08 INFO - Successfully installed blessings 04:43:08 INFO - Cleaning up... 04:43:08 INFO - Return code: 0 04:43:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:09 INFO - Reading from file tmpfile_stdout 04:43:09 INFO - Current package versions: 04:43:09 INFO - blessings == 1.6 04:43:09 INFO - blobuploader == 1.2.4 04:43:09 INFO - docopt == 0.6.1 04:43:09 INFO - functools32 == 3.2.3-2 04:43:09 INFO - jsonschema == 2.5.1 04:43:09 INFO - manifestparser == 1.1 04:43:09 INFO - mozInstall == 1.12 04:43:09 INFO - mozcrash == 1.0 04:43:09 INFO - mozdebug == 0.1 04:43:09 INFO - mozdevice == 0.50 04:43:09 INFO - mozfile == 1.2 04:43:09 INFO - mozhttpd == 0.7 04:43:09 INFO - mozinfo == 0.9 04:43:09 INFO - mozleak == 0.1 04:43:09 INFO - mozlog == 3.4 04:43:09 INFO - moznetwork == 0.27 04:43:09 INFO - mozprocess == 0.25 04:43:09 INFO - mozprofile == 0.28 04:43:09 INFO - mozrunner == 6.13 04:43:09 INFO - mozscreenshot == 0.1 04:43:09 INFO - mozsystemmonitor == 0.3 04:43:09 INFO - moztest == 0.8 04:43:09 INFO - mozversion == 1.4 04:43:09 INFO - psutil == 3.1.1 04:43:09 INFO - requests == 1.2.3 04:43:09 INFO - wsgiref == 0.1.2 04:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:09 INFO - 'HOME': '/Users/cltbld', 04:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:09 INFO - 'LOGNAME': 'cltbld', 04:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:09 INFO - 'MOZ_NO_REMOTE': '1', 04:43:09 INFO - 'NO_EM_RESTART': '1', 04:43:09 INFO - 'PAGER': '/bin/cat', 04:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:09 INFO - 'PWD': '/builds/slave/test', 04:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:09 INFO - 'SHELL': '/bin/bash', 04:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:43:09 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:09 INFO - 'USER': 'cltbld', 04:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:09 INFO - 'XPC_FLAGS': '0x0', 04:43:09 INFO - 'XPC_SERVICE_NAME': '0', 04:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:09 INFO - Cleaning up... 04:43:09 INFO - Return code: 0 04:43:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 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 0x103fa0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2fa4bb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, '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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:09 INFO - 'HOME': '/Users/cltbld', 04:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:09 INFO - 'LOGNAME': 'cltbld', 04:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:09 INFO - 'MOZ_NO_REMOTE': '1', 04:43:09 INFO - 'NO_EM_RESTART': '1', 04:43:09 INFO - 'PAGER': '/bin/cat', 04:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:09 INFO - 'PWD': '/builds/slave/test', 04:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:09 INFO - 'SHELL': '/bin/bash', 04:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:43:09 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:09 INFO - 'USER': 'cltbld', 04:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:09 INFO - 'XPC_FLAGS': '0x0', 04:43:09 INFO - 'XPC_SERVICE_NAME': '0', 04:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:43:09 INFO - Cleaning up... 04:43:09 INFO - Return code: 0 04:43:09 INFO - Running post-action listener: _resource_record_post_action 04:43:09 INFO - Running post-action listener: _start_resource_monitoring 04:43:09 INFO - Starting resource monitoring. 04:43:09 INFO - [mozharness: 2017-04-07 11:43:09.713072Z] Finished create-virtualenv step (success) 04:43:09 INFO - [mozharness: 2017-04-07 11:43:09.714057Z] Running install step. 04:43:09 INFO - Running pre-action listener: _resource_record_pre_action 04:43:09 INFO - Running main action method: install 04:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:09 INFO - Reading from file tmpfile_stdout 04:43:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:10 INFO - Reading from file tmpfile_stdout 04:43:10 INFO - Output received: 04:43:10 INFO - Usage: mozinstall [options] installer 04:43:10 INFO - Options: 04:43:10 INFO - -h, --help show this help message and exit 04:43:10 INFO - -d DEST, --destination=DEST 04:43:10 INFO - Directory to install application into. [default: 04:43:10 INFO - "/builds/slave/test"] 04:43:10 INFO - --app=APP Application being installed. [default: firefox] 04:43:10 INFO - mkdir: /builds/slave/test/build/application 04:43:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:30 INFO - Reading from file tmpfile_stdout 04:43:30 INFO - Output received: 04:43:30 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:43:30 INFO - Running post-action listener: _resource_record_post_action 04:43:30 INFO - [mozharness: 2017-04-07 11:43:30.040773Z] Finished install step (success) 04:43:30 INFO - [mozharness: 2017-04-07 11:43:30.040904Z] Running run-tests step. 04:43:30 INFO - Running pre-action listener: _resource_record_pre_action 04:43:30 INFO - Running main action method: run_tests 04:43:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:30 INFO - 2017-04-07 04:43:30.055 screenresolution[1886:8890] starting screenresolution argv=screenresolution get 04:43:30 INFO - 2017-04-07 04:43:30.058 screenresolution[1886:8890] Display 0: 1600x1200x32@60 04:43:30 INFO - 2017-04-07 04:43:30.063 screenresolution[1887:8893] starting screenresolution argv=screenresolution list 04:43:30 INFO - Available Modes on Display 0 04:43:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:30 INFO - Intel Iris: 04:43:30 INFO - Chipset Model: Intel Iris 04:43:30 INFO - Type: GPU 04:43:30 INFO - Bus: Built-In 04:43:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:30 INFO - Vendor: Intel (0x8086) 04:43:30 INFO - Device ID: 0x0a2e 04:43:30 INFO - Revision ID: 0x0009 04:43:30 INFO - Displays: 04:43:30 INFO - Display: 04:43:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:30 INFO - Display Serial Number: 1600x1200 60 04:43:30 INFO - Main Display: Yes 04:43:30 INFO - Mirror: Off 04:43:30 INFO - Online: Yes 04:43:30 INFO - Rotation: Supported 04:43:30 INFO - Return code: 0 04:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:30 INFO - Python 2.7.3 04:43:30 INFO - Return code: 0 04:43:30 INFO - grabbing minidump binary from tooltool 04:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:30 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 0x103d7ed30>, '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 0x103ca5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d73be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:43:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:43:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:43:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:30 INFO - Return code: 0 04:43:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:30 INFO - ENV: RUST_BACKTRACE is now 1 04:43:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--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 04:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0245 --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 04:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZoNOT3JxW/Render', 04:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:30 INFO - 'HOME': '/Users/cltbld', 04:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:30 INFO - 'LOGNAME': 'cltbld', 04:43:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:30 INFO - 'MOZ_NO_REMOTE': '1', 04:43:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:30 INFO - 'NO_EM_RESTART': '1', 04:43:30 INFO - 'PAGER': '/bin/cat', 04:43:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:30 INFO - 'PWD': '/builds/slave/test', 04:43:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:30 INFO - 'RUST_BACKTRACE': '1', 04:43:30 INFO - 'SHELL': '/bin/bash', 04:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.67KS8Hi1i7/Listeners', 04:43:30 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 04:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:30 INFO - 'USER': 'cltbld', 04:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:30 INFO - 'XPC_FLAGS': '0x0', 04:43:30 INFO - 'XPC_SERVICE_NAME': '0', 04:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--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 04:43:30 INFO - mozversion application_buildid: 20170407030233 04:43:30 INFO - mozversion application_changeset: 10ea10d9993c9701e5525928257a589dea2c05d8 04:43:30 INFO - mozversion application_display_name: Nightly 04:43:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:30 INFO - mozversion application_name: Firefox 04:43:30 INFO - mozversion application_remotingname: firefox 04:43:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:30 INFO - mozversion application_vendor: Mozilla 04:43:30 INFO - mozversion application_version: 55.0a1 04:43:30 INFO - mozversion platform_buildid: 20170407030233 04:43:30 INFO - mozversion platform_changeset: 10ea10d9993c9701e5525928257a589dea2c05d8 04:43:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:30 INFO - mozversion platform_version: 55.0a1 04:43:30 INFO - using testdate: 1491565410 04:43:30 INFO - actual date: 1491565410 04:43:30 INFO - starting webserver on 'localhost:49421' 04:43:30 INFO - SUITE-START | Running 2 tests 04:43:30 INFO - TEST-START | dromaeo_css 04:43:30 INFO - operating with platform_type : mac_ 04:43:30 INFO - Initialising browser for dromaeo_css test... 04:43:30 INFO - TEST-INFO | started process 1897 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpK9FJfQ/profile http://localhost:49421/getInfo.html) 04:43:34 INFO - PID 1897 | 2017-04-07 04:43:34.021 plugin-container[1900:9058] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 04:43:34 INFO - PID 1897 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:34 INFO - PID 1897 | 2017-04-07 04:43:34.022 plugin-container[1900:9058] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 04:43:34 INFO - PID 1897 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:34 INFO - PID 1897 | 2017-04-07 04:43:34.022 plugin-container[1900:9058] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:34 INFO - PID 1897 | __metrics Screen width/height:1600/1200 04:43:34 INFO - PID 1897 | colorDepth:24 04:43:34 INFO - PID 1897 | Browser inner width/height: 1024/689 04:43:34 INFO - PID 1897 | __metrics 04:43:34 ERROR - PID 1897 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 04:43:35 INFO - TEST-INFO | 1897: exit 0 04:43:35 INFO - Browser initialized. 04:43:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:35 INFO - TEST-INFO | started process 1901 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpK9FJfQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:38 INFO - PID 1901 | 2017-04-07 04:43:38.112 plugin-container[1902:9193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 04:43:38 INFO - PID 1901 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:38 INFO - PID 1901 | 2017-04-07 04:43:38.113 plugin-container[1902:9193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:43:38 INFO - PID 1901 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:38 INFO - PID 1901 | 2017-04-07 04:43:38.113 plugin-container[1902:9193] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:47 INFO - PID 1901 | RSS: Main: 235134976 04:43:47 INFO - PID 1901 | 04:46:52 INFO - PID 1901 | Cycle 1(1): loaded http://localhost:49421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49421/tests/dromaeo/cssquery-ext.html) 04:46:54 INFO - PID 1901 | RSS: Main: 255582208 04:46:54 INFO - PID 1901 | 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | A coding exception was thrown and uncaught in a Task. 04:48:35 INFO - PID 1901 | 04:48:35 ERROR - PID 1901 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:35 INFO - PID 1901 | Full stack: 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | A coding exception was thrown and uncaught in a Task. 04:48:35 INFO - PID 1901 | 04:48:35 ERROR - PID 1901 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:35 INFO - PID 1901 | Full stack: 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | A coding exception was thrown and uncaught in a Task. 04:48:35 INFO - PID 1901 | 04:48:35 ERROR - PID 1901 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:35 INFO - PID 1901 | Full stack: 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | ************************* 04:48:35 INFO - PID 1901 | A coding exception was thrown and uncaught in a Task. 04:48:35 INFO - PID 1901 | 04:48:35 ERROR - PID 1901 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:35 INFO - PID 1901 | Full stack: 04:48:35 INFO - PID 1901 | ************************* 04:49:56 INFO - PID 1901 | Cycle 1(1): loaded http://localhost:49421/tests/dromaeo/cssquery-ext.html (next: http://localhost:49421/tests/dromaeo/cssquery-jquery.html) 04:49:56 INFO - PID 1901 | RSS: Main: 264048640 04:49:56 INFO - PID 1901 | 04:52:58 INFO - PID 1901 | Cycle 1(1): loaded http://localhost:49421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49421/tests/dromaeo/cssquery-mootools.html) 04:52:59 INFO - PID 1901 | RSS: Main: 275230720 04:52:59 INFO - PID 1901 | 04:56:00 INFO - PID 1901 | Cycle 1(1): loaded http://localhost:49421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49421/tests/dromaeo/cssquery-prototype.html) 04:56:01 INFO - PID 1901 | RSS: Main: 267440128 04:56:01 INFO - PID 1901 | 04:59:04 INFO - PID 1901 | Cycle 1(1): loaded http://localhost:49421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49421/tests/dromaeo/cssquery-yui.html) 04:59:05 INFO - PID 1901 | RSS: Main: 277831680 04:59:05 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | Cycle 1(1): loaded http://localhost:49421/tests/dromaeo/cssquery-yui.html (next: http://localhost:49421/tests/dromaeo/cssquery-dojo.html) 05:02:07 INFO - PID 1901 | RSS: Main: 271642624 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | __start_tp_report 05:02:07 INFO - PID 1901 | _x_x_mozilla_page_load 05:02:07 INFO - PID 1901 | _x_x_mozilla_page_load_details 05:02:07 INFO - PID 1901 | |i|pagename|runs| 05:02:07 INFO - PID 1901 | |0;dojo.html;3454.8253593778113;3476.878309259175;3622.728295377846;3629.0745859805747;3663.8900832975005;5531.861703457415;5847.386024467433;6166.568340216176;6245.687715614213;6343.0802533632595;6137.806028951344;6210.192674952261;6253.937460625392;6360;6440.098386225932;5541.806036788713;5593.300837395325;5645.717714114298;5691.459311365414;5743.483086522212;5487.862803429926;5605.663660180382;5720.313562372521;5740.253767010304;5758.251427314443;5440.809571664972;5517.779288828482;5527.585431092684;5612.719364031803;5644.858878528029;5531.308586426697;5540.335159780811;5566.805161819358;5568.1647752837;5610.747516361774;5539.335279766414;5545.362283337387;5557.888842223173;5567.916481252784;5611.2144299798065;6120.357362476921;6145.801568694106;6200.565960382775;6241.65670888101;6317.6209427434505;6868.519203655746;6881.41507971823;6889.931100688979;6896.551724137915;6897.48268879831;6904.516683832134;6947.826304342432;6967.93032069683;6968.024476573284;6976.965115174392;6201.56589038772;6233.812985610439;6361.109444677749;6432.646204458753;6470.741170353227;7092.4680648951535;7117.217106118323;7130.857382852418;7137.785866424016;7160.427165826722;6514.348565143448;6596.307387724316;6609.702563384659;6729.663516824139;6792.403785110495;6809.591424514545;6950.20072691647;6978.476614253951;6986.580805151707;7003.92996070043;6576.901346479806;6640.435562977201;6901.930980690129;6905.620190889549;6912.343327383891;6781.4574834013165;6788.898166527506;6877.3810357068105;6877.690503927335;6910.792676219721;5457.072297709399;5462.808801691922;5470;5485;5522.889542209214;4780.306855506002;4855.368802055781;4864.440589332201;4876.390451193601;4934.6545741798445;5537.224788529609;5977.701114944235;6371.267304259976;6443.162388889508;6453.580517266457;6968.721251149998;6984.650767461607;6990.755323563752;6999.545029573163;7013.859722805515;6471.449926756279;6493.740250389931;6526.902096468557;6543.411093001652;6556.541042127005;5995;6065.514758819372;6071.332153463116;6071.544634152457;6175.96912015437;5954.791582294599;7049.5417797844;7074.610896400542;7100.822479437848;7112.57324560528;6937.445004399535;6954.826129346807;6968.721251149897;6995.685194166173;7002.194747603887;5782.624129431573;5950.940490595039;6883.896741548981;7144.3212894774915;7145.928540714526;6645.1361323027695;6789.1174147360525;6829.351211634887;6871.175458944758;6901.965490172517;5680.517156041783;5892.880352732967;6670.499712521483;6786.59280443175;6995.510314277952;6499.935000649933;6559.376859198369;6611.900821487586;6711.127553418024;6713.731450741916;5969.76120955157;6644.003399490115;6718.798436046926;6755.560888542229;6835.555688880207;6329.9872020476505;6421.454176394872;6467.838304042437;6513.218413790186;6514.315996820265;5686.488216060575;6075.210222671025;6710.926251799884;6740.157480314961;6742.393184613408;6532.5753826001155;6545.901811472927;6550.901736474052;6558.114654521579;6587.0448784926875 05:02:07 INFO - PID 1901 | |1;ext.html;734.5262305812751;756.451572609858;835.6490274084886;1290.8902743266822;1293.4632127667019;36962.81518592407;38182.42726359103;38192.618073819256;38222;38285.808570957175;38218.617813821926;38360.616393836055;38465;38618;38647.42028869562;8073.798155046126;8243.340532757395;8538.573071346407;8816.515091669955;8827.514486703229;8661;8701.695440659578;8779;8791.340649451286;8792;8720.607572659213;8791.428557143798;8806.911930880673;8809.471431714117;8821.911780882174;8737.563121843914;8744.344174186897;8773.990991036017;8779.517126558037;8801.735947921572;8435.325173986066;8512.829743405096;8553.44402613828;8561.272291855199;8566.914330856736;37553.81223093867;37623.62376376256;37804;37849.810750946344;37886;3496.807675577842;3529.770564913272;3530.858765649371;3538.203904121552;3539.681428671406;29655.85172074126;30018;30094;30126.397472050656;30130.698693013008;3047.6190476190477;3109.5957525521762;3114.7196752292175;3155.826429546374;3159.336539326744;233419;236910.4162708611;266748;268423.31576684373;291495;51413.485865141614;51682;51905;51906.48093519092;52001.219981700306;53927.11255106053;53939.92120157575;54408;54417.1837422439;54632;14455.49405770814;14536.636584085483;14589.90575706805;14603;14636.560903172922;11818.113641476924;11973.40132993347;12009.279443233434;12015.759684806255;12052.819207711891;13798.17210967345;13963;13978.930105349611;13980.601939805938;14066.578002659937;6229.657368844757;6253.53098517613;6272.937270627326;6293.96853015732;6297.590656607306;869.26112804116;948.5873644964463;951.6098399656108;1023.8003589300164;1035.6737627647267;21192.15231390727;23242.883785580965;23621.05515779384;23685.54471981168;23764.524709505713;1019.9286049976579;1064.1699474409818;1080.6001779341536;1092.9672109836717;1128.4639796096953;11914.702132446584;12155.20991135591;12203.572874949334;12217.51129954792;12256.938715306367;365437;367042;367229;368675;369152;51997;52261;52595.73702131465;52606;52777.736111319195;1319.4656164253493;1487.970240595182;1520.7034628247607;1535.1633359818925;1547.7153962211337;18606.53483662919;22103.336899893027;23073;23207.3037808866;23578.17476388318;29104.27239319034;36613.81693091518;36835.815820920725;36891;37040.81479592585;325195;325533;325974;326320;326611;32147;33940.83029584836;34595.443205056334;34842.30315393729;34915.65084349124;42061;42125.94685132896;42548.78725606476;42637.14725705531;43590.78204608957;28214.85892570524;29122.12633620995;29684.257893552833;29953.55069673913;30153.793848245823;28663.57004644974;29112.417751645273;29170.124896253146;29700.40599187961;30030.94891678781;32504.674953250164;35108.64891351054;35530.644693552735;35973.64026359703;35983;24285.392865177804;26155.869220653774;29988.35064071497;30182.69817301799;30248.092557223317;23438.64842027405;23572.174973875834;24339.271074010725;24340.634890476304;24422.389440264134 05:02:07 INFO - PID 1901 | |2;jquery.html;409.9815508302126;419.60976292048394;420.9557996410375;423.27197220780255;447.3200734882978;19566.510837229078;21318.786812131875;21974.560508789815;21989.450263743394;22018.889905550448;21039.47401314968;21742.91285435726;22543;22669.319920402373;22738;6228.937710622881;6429.6142231466265;6484.513661475408;6489.805305840809;6495.512836537255;6070.696465176746;6307.432331090201;6376.2667293261175;6389.488840892717;6399.200099987502;6139.355367686396;6313.863504569175;6317.652529110897;6357.777477788279;6359.395857393541;6203.565750397474;6344.206974128234;6347.428731414148;6352.142460767784;6361.491080713532;5559.305086864142;5607.271054762896;5662.688552129631;5668.801591944262;5671.801486947978;26731;26732.732672673217;26846.328841778915;26992.32519187036;27096.91612335504;1950.619629172312;2236.105557776886;2242.843000989931;2243.9439014024615;2247.797698207169;17263.30946762128;17317;17466.301347946068;17845.286188552443;17902.820971790246;2065.9070341834504;2067.5968186203695;2128.563644452899;2132.093860109447;2136.380449669594;134403;134945.32527337302;134985;135662.999999999;136173.3191334047;12495.500179992698;12751.107422480338;12932.288724120264;12941.347023860086;12944.288064156563;16408.343666253455;16455.506334809976;16483.6703265934;16488.25802838875;16507.174641267888;8801.91198088011;8886;9014.18872301496;9033.728988130235;9139.360244782802;8564.100769419247;8578.01352844431;8593.871091933626;8743.256823169975;8753.47479151253;7745.341645960044;7891.171427000082;7921;7921;7940.325072368798;1926.9614607707767;2059.341010876535;2118.428024433425;2147.1411435425953;2147.6671115977047;875.7635438431588;933.715216858851;939.7603611079268;950.7337945375306;994.4033579852031;20073.598528029357;21273.574528509653;21444.78555214428;21472.083999541697;21711.457213569473;975.4196253229317;980.6959842448864;1013.8986101389802;1028.9691309260734;1032;8852.424592401474;9856.408615483095;11041;11128.833067503994;11178.44107794607;650543;657943;660167;665669;667449;130641;151451;154220.22889885478;154494;157667;1092.2954694222183;1169.976600468003;1183.6981569699672;1229.7171650520431;1235.184778046485;17349;18065.00642464677;20432.182712691327;21528.569428611027;22214.66677999799;61460;61639.38360616516;61916.69041654763;62101;62176;72936;81822;82164.3567128666;83807;83939.16060839557;7500.962495187708;8528.061913189667;8720.738377848675;8788.560571971248;8859.51272679983;11801.52793888235;13404.463821447032;13964.092333998258;14050.859491405365;14131.505397311044;9694.545818127337;11353.86461353858;11769.293842369485;11813.586524471602;12123.393830308272;8766.912330876865;11146.777064458827;11217;11439.828402573801;11461.764955833532;11683.299002059903;11801.881981180079;12058.819117713418;12104.515819367127;12214.938925305316;7742.496737712031;8708.897678692687;8711.782205444915;8764.553848614907;8943.329250306384;9554.474503902353;11416.31502109876;11583.478743456733;11614.593489228175;11975.520979160736 05:02:07 INFO - PID 1901 | |3;mootools.html;1405.8734713875751;1450.0574626492778;1467.1050659097955;1479.3342995651954;1484.2430360516134;11059.834102488468;11211.710653274877;11529.942350288247;11842.644720658394;12162.878371216286;11819.527218911233;11994.580189693363;12047.51809927604;12156.33140177292;12162.878371216286;2496.10140349474;2529.203300960201;2544.9872750636223;2557.7314381989904;2562.3209849389928;2461.1509029384924;2466.9259922202364;2507.4107584717576;2516.937076573091;2520.092766604021;2442.6702395176603;2499.450120973383;2503.574392353304;2514.346269969812;2522.9403650466847;2427.0413186791206;2490.8256422050463;2497.512984967932;2499.9250022499355;2501.062101711858;2343.8945247463903;2452.6934133233344;2486.204414587333;2500.237427584586;2507;9895.554700038516;11801.114916381306;11898.345590992492;11988.28070315775;11999.64001079969;6623.602583844937;6893.75871844488;6896.448284137307;6910.170779506441;6925.58446493212;4100;4378.715383500063;4444.444444444444;4469.463664360265;4488.3940668010055;1232.6548566401423;1237.1031002523098;1264.6648638110908;1279.8976081913518;1284.78158713019;14936;15553.22233888301;16363.918180409022;16519.33922643093;16568;5474.288342515448;5625;5877.38287479817;5886.3230728465915;5911.290645122527;12271.938640306742;12316.630501084981;12326.445309961073;12352.25886446816;12383.947364474121;6637.103990961158;6645.936650136052;6656.400923916871;6658.067870498134;6663.533552651268;6105.45050945417;6145.139680444741;6188.721507532082;6233.594816336924;6243.344448832898;4390.100029493946;4427.845025424094;4502.234620114588;4529.456465224194;4533.637309015271;1097.4567589043475;1274.6176147155816;1292.65744577687;1301.8633043530292;1313.9868601313865;597.4413922982026;711.8113699869435;732.4030914804417;737.8081698758255;755.0750330844671;5533.865557560771;6147.754089836357;6784.525083244224;7021.719131234693;7241.456890733216;895.9955200223957;898.5641963647626;904.5748498205833;929.1544694328129;934.1592566690033;4076.3477843544892;4153.252414565347;4309.030468144642;4337.934930976038;4367.912641747147;14786;15393.23033848303;15404;15416.922915385576;15461.5361539154;14864.108153510824;15014.47449339268;15191.392344306105;15234.162121083225;15385.846141538665;10914.290571112851;11020.669379918616;11066.612668556723;11163.609273675382;11270.661880143609;6386.87226255463;6621.702023408862;6824.351686589766;7048.964755176191;7109.644517774194;11006.614768483065;12850.871491284968;13138.737225255632;13182.472701091849;13263.668408289484;13146.671333216746;13325.466981321026;13491.595252142451;13550.457981680622;13628.454861805416;8720.389572729848;8729.127087291221;8754.387192896436;8800.427972181787;8802.95598522029;10622.628208012682;10666.093382062612;10759.569617215537;10799.136069114295;10819.621313253998;9081.68214112503;9112.225460835904;9145.954270228607;9195.21840643526;9246.121618446237;8916.465012099296;8993.235574975939;9068.319876009195;9079.954600226956;9121.270298375981;7976.242256985577;8029.919700802917;8052.154523775153;8105.432619716563;8153.388495862952;5601.327840659147;5847.561432892465;5892.322382926019;6009.429104235091;6148.016317389196;5929.940700592939;5979.103134529855;6148.692565371803;6159.29168145669;6268.623882567061 05:02:07 INFO - PID 1901 | |4;prototype.html;344.73455439311715;347.4527619000074;356.55964883369035;380.34200832559674;406.1592503517718;6169.691515424233;6286.402791734778;6423.229212494502;6467.385598368153;6489.80530584082;6113.2664080310315;6158.1994340735755;6227.252729672446;6288.434040936315;6301.6534090625;3983.9004024899464;4391.49497807753;4575;4741.502142275063;4834.758262086899;4556.179887620227;4600.240960241573;4778.952210477885;4787;4791.520847915215;3689.631036896316;3780.432935059749;3908.2183563287313;4761.262004389325;4761.690490118149;3903.4340020697123;4316.503602085753;4638.930416043779;4770.594499467549;4788.688735232199;3245.1917092770113;4225.873223803291;4234.343676730112;4236.491621005468;4271.145770845812;5320.6275560710765;5942.257217847769;6168.599041062316;6175.980963141076;6198.845028874269;4938.432080310774;5652.943470565324;5693.238779192088;5706.915686019643;5730.971345143247;5783.277090363705;6363.059266923587;6657.833554161185;6706.9329306706795;6718.764843230512;4412.338149277602;4827.396575428072;4831.371921650198;4849.248366503198;4850.054239423313;6349.555531112777;6884.311568843075;7092.397146242575;7132.821679458003;7248.311410416002;3775.4714339992424;4274.380214868889;4387.802548885308;4966.95693904277;4976.62675299354;4838.685485443435;5080.196530231715;5082.74586270685;5088.753255452438;5100.209467532539;4911.287863259879;4927.240745182709;5021.899562008739;5370.758315875795;5694.743736531866;5949.8215053548465;6026.21659184312;6052.878942421127;6785;6867.656617169122;1711.9058451785022;1725.4996051145279;1728.8616910647117;1738.7304967730022;1745.092551873019;1131.1685910855515;1192.5706745571588;1194.5699548162654;1201.2612243470203;1207.9094067944939;5359.946400536022;6369;6382.393672601095;6396.776112836028;6399.168108145911;5488.91766623501;6012.033931741944;6955.095837541087;6956;6980.616066116311;4897.926531102036;5146.716930568855;5672.681481333466;6317.009562445616;6397.552171347961;3088.4286407014324;3503.8773642922374;3619.1314084619503;3647.2340808429994;3661.8901432957055;5915.556333275022;5954.612950158225;6783.762568310085;7141.464390170758;7160.57036577807;6822.351876571718;6997.300269973064;7083.220845706968;7137.571745695275;7176.7846964591145;6323.652199129;7049.801533739379;7206;7214.96392518034;7233.746818861315;6645.667716614246;6911.481638877004;6954.3393377629045;6998.6150761708595;7049.506534542533;5329.253904453302;5802.332731735735;6281;6516.543841931209;6885.862282754417;6546.509011824037;7205.567665940061;7243.891341629775;7260.346568808833;7292.635368231461;3891.6497515223764;4334.371516130081;4886.849786094107;4919.1883339248625;4929.482404347636;6946.548474349152;6948.922916947881;6985.301469852974;7024;7027.718891244497;5500.477454641803;6368.42684158428;6624.271330153776;6668.6665666717445;6709.295523969913;5708.857278568069;5830.82507524775;6705.865882682417;6720.932790672031;6743.797686069426;5605.775768969195;6143.477804386677;6489.1447762984135;6551.967240163769;6583.44040756541;6707.061011458302;6722.663866806738;6739.73041078371;6757.526973111835;6765.5305813378745;5146.742662866767;5884.617499862496;6395.328490508429;6479.838004049937;6544.8363790905605 05:02:07 INFO - PID 1901 | |5;yui.html;701.9684114214859;730.7150211417545;756.8344749086407;839.7019058234326;840.3865178419755;15663.765043524341;15713.685726285481;15794.684106317896;15953.361865525365;15971.92014039931;14406.135631862096;14486;14717.484888028921;14746.63133421665;15110.244487775622;910.2399496420497;935.4013431403873;939.4926739560664;942.7690215897114;945.42801605029;954.4034978138664;960.0447554683066;960.2605993385089;960.3901522533207;961.0485619236975;1019.6278358399205;1024.2778840917135;1024.472396715692;1024.923130765192;1027.1012863744224;1007.9546420411062;1018.2871989607268;1020.5611587017579;1021.4177918586446;1022.2180032275315;746.8431629357841;749.3368368993425;751.3726038757644;752.578556008637;752.9962350188214;14013.089149205269;14131.010829241957;14743.557693269218;14870.330835112338;14888.330025148785;10132.632094667199;11597.884021159849;11630.592929247521;11723.062155027577;11867.52529898803;11794.05647548194;11929.522819087226;14206.289685515683;14935.477258296016;15023.474178403703;4976.651634385595;5005.848654809378;5029.270755740434;5052.191649336125;5091.541761241469;96865.5156724219;100424.49787751088;102204.48897755463;102733.43166420824;105704;9752.366096203725;10939.445191177407;11496.42517874103;11649.825252621218;11925.880741192477;21365.359039228537;22121.44696382571;22907.42731431694;24157.396065098514;24741.381465463506;6816.591004539743;7753.147153813076;7835.608219588998;7989.7203597873795;8122.318184763025;3496.860125594948;3663.780173189617;4130.459767243124;4135.152293779768;4212.262854000599;4168.228877657643;4228.556001619786;4256.127493863751;4270.231358355463;4272.5086615039045;942.2273735536794;946.8390373636498;948.5541795356172;948.8197242523898;951.7192428233687;517.2551525802832;620.8758248350258;622.1290193728726;637.5791977295056;639.6567208861354;9923.553440095213;10040.297179197387;10045.525487790886;10089.697309080739;10116.645917392856;604.8608819971344;622.6450922973861;625.1654041854085;635.9141515895387;664.3024823934849;4143.56492568282;4553.134904368159;4745.881352966204;4747.240441529408;4769.189237829577;82132;93197;94962.52518737363;96180;97337;81937;83624.58187709023;84193;84870.57564712137;86395.13604863996;72412;73622;73919.52160956751;74228;75371.24628753752;10639.673696776637;10679;11003.724906877072;11018.669439916815;11069.667909962393;27721.584176237775;37381.439278410304;38639.613603864724;39030.80484597559;39701.602983970944;40110;51134.74432627813;51888.221676674126;52017;52706.20940685969;13027;13533.661658458224;13574.59276221715;13660.658483537594;14018.509352172625;12634.810477843024;12827.551035713705;14132.646683832987;14156.433742650179;14731.852681473476;11115.72210694739;12973.870261297267;13087.607371778862;13434.798478023033;13840.723185536433;13427.395767190696;13465.461381544628;13867.583972480841;13888.027838051239;14171;13102.017348699077;13126.737465250451;13315.800262996256;13334;13948.79076813869;9209.677661281823;9241.584128714358;9574.664886728931;9634.373765705206;10103.595856165965;9964.55159517838;10902.484552650667;11019.559217631526;11095.889041109485;11096.278741881752 05:02:07 INFO - PID 1901 | __end_tp_report 05:02:07 INFO - PID 1901 | __start_cc_report 05:02:07 INFO - PID 1901 | _x_x_mozilla_cycle_collect,436 05:02:07 INFO - PID 1901 | __end_cc_report 05:02:07 INFO - PID 1901 | __startTimestamp1491566527945__endTimestamp 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | ------- Summary: start ------- 05:02:07 INFO - PID 1901 | Number of tests: 6 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | [#0] dojo.html Cycles:165 Average:6269.95 Median:6493.74 stddev:755.30 (11.6%) stddev-sans-first:724.61 05:02:07 INFO - PID 1901 | Values: 3454.8 3476.9 3622.7 3629.1 3663.9 5531.9 5847.4 6166.6 6245.7 6343.1 6137.8 6210.2 6253.9 6360.0 6440.1 5541.8 5593.3 5645.7 5691.5 5743.5 5487.9 5605.7 5720.3 5740.3 5758.3 5440.8 5517.8 5527.6 5612.7 5644.9 5531.3 5540.3 5566.8 5568.2 5610.7 5539.3 5545.4 5557.9 5567.9 5611.2 6120.4 6145.8 6200.6 6241.7 6317.6 6868.5 6881.4 6889.9 6896.6 6897.5 6904.5 6947.8 6967.9 6968.0 6977.0 6201.6 6233.8 6361.1 6432.6 6470.7 7092.5 7117.2 7130.9 7137.8 7160.4 6514.3 6596.3 6609.7 6729.7 6792.4 6809.6 6950.2 6978.5 6986.6 7003.9 6576.9 6640.4 6901.9 6905.6 6912.3 6781.5 6788.9 6877.4 6877.7 6910.8 5457.1 5462.8 5470.0 5485.0 5522.9 4780.3 4855.4 4864.4 4876.4 4934.7 5537.2 5977.7 6371.3 6443.2 6453.6 6968.7 6984.7 6990.8 6999.5 7013.9 6471.4 6493.7 6526.9 6543.4 6556.5 5995.0 6065.5 6071.3 6071.5 6176.0 5954.8 7049.5 7074.6 7100.8 7112.6 6937.4 6954.8 6968.7 6995.7 7002.2 5782.6 5950.9 6883.9 7144.3 7145.9 6645.1 6789.1 6829.4 6871.2 6902.0 5680.5 5892.9 6670.5 6786.6 6995.5 6499.9 6559.4 6611.9 6711.1 6713.7 5969.8 6644.0 6718.8 6755.6 6835.6 6330.0 6421.5 6467.8 6513.2 6514.3 5686.5 6075.2 6710.9 6740.2 6742.4 6532.6 6545.9 6550.9 6558.1 6587.0 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | [#1] ext.html Cycles:180 Average:46446.40 Median:19206.23 stddev:84520.15 (440.1%) stddev-sans-first:84687.57 05:02:07 INFO - PID 1901 | Values: 734.5 756.5 835.6 1290.9 1293.5 36962.8 38182.4 38192.6 38222.0 38285.8 38218.6 38360.6 38465.0 38618.0 38647.4 8073.8 8243.3 8538.6 8816.5 8827.5 8661.0 8701.7 8779.0 8791.3 8792.0 8720.6 8791.4 8806.9 8809.5 8821.9 8737.6 8744.3 8774.0 8779.5 8801.7 8435.3 8512.8 8553.4 8561.3 8566.9 37553.8 37623.6 37804.0 37849.8 37886.0 3496.8 3529.8 3530.9 3538.2 3539.7 29655.9 30018.0 30094.0 30126.4 30130.7 3047.6 3109.6 3114.7 3155.8 3159.3 233419.0 236910.4 266748.0 268423.3 291495.0 51413.5 51682.0 51905.0 51906.5 52001.2 53927.1 53939.9 54408.0 54417.2 54632.0 14455.5 14536.6 14589.9 14603.0 14636.6 11818.1 11973.4 12009.3 12015.8 12052.8 13798.2 13963.0 13978.9 13980.6 14066.6 6229.7 6253.5 6272.9 6294.0 6297.6 869.3 948.6 951.6 1023.8 1035.7 21192.2 23242.9 23621.1 23685.5 23764.5 1019.9 1064.2 1080.6 1093.0 1128.5 11914.7 12155.2 12203.6 12217.5 12256.9 365437.0 367042.0 367229.0 368675.0 369152.0 51997.0 52261.0 52595.7 52606.0 52777.7 1319.5 1488.0 1520.7 1535.2 1547.7 18606.5 22103.3 23073.0 23207.3 23578.2 29104.3 36613.8 36835.8 36891.0 37040.8 325195.0 325533.0 325974.0 326320.0 326611.0 32147.0 33940.8 34595.4 34842.3 34915.7 42061.0 42125.9 42548.8 42637.1 43590.8 28214.9 29122.1 29684.3 29953.6 30153.8 28663.6 29112.4 29170.1 29700.4 30030.9 32504.7 35108.6 35530.6 35973.6 35983.0 24285.4 26155.9 29988.4 30182.7 30248.1 23438.6 23572.2 24339.3 24340.6 24422.4 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | [#2] jquery.html Cycles:180 Average:38864.94 Median:22606.16 stddev:110554.53 (489.0%) stddev-sans-first:110826.96 05:02:07 INFO - PID 1901 | Values: 410.0 419.6 421.0 423.3 447.3 19566.5 21318.8 21974.6 21989.5 22018.9 21039.5 21742.9 22543.0 22669.3 22738.0 6228.9 6429.6 6484.5 6489.8 6495.5 6070.7 6307.4 6376.3 6389.5 6399.2 6139.4 6313.9 6317.7 6357.8 6359.4 6203.6 6344.2 6347.4 6352.1 6361.5 5559.3 5607.3 5662.7 5668.8 5671.8 26731.0 26732.7 26846.3 26992.3 27096.9 1950.6 2236.1 2242.8 2243.9 2247.8 17263.3 17317.0 17466.3 17845.3 17902.8 2065.9 2067.6 2128.6 2132.1 2136.4 134403.0 134945.3 134985.0 135663.0 136173.3 12495.5 12751.1 12932.3 12941.3 12944.3 16408.3 16455.5 16483.7 16488.3 16507.2 8801.9 8886.0 9014.2 9033.7 9139.4 8564.1 8578.0 8593.9 8743.3 8753.5 7745.3 7891.2 7921.0 7921.0 7940.3 1927.0 2059.3 2118.4 2147.1 2147.7 875.8 933.7 939.8 950.7 994.4 20073.6 21273.6 21444.8 21472.1 21711.5 975.4 980.7 1013.9 1029.0 1032.0 8852.4 9856.4 11041.0 11128.8 11178.4 650543.0 657943.0 660167.0 665669.0 667449.0 130641.0 151451.0 154220.2 154494.0 157667.0 1092.3 1170.0 1183.7 1229.7 1235.2 17349.0 18065.0 20432.2 21528.6 22214.7 61460.0 61639.4 61916.7 62101.0 62176.0 72936.0 81822.0 82164.4 83807.0 83939.2 7501.0 8528.1 8720.7 8788.6 8859.5 11801.5 13404.5 13964.1 14050.9 14131.5 9694.5 11353.9 11769.3 11813.6 12123.4 8766.9 11146.8 11217.0 11439.8 11461.8 11683.3 11801.9 12058.8 12104.5 12214.9 7742.5 8708.9 8711.8 8764.6 8943.3 9554.5 11416.3 11583.5 11614.6 11975.5 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | [#3] mootools.html Cycles:180 Average:7187.88 Median:2537.10 stddev:4515.31 (178.0%) stddev-sans-first:4507.07 05:02:07 INFO - PID 1901 | Values: 1405.9 1450.1 1467.1 1479.3 1484.2 11059.8 11211.7 11529.9 11842.6 12162.9 11819.5 11994.6 12047.5 12156.3 12162.9 2496.1 2529.2 2545.0 2557.7 2562.3 2461.2 2466.9 2507.4 2516.9 2520.1 2442.7 2499.5 2503.6 2514.3 2522.9 2427.0 2490.8 2497.5 2499.9 2501.1 2343.9 2452.7 2486.2 2500.2 2507.0 9895.6 11801.1 11898.3 11988.3 11999.6 6623.6 6893.8 6896.4 6910.2 6925.6 4100.0 4378.7 4444.4 4469.5 4488.4 1232.7 1237.1 1264.7 1279.9 1284.8 14936.0 15553.2 16363.9 16519.3 16568.0 5474.3 5625.0 5877.4 5886.3 5911.3 12271.9 12316.6 12326.4 12352.3 12383.9 6637.1 6645.9 6656.4 6658.1 6663.5 6105.5 6145.1 6188.7 6233.6 6243.3 4390.1 4427.8 4502.2 4529.5 4533.6 1097.5 1274.6 1292.7 1301.9 1314.0 597.4 711.8 732.4 737.8 755.1 5533.9 6147.8 6784.5 7021.7 7241.5 896.0 898.6 904.6 929.2 934.2 4076.3 4153.3 4309.0 4337.9 4367.9 14786.0 15393.2 15404.0 15416.9 15461.5 14864.1 15014.5 15191.4 15234.2 15385.8 10914.3 11020.7 11066.6 11163.6 11270.7 6386.9 6621.7 6824.4 7049.0 7109.6 11006.6 12850.9 13138.7 13182.5 13263.7 13146.7 13325.5 13491.6 13550.5 13628.5 8720.4 8729.1 8754.4 8800.4 8803.0 10622.6 10666.1 10759.6 10799.1 10819.6 9081.7 9112.2 9146.0 9195.2 9246.1 8916.5 8993.2 9068.3 9080.0 9121.3 7976.2 8029.9 8052.2 8105.4 8153.4 5601.3 5847.6 5892.3 6009.4 6148.0 5929.9 5979.1 6148.7 6159.3 6268.6 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | [#4] prototype.html Cycles:180 Average:5403.87 Median:5928.91 stddev:1672.14 (28.2%) stddev-sans-first:1633.15 05:02:07 INFO - PID 1901 | Values: 344.7 347.5 356.6 380.3 406.2 6169.7 6286.4 6423.2 6467.4 6489.8 6113.3 6158.2 6227.3 6288.4 6301.7 3983.9 4391.5 4575.0 4741.5 4834.8 4556.2 4600.2 4779.0 4787.0 4791.5 3689.6 3780.4 3908.2 4761.3 4761.7 3903.4 4316.5 4638.9 4770.6 4788.7 3245.2 4225.9 4234.3 4236.5 4271.1 5320.6 5942.3 6168.6 6176.0 6198.8 4938.4 5652.9 5693.2 5706.9 5731.0 5783.3 6363.1 6657.8 6706.9 6718.8 4412.3 4827.4 4831.4 4849.2 4850.1 6349.6 6884.3 7092.4 7132.8 7248.3 3775.5 4274.4 4387.8 4967.0 4976.6 4838.7 5080.2 5082.7 5088.8 5100.2 4911.3 4927.2 5021.9 5370.8 5694.7 5949.8 6026.2 6052.9 6785.0 6867.7 1711.9 1725.5 1728.9 1738.7 1745.1 1131.2 1192.6 1194.6 1201.3 1207.9 5359.9 6369.0 6382.4 6396.8 6399.2 5488.9 6012.0 6955.1 6956.0 6980.6 4897.9 5146.7 5672.7 6317.0 6397.6 3088.4 3503.9 3619.1 3647.2 3661.9 5915.6 5954.6 6783.8 7141.5 7160.6 6822.4 6997.3 7083.2 7137.6 7176.8 6323.7 7049.8 7206.0 7215.0 7233.7 6645.7 6911.5 6954.3 6998.6 7049.5 5329.3 5802.3 6281.0 6516.5 6885.9 6546.5 7205.6 7243.9 7260.3 7292.6 3891.6 4334.4 4886.8 4919.2 4929.5 6946.5 6948.9 6985.3 7024.0 7027.7 5500.5 6368.4 6624.3 6668.7 6709.3 5708.9 5830.8 6705.9 6720.9 6743.8 5605.8 6143.5 6489.1 6552.0 6583.4 6707.1 6722.7 6739.7 6757.5 6765.5 5146.7 5884.6 6395.3 6479.8 6544.8 05:02:07 INFO - PID 1901 | 05:02:07 INFO - PID 1901 | [#5] yui.html Cycles:180 Average:19012.87 Median:38010.53 stddev:26673.70 (70.2%) stddev-sans-first:26713.10 05:02:07 INFO - PID 1901 | Values: 702.0 730.7 756.8 839.7 840.4 15663.8 15713.7 15794.7 15953.4 15971.9 14406.1 14486.0 14717.5 14746.6 15110.2 910.2 935.4 939.5 942.8 945.4 954.4 960.0 960.3 960.4 961.0 1019.6 1024.3 1024.5 1024.9 1027.1 1008.0 1018.3 1020.6 1021.4 1022.2 746.8 749.3 751.4 752.6 753.0 14013.1 14131.0 14743.6 14870.3 14888.3 10132.6 11597.9 11630.6 11723.1 11867.5 11794.1 11929.5 14206.3 14935.5 15023.5 4976.7 5005.8 5029.3 5052.2 5091.5 96865.5 100424.5 102204.5 102733.4 105704.0 9752.4 10939.4 11496.4 11649.8 11925.9 21365.4 22121.4 22907.4 24157.4 24741.4 6816.6 7753.1 7835.6 7989.7 8122.3 3496.9 3663.8 4130.5 4135.2 4212.3 4168.2 4228.6 4256.1 4270.2 4272.5 942.2 946.8 948.6 948.8 951.7 517.3 620.9 622.1 637.6 639.7 9923.6 10040.3 10045.5 10089.7 10116.6 604.9 622.6 625.2 635.9 664.3 4143.6 4553.1 4745.9 4747.2 4769.2 82132.0 93197.0 94962.5 96180.0 97337.0 81937.0 83624.6 84193.0 84870.6 86395.1 72412.0 73622.0 73919.5 74228.0 75371.2 10639.7 10679.0 11003.7 11018.7 11069.7 27721.6 37381.4 38639.6 39030.8 39701.6 40110.0 51134.7 51888.2 52017.0 52706.2 13027.0 13533.7 13574.6 13660.7 14018.5 12634.8 12827.6 14132.6 14156.4 14731.9 11115.7 12973.9 13087.6 13434.8 13840.7 13427.4 13465.5 13867.6 13888.0 14171.0 13102.0 13126.7 13315.8 13334.0 13948.8 9209.7 9241.6 9574.7 9634.4 10103.6 9964.6 10902.5 11019.6 11095.9 11096.3 05:02:07 INFO - PID 1901 | -------- Summary: end -------- 05:02:07 INFO - PID 1901 | 05:02:08 INFO - TEST-INFO | 1901: exit 0 05:02:08 INFO - TEST-OK | dromaeo_css | took 1118008ms 05:02:08 INFO - TEST-START | kraken 05:02:08 INFO - operating with platform_type : mac_ 05:02:08 INFO - Initialising browser for kraken test... 05:02:08 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpVGE2u8/profile http://localhost:49421/getInfo.html) 05:02:11 INFO - PID 1908 | 2017-04-07 05:02:11.591 plugin-container[1910:11286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 05:02:11 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:02:11 INFO - PID 1908 | 2017-04-07 05:02:11.591 plugin-container[1910:11286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 05:02:11 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:02:11 INFO - PID 1908 | 2017-04-07 05:02:11.592 plugin-container[1910:11286] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:02:11 INFO - PID 1908 | __metrics Screen width/height:1600/1200 05:02:11 INFO - PID 1908 | colorDepth:24 05:02:11 INFO - PID 1908 | Browser inner width/height: 1024/689 05:02:11 INFO - PID 1908 | __metrics 05:02:11 ERROR - PID 1908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 05:02:12 INFO - TEST-INFO | 1908: exit 0 05:02:12 INFO - Browser initialized. 05:02:12 INFO - Running cycle 1/1 for kraken test... 05:02:12 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpVGE2u8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:15 INFO - PID 1911 | 2017-04-07 05:02:15.495 plugin-container[1912:11415] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 05:02:15 INFO - PID 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:02:15 INFO - PID 1911 | 2017-04-07 05:02:15.495 plugin-container[1912:11415] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 05:02:15 INFO - PID 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:02:15 INFO - PID 1911 | 2017-04-07 05:02:15.495 plugin-container[1912:11415] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:02:25 INFO - PID 1911 | RSS: Main: 233820160 05:02:25 INFO - PID 1911 | 05:02:28 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49421/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:29 INFO - PID 1911 | RSS: Main: 248635392 05:02:29 INFO - PID 1911 | 05:02:32 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49421/tests/kraken/driver.html?testName=audio-dft) 05:02:32 INFO - PID 1911 | RSS: Main: 257085440 05:02:32 INFO - PID 1911 | 05:02:36 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49421/tests/kraken/driver.html?testName=audio-fft) 05:02:37 INFO - PID 1911 | RSS: Main: 259600384 05:02:37 INFO - PID 1911 | 05:02:39 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49421/tests/kraken/driver.html?testName=audio-oscillator) 05:02:39 INFO - PID 1911 | RSS: Main: 260464640 05:02:39 INFO - PID 1911 | 05:02:41 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:42 INFO - PID 1911 | RSS: Main: 260861952 05:02:42 INFO - PID 1911 | 05:02:45 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49421/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:46 INFO - PID 1911 | RSS: Main: 267657216 05:02:46 INFO - PID 1911 | 05:02:49 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49421/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:50 INFO - PID 1911 | RSS: Main: 268627968 05:02:50 INFO - PID 1911 | 05:02:53 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49421/tests/kraken/driver.html?testName=json-parse-financial) 05:02:54 INFO - PID 1911 | RSS: Main: 268390400 05:02:54 INFO - PID 1911 | 05:02:55 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:56 INFO - PID 1911 | RSS: Main: 267788288 05:02:56 INFO - PID 1911 | 05:02:58 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:59 INFO - PID 1911 | RSS: Main: 267755520 05:02:59 INFO - PID 1911 | 05:03:01 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:02 INFO - PID 1911 | RSS: Main: 267800576 05:03:02 INFO - PID 1911 | 05:03:05 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:06 INFO - PID 1911 | RSS: Main: 268197888 05:03:06 INFO - PID 1911 | 05:03:09 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:10 INFO - PID 1911 | RSS: Main: 265330688 05:03:10 INFO - PID 1911 | 05:03:11 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:49421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49421/tests/kraken/driver.html?testName=ai-astar) 05:03:12 INFO - PID 1911 | RSS: Main: 268726272 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | __start_tp_report 05:03:12 INFO - PID 1911 | _x_x_mozilla_page_load 05:03:12 INFO - PID 1911 | _x_x_mozilla_page_load_details 05:03:12 INFO - PID 1911 | |i|pagename|runs| 05:03:12 INFO - PID 1911 | |0;ai-astar;119;151;157;191;192;126;124;140;113;144 05:03:12 INFO - PID 1911 | |1;audio-beat-detection;150;118;120;158;125;156;137;116;140;155 05:03:12 INFO - PID 1911 | |2;audio-dft;222;237;316;257;200;299;287;208;214;213 05:03:12 INFO - PID 1911 | |3;audio-fft;74;74;58;123;92;88;53;81;109;76 05:03:12 INFO - PID 1911 | |4;audio-oscillator;88;74;89;75;74;71;89;71;74;124 05:03:12 INFO - PID 1911 | |5;imaging-gaussian-blur;118;135;98;108;100;142;136;89;89;108 05:03:12 INFO - PID 1911 | |6;imaging-darkroom;103;103;104;105;103;132;101;106;101;103 05:03:12 INFO - PID 1911 | |7;imaging-desaturate;102;106;104;107;108;164;102;111;100;104 05:03:12 INFO - PID 1911 | |8;json-parse-financial;53;52;54;52;54;53;53;53;54;53 05:03:12 INFO - PID 1911 | |9;json-stringify-tinderbox;60;81;87;97;96;61;61;60;59;60 05:03:12 INFO - PID 1911 | |10;stanford-crypto-aes;89;89;88;98;114;115;86;87;87;87 05:03:12 INFO - PID 1911 | |11;stanford-crypto-ccm;154;171;171;161;163;161;184;160;199;166 05:03:12 INFO - PID 1911 | |12;stanford-crypto-pbkdf2;205;195;195;206;197;234;264;194;264;213 05:03:12 INFO - PID 1911 | |13;stanford-crypto-sha256-iterative;71;72;75;72;69;86;88;73;69;74 05:03:12 INFO - PID 1911 | __end_tp_report 05:03:12 INFO - PID 1911 | __start_cc_report 05:03:12 INFO - PID 1911 | _x_x_mozilla_cycle_collect,1026 05:03:12 INFO - PID 1911 | __end_cc_report 05:03:12 INFO - PID 1911 | __startTimestamp1491566592163__endTimestamp 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | ------- Summary: start ------- 05:03:12 INFO - PID 1911 | Number of tests: 14 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#0] ai-astar Cycles:10 Average:145.70 Median:147.50 stddev:27.94 (18.9%) stddev-sans-first:27.92 05:03:12 INFO - PID 1911 | Values: 119.0 151.0 157.0 191.0 192.0 126.0 124.0 140.0 113.0 144.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:145.00 stddev:16.79 (11.6%) stddev-sans-first:17.19 05:03:12 INFO - PID 1911 | Values: 150.0 118.0 120.0 158.0 125.0 156.0 137.0 116.0 140.0 155.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#2] audio-dft Cycles:10 Average:245.30 Median:247.00 stddev:41.95 (17.0%) stddev-sans-first:43.64 05:03:12 INFO - PID 1911 | Values: 222.0 237.0 316.0 257.0 200.0 299.0 287.0 208.0 214.0 213.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:21.40 (28.5%) stddev-sans-first:22.46 05:03:12 INFO - PID 1911 | Values: 74.0 74.0 58.0 123.0 92.0 88.0 53.0 81.0 109.0 76.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:74.50 stddev:16.24 (21.8%) stddev-sans-first:17.12 05:03:12 INFO - PID 1911 | Values: 88.0 74.0 89.0 75.0 74.0 71.0 89.0 71.0 74.0 124.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#5] imaging-gaussian-blur Cycles:10 Average:112.30 Median:139.00 stddev:19.64 (14.1%) stddev-sans-first:20.72 05:03:12 INFO - PID 1911 | Values: 118.0 135.0 98.0 108.0 100.0 142.0 136.0 89.0 89.0 108.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:103.50 stddev:9.23 (8.9%) stddev-sans-first:9.72 05:03:12 INFO - PID 1911 | Values: 103.0 103.0 104.0 105.0 103.0 132.0 101.0 106.0 101.0 103.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:106.50 stddev:18.97 (17.8%) stddev-sans-first:19.85 05:03:12 INFO - PID 1911 | Values: 102.0 106.0 104.0 107.0 108.0 164.0 102.0 111.0 100.0 104.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 05:03:12 INFO - PID 1911 | Values: 53.0 52.0 54.0 52.0 54.0 53.0 53.0 53.0 54.0 53.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:71.00 stddev:16.16 (22.8%) stddev-sans-first:16.52 05:03:12 INFO - PID 1911 | Values: 60.0 81.0 87.0 97.0 96.0 61.0 61.0 60.0 59.0 60.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:87.50 stddev:11.32 (12.9%) stddev-sans-first:11.86 05:03:12 INFO - PID 1911 | Values: 89.0 89.0 88.0 98.0 114.0 115.0 86.0 87.0 87.0 87.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#11] stanford-crypto-ccm Cycles:10 Average:169.00 Median:168.50 stddev:13.38 (7.9%) stddev-sans-first:13.05 05:03:12 INFO - PID 1911 | Values: 154.0 171.0 171.0 161.0 163.0 161.0 184.0 160.0 199.0 166.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:216.70 Median:209.50 stddev:27.66 (13.2%) stddev-sans-first:29.01 05:03:12 INFO - PID 1911 | Values: 205.0 195.0 195.0 206.0 197.0 234.0 264.0 194.0 264.0 213.0 05:03:12 INFO - PID 1911 | 05:03:12 INFO - PID 1911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:73.50 stddev:6.67 (9.1%) stddev-sans-first:6.93 05:03:12 INFO - PID 1911 | Values: 71.0 72.0 75.0 72.0 69.0 86.0 88.0 73.0 69.0 74.0 05:03:12 INFO - PID 1911 | -------- Summary: end -------- 05:03:12 INFO - PID 1911 | 05:03:13 INFO - TEST-INFO | 1911: exit 0 05:03:13 INFO - TEST-OK | kraken | took 64803ms 05:03:13 INFO - SUITE-END | took 1182s 05:03:13 INFO - Completed test suite (00:19:43) 05:03:13 INFO - javascript benchmark 05:03:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7824.708422552544, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3454.8253593778113, 3476.878309259175, 3622.728295377846, 3629.0745859805747, 3663.8900832975005, 5531.861703457415, 5847.386024467433, 6166.568340216176, 6245.687715614213, 6343.0802533632595, 6137.806028951344, 6210.192674952261, 6253.937460625392, 6360.0, 6440.098386225932, 5541.806036788713, 5593.300837395325, 5645.717714114298, 5691.459311365414, 5743.483086522212, 5487.862803429926, 5605.663660180382, 5720.313562372521, 5740.253767010304, 5758.251427314443, 5440.809571664972, 5517.779288828482, 5527.585431092684, 5612.719364031803, 5644.858878528029, 5531.308586426697, 5540.335159780811, 5566.805161819358, 5568.1647752837, 5610.747516361774, 5539.335279766414, 5545.362283337387, 5557.888842223173, 5567.916481252784, 5611.2144299798065, 6120.357362476921, 6145.801568694106, 6200.565960382775, 6241.65670888101, 6317.6209427434505, 6868.519203655746, 6881.41507971823, 6889.931100688979, 6896.551724137915, 6897.48268879831, 6904.516683832134, 6947.826304342432, 6967.93032069683, 6968.024476573284, 6976.965115174392, 6201.56589038772, 6233.812985610439, 6361.109444677749, 6432.646204458753, 6470.741170353227, 7092.4680648951535, 7117.217106118323, 7130.857382852418, 7137.785866424016, 7160.427165826722, 6514.348565143448, 6596.307387724316, 6609.702563384659, 6729.663516824139, 6792.403785110495, 6809.591424514545, 6950.20072691647, 6978.476614253951, 6986.580805151707, 7003.92996070043, 6576.901346479806, 6640.435562977201, 6901.930980690129, 6905.620190889549, 6912.343327383891, 6781.4574834013165, 6788.898166527506, 6877.3810357068105, 6877.690503927335, 6910.792676219721, 5457.072297709399, 5462.808801691922, 5470.0, 5485.0, 5522.889542209214, 4780.306855506002, 4855.368802055781, 4864.440589332201, 4876.390451193601, 4934.6545741798445, 5537.224788529609, 5977.701114944235, 6371.267304259976, 6443.162388889508, 6453.580517266457, 6968.721251149998, 6984.650767461607, 6990.755323563752, 6999.545029573163, 7013.859722805515, 6471.449926756279, 6493.740250389931, 6526.902096468557, 6543.411093001652, 6556.541042127005, 5995.0, 6065.514758819372, 6071.332153463116, 6071.544634152457, 6175.96912015437, 5954.791582294599, 7049.5417797844, 7074.610896400542, 7100.822479437848, 7112.57324560528, 6937.445004399535, 6954.826129346807, 6968.721251149897, 6995.685194166173, 7002.194747603887, 5782.624129431573, 5950.940490595039, 6883.896741548981, 7144.3212894774915, 7145.928540714526, 6645.1361323027695, 6789.1174147360525, 6829.351211634887, 6871.175458944758, 6901.965490172517, 5680.517156041783, 5892.880352732967, 6670.499712521483, 6786.59280443175, 6995.510314277952, 6499.935000649933, 6559.376859198369, 6611.900821487586, 6711.127553418024, 6713.731450741916, 5969.76120955157, 6644.003399490115, 6718.798436046926, 6755.560888542229, 6835.555688880207, 6329.9872020476505, 6421.454176394872, 6467.838304042437, 6513.218413790186, 6514.315996820265, 5686.488216060575, 6075.210222671025, 6710.926251799884, 6740.157480314961, 6742.393184613408, 6532.5753826001155, 6545.901811472927, 6550.901736474052, 6558.114654521579, 6587.0448784926875], "value": 6220.179175813718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.5262305812751, 756.451572609858, 835.6490274084886, 1290.8902743266822, 1293.4632127667019, 36962.81518592407, 38182.42726359103, 38192.618073819256, 38222.0, 38285.808570957175, 38218.617813821926, 38360.616393836055, 38465.0, 38618.0, 38647.42028869562, 8073.798155046126, 8243.340532757395, 8538.573071346407, 8816.515091669955, 8827.514486703229, 8661.0, 8701.695440659578, 8779.0, 8791.340649451286, 8792.0, 8720.607572659213, 8791.428557143798, 8806.911930880673, 8809.471431714117, 8821.911780882174, 8737.563121843914, 8744.344174186897, 8773.990991036017, 8779.517126558037, 8801.735947921572, 8435.325173986066, 8512.829743405096, 8553.44402613828, 8561.272291855199, 8566.914330856736, 37553.81223093867, 37623.62376376256, 37804.0, 37849.810750946344, 37886.0, 3496.807675577842, 3529.770564913272, 3530.858765649371, 3538.203904121552, 3539.681428671406, 29655.85172074126, 30018.0, 30094.0, 30126.397472050656, 30130.698693013008, 3047.6190476190477, 3109.5957525521762, 3114.7196752292175, 3155.826429546374, 3159.336539326744, 233419.0, 236910.4162708611, 266748.0, 268423.31576684373, 291495.0, 51413.485865141614, 51682.0, 51905.0, 51906.48093519092, 52001.219981700306, 53927.11255106053, 53939.92120157575, 54408.0, 54417.1837422439, 54632.0, 14455.49405770814, 14536.636584085483, 14589.90575706805, 14603.0, 14636.560903172922, 11818.113641476924, 11973.40132993347, 12009.279443233434, 12015.759684806255, 12052.819207711891, 13798.17210967345, 13963.0, 13978.930105349611, 13980.601939805938, 14066.578002659937, 6229.657368844757, 6253.53098517613, 6272.937270627326, 6293.96853015732, 6297.590656607306, 869.26112804116, 948.5873644964463, 951.6098399656108, 1023.8003589300164, 1035.6737627647267, 21192.15231390727, 23242.883785580965, 23621.05515779384, 23685.54471981168, 23764.524709505713, 1019.9286049976579, 1064.1699474409818, 1080.6001779341536, 1092.9672109836717, 1128.4639796096953, 11914.702132446584, 12155.20991135591, 12203.572874949334, 12217.51129954792, 12256.938715306367, 365437.0, 367042.0, 367229.0, 368675.0, 369152.0, 51997.0, 52261.0, 52595.73702131465, 52606.0, 52777.736111319195, 1319.4656164253493, 1487.970240595182, 1520.7034628247607, 1535.1633359818925, 1547.7153962211337, 18606.53483662919, 22103.336899893027, 23073.0, 23207.3037808866, 23578.17476388318, 29104.27239319034, 36613.81693091518, 36835.815820920725, 36891.0, 37040.81479592585, 325195.0, 325533.0, 325974.0, 326320.0, 326611.0, 32147.0, 33940.83029584836, 34595.443205056334, 34842.30315393729, 34915.65084349124, 42061.0, 42125.94685132896, 42548.78725606476, 42637.14725705531, 43590.78204608957, 28214.85892570524, 29122.12633620995, 29684.257893552833, 29953.55069673913, 30153.793848245823, 28663.57004644974, 29112.417751645273, 29170.124896253146, 29700.40599187961, 30030.94891678781, 32504.674953250164, 35108.64891351054, 35530.644693552735, 35973.64026359703, 35983.0, 24285.392865177804, 26155.869220653774, 29988.35064071497, 30182.69817301799, 30248.092557223317, 23438.64842027405, 23572.174973875834, 24339.271074010725, 24340.634890476304, 24422.389440264134], "value": 17543.49023116635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9815508302126, 419.60976292048394, 420.9557996410375, 423.27197220780255, 447.3200734882978, 19566.510837229078, 21318.786812131875, 21974.560508789815, 21989.450263743394, 22018.889905550448, 21039.47401314968, 21742.91285435726, 22543.0, 22669.319920402373, 22738.0, 6228.937710622881, 6429.6142231466265, 6484.513661475408, 6489.805305840809, 6495.512836537255, 6070.696465176746, 6307.432331090201, 6376.2667293261175, 6389.488840892717, 6399.200099987502, 6139.355367686396, 6313.863504569175, 6317.652529110897, 6357.777477788279, 6359.395857393541, 6203.565750397474, 6344.206974128234, 6347.428731414148, 6352.142460767784, 6361.491080713532, 5559.305086864142, 5607.271054762896, 5662.688552129631, 5668.801591944262, 5671.801486947978, 26731.0, 26732.732672673217, 26846.328841778915, 26992.32519187036, 27096.91612335504, 1950.619629172312, 2236.105557776886, 2242.843000989931, 2243.9439014024615, 2247.797698207169, 17263.30946762128, 17317.0, 17466.301347946068, 17845.286188552443, 17902.820971790246, 2065.9070341834504, 2067.5968186203695, 2128.563644452899, 2132.093860109447, 2136.380449669594, 134403.0, 134945.32527337302, 134985.0, 135662.999999999, 136173.3191334047, 12495.500179992698, 12751.107422480338, 12932.288724120264, 12941.347023860086, 12944.288064156563, 16408.343666253455, 16455.506334809976, 16483.6703265934, 16488.25802838875, 16507.174641267888, 8801.91198088011, 8886.0, 9014.18872301496, 9033.728988130235, 9139.360244782802, 8564.100769419247, 8578.01352844431, 8593.871091933626, 8743.256823169975, 8753.47479151253, 7745.341645960044, 7891.171427000082, 7921.0, 7921.0, 7940.325072368798, 1926.9614607707767, 2059.341010876535, 2118.428024433425, 2147.1411435425953, 2147.6671115977047, 875.7635438431588, 933.715216858851, 939.7603611079268, 950.7337945375306, 994.4033579852031, 20073.598528029357, 21273.574528509653, 21444.78555214428, 21472.083999541697, 21711.457213569473, 975.4196253229317, 980.6959842448864, 1013.8986101389802, 1028.9691309260734, 1032.0, 8852.424592401474, 9856.408615483095, 11041.0, 11128.833067503994, 11178.44107794607, 650543.0, 657943.0, 660167.0, 665669.0, 667449.0, 130641.0, 151451.0, 154220.22889885478, 154494.0, 157667.0, 1092.2954694222183, 1169.976600468003, 1183.6981569699672, 1229.7171650520431, 1235.184778046485, 17349.0, 18065.00642464677, 20432.182712691327, 21528.569428611027, 22214.66677999799, 61460.0, 61639.38360616516, 61916.69041654763, 62101.0, 62176.0, 72936.0, 81822.0, 82164.3567128666, 83807.0, 83939.16060839557, 7500.962495187708, 8528.061913189667, 8720.738377848675, 8788.560571971248, 8859.51272679983, 11801.52793888235, 13404.463821447032, 13964.092333998258, 14050.859491405365, 14131.505397311044, 9694.545818127337, 11353.86461353858, 11769.293842369485, 11813.586524471602, 12123.393830308272, 8766.912330876865, 11146.777064458827, 11217.0, 11439.828402573801, 11461.764955833532, 11683.299002059903, 11801.881981180079, 12058.819117713418, 12104.515819367127, 12214.938925305316, 7742.496737712031, 8708.897678692687, 8711.782205444915, 8764.553848614907, 8943.329250306384, 9554.474503902353, 11416.31502109876, 11583.478743456733, 11614.593489228175, 11975.520979160736], "value": 10494.306706644915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.8734713875751, 1450.0574626492778, 1467.1050659097955, 1479.3342995651954, 1484.2430360516134, 11059.834102488468, 11211.710653274877, 11529.942350288247, 11842.644720658394, 12162.878371216286, 11819.527218911233, 11994.580189693363, 12047.51809927604, 12156.33140177292, 12162.878371216286, 2496.10140349474, 2529.203300960201, 2544.9872750636223, 2557.7314381989904, 2562.3209849389928, 2461.1509029384924, 2466.9259922202364, 2507.4107584717576, 2516.937076573091, 2520.092766604021, 2442.6702395176603, 2499.450120973383, 2503.574392353304, 2514.346269969812, 2522.9403650466847, 2427.0413186791206, 2490.8256422050463, 2497.512984967932, 2499.9250022499355, 2501.062101711858, 2343.8945247463903, 2452.6934133233344, 2486.204414587333, 2500.237427584586, 2507.0, 9895.554700038516, 11801.114916381306, 11898.345590992492, 11988.28070315775, 11999.64001079969, 6623.602583844937, 6893.75871844488, 6896.448284137307, 6910.170779506441, 6925.58446493212, 4100.0, 4378.715383500063, 4444.444444444444, 4469.463664360265, 4488.3940668010055, 1232.6548566401423, 1237.1031002523098, 1264.6648638110908, 1279.8976081913518, 1284.78158713019, 14936.0, 15553.22233888301, 16363.918180409022, 16519.33922643093, 16568.0, 5474.288342515448, 5625.0, 5877.38287479817, 5886.3230728465915, 5911.290645122527, 12271.938640306742, 12316.630501084981, 12326.445309961073, 12352.25886446816, 12383.947364474121, 6637.103990961158, 6645.936650136052, 6656.400923916871, 6658.067870498134, 6663.533552651268, 6105.45050945417, 6145.139680444741, 6188.721507532082, 6233.594816336924, 6243.344448832898, 4390.100029493946, 4427.845025424094, 4502.234620114588, 4529.456465224194, 4533.637309015271, 1097.4567589043475, 1274.6176147155816, 1292.65744577687, 1301.8633043530292, 1313.9868601313865, 597.4413922982026, 711.8113699869435, 732.4030914804417, 737.8081698758255, 755.0750330844671, 5533.865557560771, 6147.754089836357, 6784.525083244224, 7021.719131234693, 7241.456890733216, 895.9955200223957, 898.5641963647626, 904.5748498205833, 929.1544694328129, 934.1592566690033, 4076.3477843544892, 4153.252414565347, 4309.030468144642, 4337.934930976038, 4367.912641747147, 14786.0, 15393.23033848303, 15404.0, 15416.922915385576, 15461.5361539154, 14864.108153510824, 15014.47449339268, 15191.392344306105, 15234.162121083225, 15385.846141538665, 10914.290571112851, 11020.669379918616, 11066.612668556723, 11163.609273675382, 11270.661880143609, 6386.87226255463, 6621.702023408862, 6824.351686589766, 7048.964755176191, 7109.644517774194, 11006.614768483065, 12850.871491284968, 13138.737225255632, 13182.472701091849, 13263.668408289484, 13146.671333216746, 13325.466981321026, 13491.595252142451, 13550.457981680622, 13628.454861805416, 8720.389572729848, 8729.127087291221, 8754.387192896436, 8800.427972181787, 8802.95598522029, 10622.628208012682, 10666.093382062612, 10759.569617215537, 10799.136069114295, 10819.621313253998, 9081.68214112503, 9112.225460835904, 9145.954270228607, 9195.21840643526, 9246.121618446237, 8916.465012099296, 8993.235574975939, 9068.319876009195, 9079.954600226956, 9121.270298375981, 7976.242256985577, 8029.919700802917, 8052.154523775153, 8105.432619716563, 8153.388495862952, 5601.327840659147, 5847.561432892465, 5892.322382926019, 6009.429104235091, 6148.016317389196, 5929.940700592939, 5979.103134529855, 6148.692565371803, 6159.29168145669, 6268.623882567061], "value": 5422.395816776215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.73455439311715, 347.4527619000074, 356.55964883369035, 380.34200832559674, 406.1592503517718, 6169.691515424233, 6286.402791734778, 6423.229212494502, 6467.385598368153, 6489.80530584082, 6113.2664080310315, 6158.1994340735755, 6227.252729672446, 6288.434040936315, 6301.6534090625, 3983.9004024899464, 4391.49497807753, 4575.0, 4741.502142275063, 4834.758262086899, 4556.179887620227, 4600.240960241573, 4778.952210477885, 4787.0, 4791.520847915215, 3689.631036896316, 3780.432935059749, 3908.2183563287313, 4761.262004389325, 4761.690490118149, 3903.4340020697123, 4316.503602085753, 4638.930416043779, 4770.594499467549, 4788.688735232199, 3245.1917092770113, 4225.873223803291, 4234.343676730112, 4236.491621005468, 4271.145770845812, 5320.6275560710765, 5942.257217847769, 6168.599041062316, 6175.980963141076, 6198.845028874269, 4938.432080310774, 5652.943470565324, 5693.238779192088, 5706.915686019643, 5730.971345143247, 5783.277090363705, 6363.059266923587, 6657.833554161185, 6706.9329306706795, 6718.764843230512, 4412.338149277602, 4827.396575428072, 4831.371921650198, 4849.248366503198, 4850.054239423313, 6349.555531112777, 6884.311568843075, 7092.397146242575, 7132.821679458003, 7248.311410416002, 3775.4714339992424, 4274.380214868889, 4387.802548885308, 4966.95693904277, 4976.62675299354, 4838.685485443435, 5080.196530231715, 5082.74586270685, 5088.753255452438, 5100.209467532539, 4911.287863259879, 4927.240745182709, 5021.899562008739, 5370.758315875795, 5694.743736531866, 5949.8215053548465, 6026.21659184312, 6052.878942421127, 6785.0, 6867.656617169122, 1711.9058451785022, 1725.4996051145279, 1728.8616910647117, 1738.7304967730022, 1745.092551873019, 1131.1685910855515, 1192.5706745571588, 1194.5699548162654, 1201.2612243470203, 1207.9094067944939, 5359.946400536022, 6369.0, 6382.393672601095, 6396.776112836028, 6399.168108145911, 5488.91766623501, 6012.033931741944, 6955.095837541087, 6956.0, 6980.616066116311, 4897.926531102036, 5146.716930568855, 5672.681481333466, 6317.009562445616, 6397.552171347961, 3088.4286407014324, 3503.8773642922374, 3619.1314084619503, 3647.2340808429994, 3661.8901432957055, 5915.556333275022, 5954.612950158225, 6783.762568310085, 7141.464390170758, 7160.57036577807, 6822.351876571718, 6997.300269973064, 7083.220845706968, 7137.571745695275, 7176.7846964591145, 6323.652199129, 7049.801533739379, 7206.0, 7214.96392518034, 7233.746818861315, 6645.667716614246, 6911.481638877004, 6954.3393377629045, 6998.6150761708595, 7049.506534542533, 5329.253904453302, 5802.332731735735, 6281.0, 6516.543841931209, 6885.862282754417, 6546.509011824037, 7205.567665940061, 7243.891341629775, 7260.346568808833, 7292.635368231461, 3891.6497515223764, 4334.371516130081, 4886.849786094107, 4919.1883339248625, 4929.482404347636, 6946.548474349152, 6948.922916947881, 6985.301469852974, 7024.0, 7027.718891244497, 5500.477454641803, 6368.42684158428, 6624.271330153776, 6668.6665666717445, 6709.295523969913, 5708.857278568069, 5830.82507524775, 6705.865882682417, 6720.932790672031, 6743.797686069426, 5605.775768969195, 6143.477804386677, 6489.1447762984135, 6551.967240163769, 6583.44040756541, 6707.061011458302, 6722.663866806738, 6739.73041078371, 6757.526973111835, 6765.5305813378745, 5146.742662866767, 5884.617499862496, 6395.328490508429, 6479.838004049937, 6544.8363790905605], "value": 4890.578047777043, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.9684114214859, 730.7150211417545, 756.8344749086407, 839.7019058234326, 840.3865178419755, 15663.765043524341, 15713.685726285481, 15794.684106317896, 15953.361865525365, 15971.92014039931, 14406.135631862096, 14486.0, 14717.484888028921, 14746.63133421665, 15110.244487775622, 910.2399496420497, 935.4013431403873, 939.4926739560664, 942.7690215897114, 945.42801605029, 954.4034978138664, 960.0447554683066, 960.2605993385089, 960.3901522533207, 961.0485619236975, 1019.6278358399205, 1024.2778840917135, 1024.472396715692, 1024.923130765192, 1027.1012863744224, 1007.9546420411062, 1018.2871989607268, 1020.5611587017579, 1021.4177918586446, 1022.2180032275315, 746.8431629357841, 749.3368368993425, 751.3726038757644, 752.578556008637, 752.9962350188214, 14013.089149205269, 14131.010829241957, 14743.557693269218, 14870.330835112338, 14888.330025148785, 10132.632094667199, 11597.884021159849, 11630.592929247521, 11723.062155027577, 11867.52529898803, 11794.05647548194, 11929.522819087226, 14206.289685515683, 14935.477258296016, 15023.474178403703, 4976.651634385595, 5005.848654809378, 5029.270755740434, 5052.191649336125, 5091.541761241469, 96865.5156724219, 100424.49787751088, 102204.48897755463, 102733.43166420824, 105704.0, 9752.366096203725, 10939.445191177407, 11496.42517874103, 11649.825252621218, 11925.880741192477, 21365.359039228537, 22121.44696382571, 22907.42731431694, 24157.396065098514, 24741.381465463506, 6816.591004539743, 7753.147153813076, 7835.608219588998, 7989.7203597873795, 8122.318184763025, 3496.860125594948, 3663.780173189617, 4130.459767243124, 4135.152293779768, 4212.262854000599, 4168.228877657643, 4228.556001619786, 4256.127493863751, 4270.231358355463, 4272.5086615039045, 942.2273735536794, 946.8390373636498, 948.5541795356172, 948.8197242523898, 951.7192428233687, 517.2551525802832, 620.8758248350258, 622.1290193728726, 637.5791977295056, 639.6567208861354, 9923.553440095213, 10040.297179197387, 10045.525487790886, 10089.697309080739, 10116.645917392856, 604.8608819971344, 622.6450922973861, 625.1654041854085, 635.9141515895387, 664.3024823934849, 4143.56492568282, 4553.134904368159, 4745.881352966204, 4747.240441529408, 4769.189237829577, 82132.0, 93197.0, 94962.52518737363, 96180.0, 97337.0, 81937.0, 83624.58187709023, 84193.0, 84870.57564712137, 86395.13604863996, 72412.0, 73622.0, 73919.52160956751, 74228.0, 75371.24628753752, 10639.673696776637, 10679.0, 11003.724906877072, 11018.669439916815, 11069.667909962393, 27721.584176237775, 37381.439278410304, 38639.613603864724, 39030.80484597559, 39701.602983970944, 40110.0, 51134.74432627813, 51888.221676674126, 52017.0, 52706.20940685969, 13027.0, 13533.661658458224, 13574.59276221715, 13660.658483537594, 14018.509352172625, 12634.810477843024, 12827.551035713705, 14132.646683832987, 14156.433742650179, 14731.852681473476, 11115.72210694739, 12973.870261297267, 13087.607371778862, 13434.798478023033, 13840.723185536433, 13427.395767190696, 13465.461381544628, 13867.583972480841, 13888.027838051239, 14171.0, 13102.017348699077, 13126.737465250451, 13315.800262996256, 13334.0, 13948.79076813869, 9209.677661281823, 9241.584128714358, 9574.664886728931, 9634.373765705206, 10103.595856165965, 9964.55159517838, 10902.484552650667, 11019.559217631526, 11095.889041109485, 11096.278741881752], "value": 7557.107903715887, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1703.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 151.0, 157.0, 191.0, 192.0, 126.0, 124.0, 140.0, 113.0, 144.0], "value": 145.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 120.0, 158.0, 125.0, 156.0, 137.0, 116.0, 140.0, 155.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 237.0, 316.0, 257.0, 200.0, 299.0, 287.0, 208.0, 214.0, 213.0], "value": 245.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 58.0, 123.0, 92.0, 88.0, 53.0, 81.0, 109.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 89.0, 75.0, 74.0, 71.0, 89.0, 71.0, 74.0, 124.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 135.0, 98.0, 108.0, 100.0, 142.0, 136.0, 89.0, 89.0, 108.0], "value": 112.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 104.0, 105.0, 103.0, 132.0, 101.0, 106.0, 101.0, 103.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 104.0, 107.0, 108.0, 164.0, 102.0, 111.0, 100.0, 104.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 52.0, 54.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 81.0, 87.0, 97.0, 96.0, 61.0, 61.0, 60.0, 59.0, 60.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 98.0, 114.0, 115.0, 86.0, 87.0, 87.0, 87.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 171.0, 171.0, 161.0, 163.0, 161.0, 184.0, 160.0, 199.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 195.0, 195.0, 206.0, 197.0, 234.0, 264.0, 194.0, 264.0, 213.0], "value": 216.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 75.0, 72.0, 69.0, 86.0, 88.0, 73.0, 69.0, 74.0], "value": 74.9, "unit": "score"}]}]} 05:03:13 INFO - Return code: 0 05:03:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:03:13 ERROR - # TBPL SUCCESS # 05:03:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:14 INFO - 2017-04-07 05:03:14.002 screenresolution[1916:11797] starting screenresolution argv=screenresolution get 05:03:14 INFO - 2017-04-07 05:03:14.004 screenresolution[1916:11797] Display 0: 1600x1200x32@60 05:03:14 INFO - 2017-04-07 05:03:14.010 screenresolution[1917:11801] starting screenresolution argv=screenresolution list 05:03:14 INFO - Available Modes on Display 0 05:03:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:14 INFO - Intel Iris: 05:03:14 INFO - Chipset Model: Intel Iris 05:03:14 INFO - Type: GPU 05:03:14 INFO - Bus: Built-In 05:03:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:14 INFO - Vendor: Intel (0x8086) 05:03:14 INFO - Device ID: 0x0a2e 05:03:14 INFO - Revision ID: 0x0009 05:03:14 INFO - Displays: 05:03:14 INFO - Display: 05:03:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:14 INFO - Display Serial Number: 1600x1200 60 05:03:14 INFO - Main Display: Yes 05:03:14 INFO - Mirror: Off 05:03:14 INFO - Online: Yes 05:03:14 INFO - Rotation: Supported 05:03:14 INFO - Return code: 0 05:03:14 INFO - Running post-action listener: _resource_record_post_action 05:03:14 INFO - [mozharness: 2017-04-07 12:03:14.244041Z] Finished run-tests step (success) 05:03:14 INFO - Running post-run listener: _resource_record_post_run 05:03:14 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 3302400; Write bytes: 522966016; Read time: 25; Write time: 1668 05:03:14 INFO - TinderboxPrint: CPU usage
54.1% 05:03:14 INFO - TinderboxPrint: I/O read bytes / time
3,302,400 / 25 05:03:14 INFO - TinderboxPrint: I/O write bytes / time
522,966,016 / 1,668 05:03:14 INFO - TinderboxPrint: CPU idle
2,209.8 (45.9%) 05:03:14 INFO - TinderboxPrint: CPU system
968.2 (20.1%) 05:03:14 INFO - TinderboxPrint: CPU user
1,639.7 (34.0%) 05:03:14 INFO - TinderboxPrint: Swap in / out
211,324,928 / 0 05:03:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204630528; Write bytes: 206268416; Read time: 16033; Write time: 468 05:03:14 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 2393088; Write bytes: 309570560; Read time: 22; Write time: 1169 05:03:14 INFO - Running post-run listener: _upload_blobber_files 05:03:14 INFO - Blob upload gear active. 05:03:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:14 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 05:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:03:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:15 INFO - (blobuploader) - INFO - Done attempting. 05:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:16 INFO - (blobuploader) - INFO - Done attempting. 05:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:17 INFO - (blobuploader) - INFO - Done attempting. 05:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:19 INFO - (blobuploader) - INFO - Done attempting. 05:03:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:19 INFO - Return code: 0 05:03:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e63d94dbeacd4e627c0e0890c54f58df62d9346795385e0774c6d7c54b2e4bc11df3fedd0da960fd926da5704a568f953b9bc5d1656a8fee5be201a8533df437", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6e9db470d31dd4b1cf64f9e0a5c76b19fdc58115ba3788c1a4f764b6cc4f07a2577ba0dd37b846b43ec460fca48950360b23e2a2589cf2fab0cf504b5f7295", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db505b6f34e57fc614d9742bbe30bf89af887d0fccfef5b4b291b6d82c17d51d6b8a8597fff4009b8e5fec790d13312a2e858c193af82eeed188afa66855477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08bf338ab21d04c498ea158b909f0523571c0be2c5f5e0ca7f6dacbf38e7fc01c38c40f6a5c0c8685ee31d585cdcb52e3e9fe65ce00ec4960352a8903941866c"} 05:03:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:19 INFO - Contents: 05:03:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e63d94dbeacd4e627c0e0890c54f58df62d9346795385e0774c6d7c54b2e4bc11df3fedd0da960fd926da5704a568f953b9bc5d1656a8fee5be201a8533df437", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6e9db470d31dd4b1cf64f9e0a5c76b19fdc58115ba3788c1a4f764b6cc4f07a2577ba0dd37b846b43ec460fca48950360b23e2a2589cf2fab0cf504b5f7295", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db505b6f34e57fc614d9742bbe30bf89af887d0fccfef5b4b291b6d82c17d51d6b8a8597fff4009b8e5fec790d13312a2e858c193af82eeed188afa66855477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08bf338ab21d04c498ea158b909f0523571c0be2c5f5e0ca7f6dacbf38e7fc01c38c40f6a5c0c8685ee31d585cdcb52e3e9fe65ce00ec4960352a8903941866c"} 05:03:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:19 INFO - Copying logs to upload dir... 05:03:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.571281 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-07 05:03:20.199214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:20.202701) ========= 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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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/Firefox/sha512/e63d94dbeacd4e627c0e0890c54f58df62d9346795385e0774c6d7c54b2e4bc11df3fedd0da960fd926da5704a568f953b9bc5d1656a8fee5be201a8533df437", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6e9db470d31dd4b1cf64f9e0a5c76b19fdc58115ba3788c1a4f764b6cc4f07a2577ba0dd37b846b43ec460fca48950360b23e2a2589cf2fab0cf504b5f7295", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db505b6f34e57fc614d9742bbe30bf89af887d0fccfef5b4b291b6d82c17d51d6b8a8597fff4009b8e5fec790d13312a2e858c193af82eeed188afa66855477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08bf338ab21d04c498ea158b909f0523571c0be2c5f5e0ca7f6dacbf38e7fc01c38c40f6a5c0c8685ee31d585cdcb52e3e9fe65ce00ec4960352a8903941866c"} build_url:https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/OuzjvPIrShSW05lcmOcPvw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e63d94dbeacd4e627c0e0890c54f58df62d9346795385e0774c6d7c54b2e4bc11df3fedd0da960fd926da5704a568f953b9bc5d1656a8fee5be201a8533df437", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6e9db470d31dd4b1cf64f9e0a5c76b19fdc58115ba3788c1a4f764b6cc4f07a2577ba0dd37b846b43ec460fca48950360b23e2a2589cf2fab0cf504b5f7295", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db505b6f34e57fc614d9742bbe30bf89af887d0fccfef5b4b291b6d82c17d51d6b8a8597fff4009b8e5fec790d13312a2e858c193af82eeed188afa66855477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08bf338ab21d04c498ea158b909f0523571c0be2c5f5e0ca7f6dacbf38e7fc01c38c40f6a5c0c8685ee31d585cdcb52e3e9fe65ce00ec4960352a8903941866c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:20.239881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:20.240206) ========= 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.BZoNOT3JxW/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.67KS8Hi1i7/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 05:03:20.289396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 05:03:20.289739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 05:03:20.290176) ========= ========= Total master_lag: 0.49 =========