builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0330 starttime: 1488900050.8 results: success (0) buildid: 20170307060527 builduid: cecd9a2599b44c38b45fb63d3483abb8 revision: 1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.804150) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.804586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.804870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.832967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.833321) ========= 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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-03-07 07:20:50-- 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% 67.1M=0s 2017-03-07 07:20:50 (67.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.983038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:50.983343) ========= 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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.021571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:51.032211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-07 07:20:51.032548) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83 --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 1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Oh4IBao0L7/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.rLXrnUWZ80/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-03-07 07:20:51,119 truncating revision to first 12 chars 2017-03-07 07:20:51,119 Setting DEBUG logging. 2017-03-07 07:20:51,119 attempt 1/10 2017-03-07 07:20:51,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1fb56ba248d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-07 07:20:53,280 unpacking tar archive at: mozilla-central-1fb56ba248d5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.417419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-07 07:20:53.473943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:53.474432) ========= script_repo_revision: 1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:53.474833) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:53.475094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 07:20:53.495801) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-07 07:20:53.496155) ========= /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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:20:53 INFO - MultiFileLogger online at 20170307 07:20:53 in /builds/slave/test 07:20:53 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 07:20:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:20:53 INFO - {'append_to_log': False, 07:20:53 INFO - 'base_work_dir': '/builds/slave/test', 07:20:53 INFO - 'blob_upload_branch': 'Firefox', 07:20:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:20:53 INFO - 'branch': 'Firefox', 07:20:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:53 INFO - 'config_files': ('talos/mac_config.py',), 07:20:53 INFO - 'default_actions': ('clobber', 07:20:53 INFO - 'read-buildbot-config', 07:20:53 INFO - 'download-and-extract', 07:20:53 INFO - 'populate-webroot', 07:20:53 INFO - 'create-virtualenv', 07:20:53 INFO - 'install', 07:20:53 INFO - 'run-tests'), 07:20:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:53 INFO - 'download_minidump_stackwalk': True, 07:20:53 INFO - 'download_symbols': 'ondemand', 07:20:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:53 INFO - 'gecko_profile': False, 07:20:53 INFO - 'gecko_profile_interval': 0, 07:20:53 INFO - 'installer_path': 'installer.exe', 07:20:53 INFO - 'log_level': 'info', 07:20:53 INFO - 'log_name': 'talos', 07:20:53 INFO - 'log_to_console': True, 07:20:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:20:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:20:53 INFO - 'opt_config_files': (), 07:20:53 INFO - 'pip_index': False, 07:20:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:20:53 INFO - 'cmd': ('bash', 07:20:53 INFO - '-c', 07:20:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:20:53 INFO - 'enabled': True, 07:20:53 INFO - 'halt_on_failure': False, 07:20:53 INFO - 'name': 'check_screen_resolution'},), 07:20:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:20:53 INFO - 'cmd': ('bash', 07:20:53 INFO - '-c', 07:20:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:20:53 INFO - 'enabled': True, 07:20:53 INFO - 'halt_on_failure': False, 07:20:53 INFO - 'name': 'check_screen_resolution'},), 07:20:53 INFO - 'run_cmd_checks_enabled': True, 07:20:53 INFO - 'suite': 'dromaeojs-e10s', 07:20:53 INFO - 'system_bits': '32', 07:20:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:53 INFO - 'title': 't-yosemite-r7-0330', 07:20:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:53 INFO - 'use_talos_json': True, 07:20:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:20:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:53 INFO - 'work_dir': 'build'} 07:20:53 INFO - [mozharness: 2017-03-07 15:20:53.702843Z] Running clobber step. 07:20:53 INFO - Running pre-action listener: _resource_record_pre_action 07:20:53 INFO - Running main action method: clobber 07:20:53 INFO - rmtree: /builds/slave/test/build 07:20:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:56 INFO - Running post-action listener: _resource_record_post_action 07:20:56 INFO - [mozharness: 2017-03-07 15:20:56.998585Z] Finished clobber step (success) 07:20:56 INFO - [mozharness: 2017-03-07 15:20:56.998833Z] Running read-buildbot-config step. 07:20:56 INFO - Running pre-action listener: _resource_record_pre_action 07:20:56 INFO - Running main action method: read_buildbot_config 07:20:56 INFO - Using buildbot properties: 07:20:57 INFO - { 07:20:57 INFO - "project": "", 07:20:57 INFO - "product": "firefox", 07:20:57 INFO - "script_repo_revision": "production", 07:20:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:20:57 INFO - "repository": "", 07:20:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:20:57 INFO - "buildid": "20170307060527", 07:20:57 INFO - "pgo_build": "False", 07:20:57 INFO - "basedir": "/builds/slave/test", 07:20:57 INFO - "buildnumber": 101, 07:20:57 INFO - "slavename": "t-yosemite-r7-0330", 07:20:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:20:57 INFO - "platform": "yosemite_r7", 07:20:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:20:57 INFO - "branch": "mozilla-central", 07:20:57 INFO - "repo_path": "mozilla-central", 07:20:57 INFO - "revision": "1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83", 07:20:57 INFO - "stage_platform": "macosx64", 07:20:57 INFO - "builduid": "cecd9a2599b44c38b45fb63d3483abb8", 07:20:57 INFO - "slavebuilddir": "test" 07:20:57 INFO - } 07:20:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 07:20:57 INFO - Running post-action listener: _resource_record_post_action 07:20:57 INFO - [mozharness: 2017-03-07 15:20:57.004899Z] Finished read-buildbot-config step (success) 07:20:57 INFO - [mozharness: 2017-03-07 15:20:57.005083Z] Running download-and-extract step. 07:20:57 INFO - Running pre-action listener: _resource_record_pre_action 07:20:57 INFO - Running main action method: download_and_extract 07:20:57 INFO - mkdir: /builds/slave/test/build/tests 07:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:57 INFO - trying https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:20:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/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 07:20:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/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 07:20:57 INFO - Downloaded 1199 bytes. 07:20:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:20:57 INFO - Using the following test package requirements: 07:20:57 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:20:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:20:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:20:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'jsshell-mac.zip'], 07:20:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:20:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:20:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:20:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:20:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:20:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:20:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:20:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:20:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:20:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:20:57 INFO - Fetch https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:20:59 INFO - Expected file size: 51778025 07:20:59 INFO - Obtained file size: 51778025 07:21: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 07:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:21:17 INFO - Expected file size: 51778025 07:21:17 INFO - Obtained file size: 51778025 07:21:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:21:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:21:32 INFO - Fetch https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:21:33 INFO - Expected file size: 14404424 07:21:33 INFO - Obtained file size: 14404424 07:21: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')]} 07:21:33 INFO - trying https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:21:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/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 07:21:35 INFO - Downloaded 74989552 bytes. 07:21:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:21:35 INFO - mkdir: /builds/slave/test/properties 07:21:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:21:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:21:35 INFO - Contents: 07:21:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:21:36 INFO - Running post-action listener: _resource_record_post_action 07:21:36 INFO - Running post-action listener: set_extra_try_arguments 07:21:36 INFO - [mozharness: 2017-03-07 15:21:36.617239Z] Finished download-and-extract step (success) 07:21:36 INFO - [mozharness: 2017-03-07 15:21:36.617363Z] Running populate-webroot step. 07:21:36 INFO - Running pre-action listener: _resource_record_pre_action 07:21:36 INFO - Running main action method: populate_webroot 07:21:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:21:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:21:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:21:36 INFO - '--tppagecycles', 07:21:36 INFO - '7'], 07:21:36 INFO - 'tests': ['tsvgm']}}, 07:21:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:21:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:21:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:21:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:21:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:21:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:21:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['damp', 'tps']}, 07:21:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'tests': ['damp', 'tps']}, 07:21:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['dromaeo_dom']}, 07:21:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:21:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['basic_compositor_video']}, 07:21:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:21:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['a11yr', 07:21:36 INFO - 'ts_paint', 07:21:36 INFO - 'tpaint', 07:21:36 INFO - 'sessionrestore', 07:21:36 INFO - 'sessionrestore_no_auto_restore', 07:21:36 INFO - 'tabpaint']}, 07:21:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:21:36 INFO - 'ts_paint', 07:21:36 INFO - 'tpaint', 07:21:36 INFO - 'sessionrestore', 07:21:36 INFO - 'sessionrestore_no_auto_restore', 07:21:36 INFO - 'tabpaint']}, 07:21:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:21:36 INFO - 'ts_paint', 07:21:36 INFO - 'tpaint', 07:21:36 INFO - 'sessionrestore', 07:21:36 INFO - 'sessionrestore_no_auto_restore', 07:21:36 INFO - 'tabpaint']}, 07:21:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:21:36 INFO - 'ts_paint', 07:21:36 INFO - 'tpaint', 07:21:36 INFO - 'sessionrestore', 07:21:36 INFO - 'sessionrestore_no_auto_restore', 07:21:36 INFO - 'tabpaint']}, 07:21:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['a11yr', 07:21:36 INFO - 'ts_paint', 07:21:36 INFO - 'tpaint', 07:21:36 INFO - 'sessionrestore', 07:21:36 INFO - 'sessionrestore_no_auto_restore', 07:21:36 INFO - 'tabpaint']}, 07:21:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['a11yr', 07:21:36 INFO - 'ts_paint', 07:21:36 INFO - 'tpaint', 07:21:36 INFO - 'sessionrestore', 07:21:36 INFO - 'sessionrestore_no_auto_restore', 07:21:36 INFO - 'tabpaint']}, 07:21:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['tsvgx', 07:21:36 INFO - 'tsvgr_opacity', 07:21:36 INFO - 'tart', 07:21:36 INFO - 'tscrollx', 07:21:36 INFO - 'cart', 07:21:36 INFO - 'tsvg_static']}, 07:21:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:21:36 INFO - 'tsvgr_opacity', 07:21:36 INFO - 'tart', 07:21:36 INFO - 'tscrollx', 07:21:36 INFO - 'cart', 07:21:36 INFO - 'tsvg_static']}, 07:21:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'talos_options': ['--disable-e10s'], 07:21:36 INFO - 'tests': ['tp5o']}, 07:21:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:21:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'talos_options': ['--disable-e10s', 07:21:36 INFO - '--xperf_path', 07:21:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:21:36 INFO - 'tests': ['tp5n']}, 07:21:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:21:36 INFO - 'talos_options': ['--xperf_path', 07:21:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:21:36 INFO - 'tests': ['tp5n']}}, 07:21:36 INFO - 'talos.zip': {'path': '', 07:21:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:21:36 INFO - Running post-action listener: _resource_record_post_action 07:21:36 INFO - [mozharness: 2017-03-07 15:21:36.635459Z] Finished populate-webroot step (success) 07:21:36 INFO - [mozharness: 2017-03-07 15:21:36.635585Z] Running create-virtualenv step. 07:21:36 INFO - Running pre-action listener: _resource_record_pre_action 07:21:36 INFO - Running main action method: create_virtualenv 07:21:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:21: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 07:21:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:21:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:21:36 INFO - Using real prefix '/tools/python27' 07:21:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:21:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:21:40 INFO - Installing pip.................done. 07:21:40 INFO - Return code: 0 07:21:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:21:40 INFO - Reading from file tmpfile_stdout 07:21:40 INFO - Output received: 07:21: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) 07:21:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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 07:21: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 07:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:41 INFO - 'HOME': '/Users/cltbld', 07:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:41 INFO - 'LOGNAME': 'cltbld', 07:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:41 INFO - 'MOZ_NO_REMOTE': '1', 07:21:41 INFO - 'NO_EM_RESTART': '1', 07:21:41 INFO - 'PAGER': '/bin/cat', 07:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:41 INFO - 'PWD': '/builds/slave/test', 07:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:41 INFO - 'SHELL': '/bin/bash', 07:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:41 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:41 INFO - 'USER': 'cltbld', 07:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:41 INFO - 'XPC_FLAGS': '0x0', 07:21:41 INFO - 'XPC_SERVICE_NAME': '0', 07:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21: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 07:21:41 INFO - Cleaning up... 07:21:41 INFO - Return code: 0 07:21:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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 07:21: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 07:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:42 INFO - 'HOME': '/Users/cltbld', 07:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:42 INFO - 'LOGNAME': 'cltbld', 07:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:42 INFO - 'MOZ_NO_REMOTE': '1', 07:21:42 INFO - 'NO_EM_RESTART': '1', 07:21:42 INFO - 'PAGER': '/bin/cat', 07:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:42 INFO - 'PWD': '/builds/slave/test', 07:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:42 INFO - 'SHELL': '/bin/bash', 07:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:42 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:42 INFO - 'USER': 'cltbld', 07:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:42 INFO - 'XPC_FLAGS': '0x0', 07:21:42 INFO - 'XPC_SERVICE_NAME': '0', 07:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:42 INFO - Downloading/unpacking psutil>=3.1.1 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:46 INFO - Installing collected packages: psutil 07:21:46 INFO - Running setup.py install for psutil 07:21:46 INFO - building 'psutil._psutil_osx' extension 07:21: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 07:21: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 07:21: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 07:21: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 07:21:46 INFO - building 'psutil._psutil_posix' extension 07:21: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 07:21:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:21:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:21:46 INFO - ^ 07:21:46 INFO - 1 warning generated. 07:21: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 07:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:47 INFO - Successfully installed psutil 07:21:47 INFO - Cleaning up... 07:21:47 INFO - Return code: 0 07:21:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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 07:21: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 07:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:47 INFO - 'HOME': '/Users/cltbld', 07:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:47 INFO - 'LOGNAME': 'cltbld', 07:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:47 INFO - 'MOZ_NO_REMOTE': '1', 07:21:47 INFO - 'NO_EM_RESTART': '1', 07:21:47 INFO - 'PAGER': '/bin/cat', 07:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:47 INFO - 'PWD': '/builds/slave/test', 07:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:47 INFO - 'SHELL': '/bin/bash', 07:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:47 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:47 INFO - 'USER': 'cltbld', 07:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:47 INFO - 'XPC_FLAGS': '0x0', 07:21:47 INFO - 'XPC_SERVICE_NAME': '0', 07:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:21:50 INFO - Installing collected packages: mozsystemmonitor 07:21:50 INFO - Running setup.py install for mozsystemmonitor 07:21:50 INFO - Successfully installed mozsystemmonitor 07:21:50 INFO - Cleaning up... 07:21:50 INFO - Return code: 0 07:21:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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 07:21: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 07:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:50 INFO - 'HOME': '/Users/cltbld', 07:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:50 INFO - 'LOGNAME': 'cltbld', 07:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:50 INFO - 'MOZ_NO_REMOTE': '1', 07:21:50 INFO - 'NO_EM_RESTART': '1', 07:21:50 INFO - 'PAGER': '/bin/cat', 07:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:50 INFO - 'PWD': '/builds/slave/test', 07:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:50 INFO - 'SHELL': '/bin/bash', 07:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:50 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:50 INFO - 'USER': 'cltbld', 07:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:50 INFO - 'XPC_FLAGS': '0x0', 07:21:50 INFO - 'XPC_SERVICE_NAME': '0', 07:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:50 INFO - Downloading/unpacking jsonschema==2.5.1 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:21:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:21:53 INFO - warning: no files found matching '*.txt' 07:21:53 INFO - no previously-included directories found matching 'build' 07:21:53 INFO - no previously-included directories found matching 'dist' 07:21:53 INFO - no previously-included directories found matching '.git*' 07:21:53 INFO - Installing collected packages: jsonschema, functools32 07:21:53 INFO - Running setup.py install for functools32 07:21:53 INFO - warning: no files found matching '*.txt' 07:21:53 INFO - no previously-included directories found matching 'build' 07:21:53 INFO - no previously-included directories found matching 'dist' 07:21:53 INFO - no previously-included directories found matching '.git*' 07:21:53 INFO - Successfully installed jsonschema functools32 07:21:53 INFO - Cleaning up... 07:21:54 INFO - Return code: 0 07:21:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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', '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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:21: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 functools32==3.2.3-2 07:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:54 INFO - 'HOME': '/Users/cltbld', 07:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:54 INFO - 'LOGNAME': 'cltbld', 07:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:54 INFO - 'MOZ_NO_REMOTE': '1', 07:21:54 INFO - 'NO_EM_RESTART': '1', 07:21:54 INFO - 'PAGER': '/bin/cat', 07:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:54 INFO - 'PWD': '/builds/slave/test', 07:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:54 INFO - 'SHELL': '/bin/bash', 07:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:54 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:54 INFO - 'USER': 'cltbld', 07:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:54 INFO - 'XPC_FLAGS': '0x0', 07:21:54 INFO - 'XPC_SERVICE_NAME': '0', 07:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:21:54 INFO - Cleaning up... 07:21:54 INFO - Return code: 0 07:21:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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 07:21: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 07:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:54 INFO - 'HOME': '/Users/cltbld', 07:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:54 INFO - 'LOGNAME': 'cltbld', 07:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:54 INFO - 'MOZ_NO_REMOTE': '1', 07:21:54 INFO - 'NO_EM_RESTART': '1', 07:21:54 INFO - 'PAGER': '/bin/cat', 07:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:54 INFO - 'PWD': '/builds/slave/test', 07:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:54 INFO - 'SHELL': '/bin/bash', 07:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:54 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:54 INFO - 'USER': 'cltbld', 07:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:54 INFO - 'XPC_FLAGS': '0x0', 07:21:54 INFO - 'XPC_SERVICE_NAME': '0', 07:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:54 INFO - Downloading/unpacking blobuploader==1.2.4 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:21:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:21:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:58 INFO - Downloading docopt-0.6.1.tar.gz 07:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:21:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:21:58 INFO - Running setup.py install for blobuploader 07:21:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:21:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:21:58 INFO - Running setup.py install for requests 07:21:59 INFO - Running setup.py install for docopt 07:21:59 INFO - Successfully installed blobuploader requests docopt 07:21:59 INFO - Cleaning up... 07:21:59 INFO - Return code: 0 07:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:21: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 07:21: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 07:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:21:59 INFO - 'HOME': '/Users/cltbld', 07:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:21:59 INFO - 'LOGNAME': 'cltbld', 07:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:59 INFO - 'MOZ_NO_REMOTE': '1', 07:21:59 INFO - 'NO_EM_RESTART': '1', 07:21:59 INFO - 'PAGER': '/bin/cat', 07:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:59 INFO - 'PWD': '/builds/slave/test', 07:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:21:59 INFO - 'SHELL': '/bin/bash', 07:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:21:59 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:21:59 INFO - 'USER': 'cltbld', 07:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:59 INFO - 'XPC_FLAGS': '0x0', 07:21:59 INFO - 'XPC_SERVICE_NAME': '0', 07:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:21:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-2YsuB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:21:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-CHTJbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:21:59 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Mrf8fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-esxJMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ZXhR7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-nucpAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-okl_eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-lT3Kwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-sydTSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-vjlKIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-dzCWlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:00 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-7dkIWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:01 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Ml_mMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:01 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-qGkoBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:01 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-NY1HtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:01 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-2TkZFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:01 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-wrkMP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:22:01 INFO - Running setup.py install for manifestparser 07:22:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:22:01 INFO - Running setup.py install for mozcrash 07:22:01 INFO - Running setup.py install for mozdebug 07:22:01 INFO - Running setup.py install for mozdevice 07:22:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Running setup.py install for mozfile 07:22:02 INFO - Running setup.py install for mozhttpd 07:22:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Running setup.py install for mozinfo 07:22:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Running setup.py install for mozInstall 07:22:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:22:02 INFO - Running setup.py install for mozleak 07:22:02 INFO - Running setup.py install for mozlog 07:22:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:22:03 INFO - Running setup.py install for moznetwork 07:22:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:22:03 INFO - Running setup.py install for mozprocess 07:22:03 INFO - Running setup.py install for mozprofile 07:22:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:22:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:22:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:22:03 INFO - Running setup.py install for mozrunner 07:22:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:22:03 INFO - Running setup.py install for mozscreenshot 07:22:03 INFO - Running setup.py install for moztest 07:22:03 INFO - Running setup.py install for mozversion 07:22:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:22:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:22:04 INFO - Cleaning up... 07:22:04 INFO - Return code: 0 07:22:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:04 INFO - 'HOME': '/Users/cltbld', 07:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:04 INFO - 'LOGNAME': 'cltbld', 07:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:04 INFO - 'MOZ_NO_REMOTE': '1', 07:22:04 INFO - 'NO_EM_RESTART': '1', 07:22:04 INFO - 'PAGER': '/bin/cat', 07:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:04 INFO - 'PWD': '/builds/slave/test', 07:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:04 INFO - 'SHELL': '/bin/bash', 07:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:22:04 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:04 INFO - 'USER': 'cltbld', 07:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:04 INFO - 'XPC_FLAGS': '0x0', 07:22:04 INFO - 'XPC_SERVICE_NAME': '0', 07:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-IcEgmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22: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)) 07:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-_LQ3cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22: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)) 07:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-OcWilU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22: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)) 07:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-dbHI93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-KDhsJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22: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)) 07:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:04 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-adlTDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-STcHly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-t3xJFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:05 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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ocNFbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22: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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Qp274z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22: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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-0gige7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22: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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-jG5_6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22: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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-8ckR2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22: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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-H7zCHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22: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)) 07:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:05 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-85Y7Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:06 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-aDjX7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:06 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-m8JF1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:06 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)) 07:22:06 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)) 07:22:06 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)) 07:22:06 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)) 07:22:06 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:22:06 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:22:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:22:06 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 07:22:06 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 07:22:06 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 07:22:06 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 07:22:06 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 07:22:06 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 07:22:08 INFO - Downloading blessings-1.6.tar.gz 07:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:22:08 INFO - Installing collected packages: blessings 07:22:08 INFO - Running setup.py install for blessings 07:22:09 INFO - Successfully installed blessings 07:22:09 INFO - Cleaning up... 07:22:09 INFO - Return code: 0 07:22:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:09 INFO - Reading from file tmpfile_stdout 07:22:09 INFO - Current package versions: 07:22:09 INFO - blessings == 1.6 07:22:09 INFO - blobuploader == 1.2.4 07:22:09 INFO - docopt == 0.6.1 07:22:09 INFO - functools32 == 3.2.3-2 07:22:09 INFO - jsonschema == 2.5.1 07:22:09 INFO - manifestparser == 1.1 07:22:09 INFO - mozInstall == 1.12 07:22:09 INFO - mozcrash == 1.0 07:22:09 INFO - mozdebug == 0.1 07:22:09 INFO - mozdevice == 0.49 07:22:09 INFO - mozfile == 1.2 07:22:09 INFO - mozhttpd == 0.7 07:22:09 INFO - mozinfo == 0.9 07:22:09 INFO - mozleak == 0.1 07:22:09 INFO - mozlog == 3.4 07:22:09 INFO - moznetwork == 0.27 07:22:09 INFO - mozprocess == 0.25 07:22:09 INFO - mozprofile == 0.28 07:22:09 INFO - mozrunner == 6.13 07:22:09 INFO - mozscreenshot == 0.1 07:22:09 INFO - mozsystemmonitor == 0.3 07:22:09 INFO - moztest == 0.8 07:22:09 INFO - mozversion == 1.4 07:22:09 INFO - psutil == 3.1.1 07:22:09 INFO - requests == 1.2.3 07:22:09 INFO - wsgiref == 0.1.2 07:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:22: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 07:22: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 07:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:09 INFO - 'HOME': '/Users/cltbld', 07:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:09 INFO - 'LOGNAME': 'cltbld', 07:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:09 INFO - 'MOZ_NO_REMOTE': '1', 07:22:09 INFO - 'NO_EM_RESTART': '1', 07:22:09 INFO - 'PAGER': '/bin/cat', 07:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:09 INFO - 'PWD': '/builds/slave/test', 07:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:09 INFO - 'SHELL': '/bin/bash', 07:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:22:09 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:09 INFO - 'USER': 'cltbld', 07:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:09 INFO - 'XPC_FLAGS': '0x0', 07:22:09 INFO - 'XPC_SERVICE_NAME': '0', 07:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22: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)) 07:22:09 INFO - Cleaning up... 07:22:09 INFO - Return code: 0 07:22:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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 0x106609b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10660c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb52b5b17c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, '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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 07:22: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 07:22: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 07:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:09 INFO - 'HOME': '/Users/cltbld', 07:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:09 INFO - 'LOGNAME': 'cltbld', 07:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:09 INFO - 'MOZ_NO_REMOTE': '1', 07:22:09 INFO - 'NO_EM_RESTART': '1', 07:22:09 INFO - 'PAGER': '/bin/cat', 07:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:09 INFO - 'PWD': '/builds/slave/test', 07:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:09 INFO - 'SHELL': '/bin/bash', 07:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:22:09 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:09 INFO - 'USER': 'cltbld', 07:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:09 INFO - 'XPC_FLAGS': '0x0', 07:22:09 INFO - 'XPC_SERVICE_NAME': '0', 07:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:22:09 INFO - Cleaning up... 07:22:09 INFO - Return code: 0 07:22:09 INFO - Running post-action listener: _resource_record_post_action 07:22:09 INFO - Running post-action listener: _start_resource_monitoring 07:22:10 INFO - Starting resource monitoring. 07:22:10 INFO - [mozharness: 2017-03-07 15:22:10.024390Z] Finished create-virtualenv step (success) 07:22:10 INFO - [mozharness: 2017-03-07 15:22:10.025408Z] Running install step. 07:22:10 INFO - Running pre-action listener: _resource_record_pre_action 07:22:10 INFO - Running main action method: install 07:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:10 INFO - Reading from file tmpfile_stdout 07:22:10 INFO - Detecting whether we're running mozinstall >=1.0... 07:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:22:10 INFO - Reading from file tmpfile_stdout 07:22:10 INFO - Output received: 07:22:10 INFO - Usage: mozinstall [options] installer 07:22:10 INFO - Options: 07:22:10 INFO - -h, --help show this help message and exit 07:22:10 INFO - -d DEST, --destination=DEST 07:22:10 INFO - Directory to install application into. [default: 07:22:10 INFO - "/builds/slave/test"] 07:22:10 INFO - --app=APP Application being installed. [default: firefox] 07:22:10 INFO - mkdir: /builds/slave/test/build/application 07:22: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'] 07:22: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 07:22:30 INFO - Reading from file tmpfile_stdout 07:22:30 INFO - Output received: 07:22:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:22:30 INFO - Running post-action listener: _resource_record_post_action 07:22:30 INFO - [mozharness: 2017-03-07 15:22:30.910478Z] Finished install step (success) 07:22:30 INFO - [mozharness: 2017-03-07 15:22:30.910608Z] Running run-tests step. 07:22:30 INFO - Running pre-action listener: _resource_record_pre_action 07:22:30 INFO - Running main action method: run_tests 07:22:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:22:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:22:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:22:30 INFO - 2017-03-07 07:22:30.925 screenresolution[2520:21558] starting screenresolution argv=screenresolution get 07:22:30 INFO - 2017-03-07 07:22:30.928 screenresolution[2520:21558] Display 0: 1600x1200x32@60 07:22:30 INFO - 2017-03-07 07:22:30.933 screenresolution[2521:21560] starting screenresolution argv=screenresolution list 07:22:30 INFO - Available Modes on Display 0 07:22:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:22:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:22:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:22:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:22:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:22:31 INFO - Intel Iris: 07:22:31 INFO - Chipset Model: Intel Iris 07:22:31 INFO - Type: GPU 07:22:31 INFO - Bus: Built-In 07:22:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:22:31 INFO - Vendor: Intel (0x8086) 07:22:31 INFO - Device ID: 0x0a2e 07:22:31 INFO - Revision ID: 0x0009 07:22:31 INFO - Displays: 07:22:31 INFO - Display: 07:22:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:22:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:22:31 INFO - Display Serial Number: 1600x1200 60 07:22:31 INFO - Main Display: Yes 07:22:31 INFO - Mirror: Off 07:22:31 INFO - Online: Yes 07:22:31 INFO - Rotation: Supported 07:22:31 INFO - Return code: 0 07:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:22:31 INFO - Python 2.7.3 07:22:31 INFO - Return code: 0 07:22:31 INFO - grabbing minidump binary from tooltool 07:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063e7d30>, '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 0x10630edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1063dcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:22:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:22:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:22:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:22:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:22:31 INFO - Return code: 0 07:22:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:22:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:22:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:22:31 INFO - ENV: RUST_BACKTRACE is now 1 07:22:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:22:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:22:31 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 07:22:31 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0330 --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 07:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oh4IBao0L7/Render', 07:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:22:31 INFO - 'HOME': '/Users/cltbld', 07:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:22:31 INFO - 'LOGNAME': 'cltbld', 07:22:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:22:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:31 INFO - 'MOZ_NO_REMOTE': '1', 07:22:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:22:31 INFO - 'NO_EM_RESTART': '1', 07:22:31 INFO - 'PAGER': '/bin/cat', 07:22:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:31 INFO - 'PWD': '/builds/slave/test', 07:22:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:22:31 INFO - 'RUST_BACKTRACE': '1', 07:22:31 INFO - 'SHELL': '/bin/bash', 07:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rLXrnUWZ80/Listeners', 07:22:31 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 07:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:22:31 INFO - 'USER': 'cltbld', 07:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:31 INFO - 'XPC_FLAGS': '0x0', 07:22:31 INFO - 'XPC_SERVICE_NAME': '0', 07:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:22:31 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 07:22:31 INFO - mozversion application_buildid: 20170307060527 07:22:31 INFO - mozversion application_changeset: 1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83 07:22:31 INFO - mozversion application_display_name: Nightly 07:22:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:22:31 INFO - mozversion application_name: Firefox 07:22:31 INFO - mozversion application_remotingname: firefox 07:22:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:22:31 INFO - mozversion application_vendor: Mozilla 07:22:31 INFO - mozversion application_version: 55.0a1 07:22:31 INFO - mozversion platform_buildid: 20170307060527 07:22:31 INFO - mozversion platform_changeset: 1fb56ba248d5018f8a3314f3d5ff3d9a2c044d83 07:22:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:22:31 INFO - mozversion platform_version: 55.0a1 07:22:31 INFO - using testdate: 1488900151 07:22:31 INFO - actual date: 1488900151 07:22:31 INFO - starting webserver on 'localhost:54405' 07:22:31 INFO - SUITE-START | Running 2 tests 07:22:31 INFO - TEST-START | dromaeo_css 07:22:31 INFO - operating with platform_type : mac_ 07:22:31 INFO - Initialising browser for dromaeo_css test... 07:22:31 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpYt1Ion/profile http://localhost:54405/getInfo.html) 07:22:34 INFO - PROCESS | 2531 | 2017-03-07 07:22:34.470 plugin-container[2533:21732] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904b, name = 'com.apple.tsm.portname' 07:22:34 INFO - PROCESS | 2531 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:22:34 INFO - PROCESS | 2531 | 2017-03-07 07:22:34.473 plugin-container[2533:21732] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 07:22:34 INFO - PROCESS | 2531 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:22:34 INFO - PROCESS | 2531 | 2017-03-07 07:22:34.473 plugin-container[2533:21732] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:22:34 INFO - PROCESS | 2531 | __metrics Screen width/height:1600/1200 07:22:34 INFO - PROCESS | 2531 | colorDepth:24 07:22:34 INFO - PROCESS | 2531 | Browser inner width/height: 1024/689 07:22:34 INFO - PROCESS | 2531 | __metrics 07:22:34 ERROR - PROCESS | 2531 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:22:35 INFO - TEST-INFO | 2531: exit 0 07:22:35 INFO - Browser initialized. 07:22:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:22:35 INFO - TEST-INFO | started process 2534 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpYt1Ion/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:22:37 INFO - PROCESS | 2534 | 2017-03-07 07:22:37.659 plugin-container[2535:21865] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 07:22:37 INFO - PROCESS | 2534 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:22:37 INFO - PROCESS | 2534 | 2017-03-07 07:22:37.659 plugin-container[2535:21865] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 07:22:37 INFO - PROCESS | 2534 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:22:37 INFO - PROCESS | 2534 | 2017-03-07 07:22:37.659 plugin-container[2535:21865] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:22:47 INFO - PROCESS | 2534 | RSS: Main: 227082240 07:22:47 INFO - PROCESS | 2534 | 07:25:51 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:54405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54405/tests/dromaeo/cssquery-ext.html) 07:25:52 INFO - PROCESS | 2534 | RSS: Main: 251826176 07:25:52 INFO - PROCESS | 2534 | 07:27:35 INFO - PROCESS | 2534 | ************************* 07:27:35 INFO - PROCESS | 2534 | A coding exception was thrown and uncaught in a Task. 07:27:35 INFO - PROCESS | 2534 | 07:27:35 ERROR - PROCESS | 2534 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:27:35 INFO - PROCESS | 2534 | Full stack: 07:27:35 INFO - PROCESS | 2534 | ************************* 07:28:54 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:54405/tests/dromaeo/cssquery-ext.html (next: http://localhost:54405/tests/dromaeo/cssquery-jquery.html) 07:28:55 INFO - PROCESS | 2534 | RSS: Main: 257974272 07:28:55 INFO - PROCESS | 2534 | 07:31:57 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:54405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54405/tests/dromaeo/cssquery-mootools.html) 07:31:58 INFO - PROCESS | 2534 | RSS: Main: 270102528 07:31:58 INFO - PROCESS | 2534 | 07:35:00 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:54405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54405/tests/dromaeo/cssquery-prototype.html) 07:35:00 INFO - PROCESS | 2534 | RSS: Main: 263028736 07:35:00 INFO - PROCESS | 2534 | 07:38:03 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:54405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54405/tests/dromaeo/cssquery-yui.html) 07:38:04 INFO - PROCESS | 2534 | RSS: Main: 272621568 07:38:04 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:54405/tests/dromaeo/cssquery-yui.html (next: http://localhost:54405/tests/dromaeo/cssquery-dojo.html) 07:41:07 INFO - PROCESS | 2534 | RSS: Main: 266616832 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | __start_tp_report 07:41:07 INFO - PROCESS | 2534 | _x_x_mozilla_page_load 07:41:07 INFO - PROCESS | 2534 | _x_x_mozilla_page_load_details 07:41:07 INFO - PROCESS | 2534 | |i|pagename|runs| 07:41:07 INFO - PROCESS | 2534 | |0;dojo.html;3411.1472131967007;3414.3512732580793;3432.3306955143757;3435.1240433689404;3446.345194413062;5800.738966746496;5988.281406231247;6009.549283803716;6027.969860150699;6073.969630151854;5936.347001829806;6004.5796794224425;6023.096535519674;6074.939250607504;6117.510599152069;4989.426215985154;5410.377806552257;5431.429699881505;5496.917546236809;5595.944040559583;5385.892282154355;5455.345358556959;5513.8345849624575;5563.471470210324;5581.553475721932;5316.12283973144;5322.281491998569;5351.170568561879;5353.732313384354;5469.261649677303;4553.385292985437;4652.74409907455;5370.275012873251;5419.187121931703;5728.169415434739;4414.955850441519;5301.443348448396;5358.758855851496;5387.353517577876;5423.403425623178;5234.398044224925;5399.379071406799;6004.309504406961;6071.2714474263375;6080.361562036011;6208.87582248357;6235.033569796688;6261.937380626181;6277.340879207663;6287.591306565058;5431.755570999315;6413;6422.068581042421;6450.774222902176;6512.381323774234;6061.605995610359;6139.201903752483;6150.292716337589;6164.321924588292;6179.84550386244;5294.655847369909;6233.283172435137;6366.108744775735;6374.872502550016;6383.71273292703;6137.131844484677;6185.072239164161;6258.061290806416;6266.091416744546;6299.118123462719;4834.419869615598;6118.20463339763;6246.406591373812;6248.968755156286;6307.747690092345;6104.725287362079;6250.15622890913;6305.117283580303;6327.96836015817;6333.303336632966;6198.0702894566175;6235.781747638811;6307.274663413675;6317.873642527124;6321.051842223703;5061.924071138936;5073.365829271341;5073.441921388644;5099.23511473282;5124.590032797368;4581.198290299184;4587.266037434061;4589.678722489461;4603.125406172817;4635.884102897455;6074.726637301332;6114.908276375858;6115.205023346936;6120.540959428061;6128.662923539159;6193.938060619336;6228.750849966042;6371.2477026750485;6390.5526613136635;6404.48764098871;5979.1629171915965;5994.1608174855555;6053.4551890330085;6062.514998800174;6111.449969502766;5633.774649014075;5644.379118296984;5646.661200327993;5656.660600363992;5657.915131273035;6249.7187626557825;6436.195475565554;6442.194725659293;6486.708098135689;6487;6244.718987645476;6290.025046117859;6351.3331100235655;6386.648734319657;6405.519586030973;6593.208814942238;6599;6600.900986485302;6609.272979972296;6631.237407698177;6292.779752708633;6330.52521060913;6341.841453963688;6345.8730825384155;6361.745530178741;5435.266239057834;6225.346338634378;6254.655993920196;6259.624422534663;6289.9056514153235;6259.655718935503;6271.216097987752;6273.435390814849;6278.372162783685;6295.244570651551;6126.029144987285;6190.597611155261;6218.533609979179;6283.560150789401;6287.685615719104;6137.989923150331;6155.1382806406245;6225.221847269091;6269.686515674107;6279.937200628118;6214.5028397728975;6256.405641464054;6269.811905642838;6284.717187726655;6285.937140628535;4890.828820991248;5002.674826136289;6218.756248750177;6246.843828904132;6252.874942501216 07:41:07 INFO - PROCESS | 2534 | |1;ext.html;701.5159539917456;765.8851172324152;784.019975031211;926.1618235496878;927.601131513449;30513.38973220534;36212;38565.614343856556;38690;38809.80595097024;37461.625383746155;37704.86885393443;37730.24539509208;37735.43396849049;37753.24493510135;7688.807779805522;7783.027121609799;10425.530851111718;10689.572417103307;10848.837267440995;10459.947700261526;10531.31546449482;10577.894221057806;10579.3652380857;10579.36523808574;10578.523966421491;10614.840777388345;10627.256092073558;10637.574497020149;10644.893551064506;10571.841422378671;10574.841377379345;10579.206559507991;10608.840867386996;10613.41626210558;10343.37939723619;10350.378977261389;10359.326643768207;10382.896171038268;10382.9480852596;32716.6728332716;32813.6718632813;32861.34277314464;32886.01341959745;32903.83548082268;3338.749593780452;3679.2089700714473;3706.4069748840056;3713.350163721365;3723.3298006358846;24450.388740281636;25291.62062569063;25306.49387012268;25358.619620705704;25486.617700734503;2986.4475072111727;3014.110837303001;3048.878044878202;3088.042706760911;3140.654528001918;324159;344500;346014;347613;348263;32901.67098328986;42736;42782;42783.14433711308;42856.571434285885;43728.781356093015;43776.781116094215;43827.78086109549;43900.90247743768;43963.78018109953;12820.35898205086;12831.807522887164;12910;12913.418896149697;12919.418626161845;10251.538680759384;10990.230683852213;10997.505112269968;11014.559417623206;11030.172737044593;9275.350725449154;11428.599998999995;11501.309921404576;11599.956003959684;11635.941820290844;5618.550515958714;5691.345495268014;5692.544596432275;5705.686187259741;5719.256496655408;940.8917974433028;1085.9674209773718;1117.519466629341;1117.7876203521305;1128.041165009735;26006.86996565043;26202.213933582025;26291.47417051648;26377.208683739518;27775.58336624952;1040.7606250562412;1040.8334666453331;1073.5974009746344;1074.2426589254712;1074.4949873559415;11268.15488838324;12596;12828.935855320664;13228.801567976489;13508.392122354519;465330;467683;470020;470083;473052;44338.556614433444;44674.55325446769;44691;44694.10611787746;44704.77647611806;1270.2378572856212;1351.6891115043595;1381.240317825192;1394.707111506595;1397.3083323754806;20406.795932040488;25844;26190.95236190607;26192.607110893732;26278.21165365042;38295.80852095722;38763.61236387713;38771.224575508895;38777.418338724376;38861;441083;443516;444423;444820;445902;28298.858505708162;28520.714792851806;28871;28879.7112028877;28928.566071508525;36372.27255454823;36853.815730921175;36940.26119477542;37044;37054.44418333673;29477;30706.078817635505;31126.688733113286;32366.029019129463;33279;31291.68708312979;31851.840740797074;32800;33014.33971320512;33168.00495985124;32036.5194522087;32145.517817232292;32736.672633274316;32935;32950.83524582362;25869.353266168495;27492.725072749017;29151.7084829149;29257.85371073131;29497.705022950355;22266.666000010337;22818.885905570365;22893.54212915699;22992.864627513198;23271.301860944197 07:41:07 INFO - PROCESS | 2534 | |2;jquery.html;385.66832524029337;386.1658816955377;387.275794264725;398.4939127308318;414.5150174296073;13057.542985995493;14622.488212912524;19597.314094006713;20836.791632083674;20847.99999999998;20231.49421264469;20807.375778726662;21420.14319427225;21524.677129843065;21691.67462488064;5434.864128396792;6405.647689377082;6527.379898909619;6553.737850485999;6562.310957349481;6526.869462610745;6579.80260592183;6622.8675426491445;6630.336966303355;6974.372306492414;7408.444366672494;7458.328750412462;7460.29127232912;7468.327850493454;7475.439342049341;7133.108361454818;7347.191808901017;7363.969044333798;7387.630618469082;7428.962855185717;6989.196242432135;7043.823904402379;7120.608366539838;7128.073350464459;7148.49960502765;19861.808291502555;20116.39650810478;20342.491437714027;20469.8976505118;25811.870940645364;2401.5677178107935;2809.761170300527;2881.9135425937257;2927.7072292770767;3038.8024778389336;14818.851811481854;14978.62553436162;15856.44502442409;16125.274362653709;16222;1987.2547794577033;2026.6656001759693;2043.264424807083;2053.712480252766;2060.536379314657;129897;151693;159404.40595594127;161851;163900.9999999988;15890.602734931488;19386.933718645327;19803.801961980484;20834.270800522212;20858.582828343653;30267.545986810215;30338.54492182619;30404.087877363716;30472;30626.54060189099;9522.428654280766;9642.807143857084;9765;9910.900890991143;9982.800343993225;8122.268995790408;8133.146019667968;8151.592420378957;8298.751037468886;8298.958505207556;9339.579718912666;9357.157855793012;9425.434473931586;9663.516824158763;9752;3538.8053657048595;3770.6606405423095;3912.5304963404005;3978.8209530571194;3990.920181596352;1028.6348346337093;1036.9014943580348;1043.7912417516527;1056.487603512296;1057.4765491081964;20016.2994295199;20239.356915755307;20329.491762705755;20370.388888333375;20429.897850510653;921.8755468011867;1006.6124542051363;1048.3552615141632;1084.1706094837455;1086;10156.339837910513;10490.527926243338;10560.943905609378;10580.470976451146;10639.202059845542;653838.4616153872;678260;693229;717910;718180;127797;127930;129866;130509.69490305166;133574.99637505444;1188.7681902029194;1194.4326444938758;1217.549506682533;1218.20207763913;1221.7373264747944;16727.24727387246;17681.939083655023;18159.819611725197;18233.270669173085;18342.358017469323;57940;58050.419495804505;59379.14035587673;59540.106898397426;61486.38513614806;62833.37166628275;77121.30075447333;81678.59160704158;81818;82418.17581824106;10539.15686745074;10781.514831832743;11071.225014249247;11073.280236784583;11292.661220163409;12222;12465;12524.373781310716;12537.549170044504;12645.620631381073;10610.89389106099;10632.415217162821;10826.945865270623;10828.891711082788;10883.23817332779;10381.377117372982;10409.115225205942;10433.426161561187;10730.570777168827;10772.407517586607;10763.623273185402;10816.729581760519;10853.348799071766;10870.286464136525;11039.503222355173;9768.413895166314;9831.901680983385;10762.139028877828;11106.000459958643;11209.49557269941;10007.749806254902;10319.94840025825;10667.253292269466;10849.728756781144;10851.565937362733 07:41:07 INFO - PROCESS | 2534 | |3;mootools.html;1522.0791421190172;1544.8068991376078;1566.4204244429563;1566.7884835547202;1572.6854629074187;9101.453912765239;9352.392094513869;10147.949260253698;10721.946390268047;10754.300970436925;9928.55321510532;10311.381317120959;10312.38125712456;10333;10345.793084138313;1981.782003979561;2280.350100221433;2316.6409206573007;2322.581935251654;2325.8139348852137;2270.2962081754627;2293.4037150340946;2304.331743794298;2318.026428899866;2320.895559699809;2285.02886273334;2304.343262170282;2309.4341886237894;2310.5263420998654;2314.8148148148107;1842.5209445544122;2282.5549017941507;2282.8287878409187;2283.3264187064856;2289.5535370602656;1800.891946483202;2224.043661225672;2326.441654003044;2334.4747431827873;2335.8832058397184;10756.462176891202;10816.134709223243;10817.675469735921;10835.83746243799;10971.396573188471;4833.734144622044;5591.077472217079;5702.059160238556;5797;5829.154772557956;2936.809107408033;3250.414925313443;3348.782329148622;3570.410882204459;3587.3542762302777;1130.7568872692411;1168.299020587649;1171.4025846818183;1185.365829281339;1221.2855479544478;14554;14562.781558276634;14624.268786560735;14633.780493292608;14723.779143312859;4711.481737008926;4720.669553131248;4829.66192366531;4914.8771280718265;4967.130752118364;12358.62924112278;12383.19509231897;12407.25556466615;12418.254904705747;12436.689082773004;5799.768009279666;5812.709364531756;5813.372255768391;5814.651120932757;5824.475797178275;5080.568151707146;5092;5122.820701275437;5130.9230361544605;5155.948440515547;3909.6481316681634;3994.800259986989;4025.094353770437;4071.3485842265095;4088.4055218464823;1124.7975364434317;1132.416805345248;1134.6936327191613;1141.4578075414113;1146.3007565385108;700.4396482813729;739.8643082867773;777.8249893773968;796.7291121018766;828.1676914700807;6190.690465476709;6348.333424990309;6849.760258390932;6867.896981545281;6868.072810170663;1028.6142696488816;1031.8039572481205;1041.520900385831;1044.2637940252105;1047.8218702820539;3333.3499967506586;4270.615644592001;4312.762798046075;4351.543087975717;4400.559944005638;12284.385780710929;12763.361831908553;13072.084954053315;13511.729765404636;13623.455061797416;12069.456874440495;12903.612891613267;13438.731225375437;13439.260840653858;13459.125156864773;9777.804443911082;9784.510774461249;9796.804063918824;9980.850287245697;9984.951580084133;6372.267189273293;6375.330590287953;6466.256380516301;6506.316836732075;6522.597641507099;11489.425528723697;11809.11431642613;11924;12050.457729402022;12059.15585908978;11896.821547676966;12046.879531204575;12049.819252711392;12088.939555302168;12112.636620901387;8213.835723285381;8533.189347012023;8552.700655477278;8553.786155346166;8566.78583035429;8377.832443350977;9816.754581135528;10114.696559103239;10121.342112762646;10131.797364052825;7050.012998180361;7895.6841726332605;8285.792855178668;8736.344774141837;9035.412698174598;8718.389712720049;8813.118688131392;8836.602352894006;8848.513331766815;8897.955510222408;7655.2344765523;7696.307332340116;7785.805354866174;7787.961060194662;7863.52818830872;5766.077427611562;5796;5796.188533605383;5947.018741907536;5965.821025369246;5927.214209321612;5948.910766338422;5952.285725712942;5953.910691339547;5954.46409823118 07:41:07 INFO - PROCESS | 2534 | |4;prototype.html;314.08287799625094;361.5318162978942;363.31515094047745;363.6182008890665;373.098965997117;4865.513448655132;4974.527419895113;5027.396712394518;5197.570668066283;5285.127953887604;4373.890652733683;4895.63282753794;4995.825980894487;5123.923141152876;5200.349956255468;4123.154753275587;4142.937855932171;4251.404803327537;4276.593723596269;4314.870553883388;4133.937990930123;4211.515675697304;4302.752201861456;4309.762963037032;4355.499117601469;4243.957560424403;4279.572042795711;4302.096559722462;4303.892402689927;4336.744892655817;3674.706023518112;3859.9192226176715;4034.7175697701173;4129.587041295861;4146.232946904802;3232.7090561849313;3661.5423072115987;3916.64750172483;3933.7639741615594;3959.6933012105937;4216;4448.532904045093;4471.3274628013805;4651.953480465186;4678.415198100238;4561.126490311116;4631.698939568917;4694;4860.538248866352;4928.162212423897;4866.7566621668775;5520.006398848206;5601.103823388279;5622.076520209509;5635.6055076144685;3838.827252773604;4408.58118478744;4439.711418757803;4446.911061778746;4447.3329000650165;5412.783488660449;5481.5340696040885;5698.544116470673;5775.123084997393;5904.5571582131515;4353.455818022747;4403.392761641978;4408.515063343029;4426.73439593619;4484.439445069366;4036.6367026967127;4548.590626843534;4558.088382323548;4581.9541804582195;4652.209124448852;3825.540935087807;4851.296561998561;4942.9258561121615;4942.9258561121615;5002.849914502571;5107.387113546398;5217.660852044605;5364.597655175878;5397.141044153371;5397.298351214317;1363.4205462678322;1495.9079871693725;1515.6514001779653;1538.9769153462707;1552.5109590478962;1026.4098143567478;1033.7829055898346;1078.2667785905503;1156.8322593224104;1177.9764404711857;4626.699264547794;5087.949120508822;5099.260607211933;5123.181270648941;5129.948700512947;5145.228215767665;5302.681839089667;5462.317210348707;5705;5762.394948530344;4326.697131200785;4469.815498892796;4944.307796908436;5126.666766660155;5144.897102058013;2681.5441374966304;2795.063653676041;2839.2192147159285;2910.2433367324647;2950.904857551163;5244.6328756987405;5579.944200557942;5810.477057064884;5813.1515557377425;5871.266091738533;4629.768511574475;5039.420466646309;5397.893431846462;5519.289020403688;5648.858778530487;5390.676559406448;5460.34475862899;5588.86027849307;5718.485336319751;5903.498202652737;5006.574441172541;5440.409329842285;5521.355905102613;5621.550275977994;5657.811859509549;4451.707370704025;4901.077121501086;5131.844625257476;5242.449542798104;5554.222408862844;4998.475464983215;5374.978754036721;5597.888042239214;5628.971855140698;5960.284765828128;3664.6152154023443;3723.5238566353073;3979.9254201366048;4062.73592216505;4565.840195593271;5268.155196194166;5371.570274377962;5371.785128594813;5440.755166017618;5671.829845104653;4589.885252868571;5338.279332290091;5474.562035037108;5547.472990065938;5598.300212473441;4781.589431117898;5309.36287645485;5476.2607048048;5484.506394424361;5625.943740562542;4614.284785858197;4703.435587729357;4903.798569350532;4948.727819969936;5245.531251249657;4647.604953578849;4850.7574621269505;5337.866553336043;5440.891182176413;5454.536364408911;4654.604358629419;5231.869203269796;5373.892522149457;5382.178653156303;5400.2439658447065 07:41:07 INFO - PROCESS | 2534 | |5;yui.html;691.6438034412275;720.6324774365074;749.3555542233678;758.6168984662744;832.7876391520159;12344.135910486259;16480.42318518852;16523.50429487116;16537.58656033598;16707.916460417713;15236.695266094672;15344.61638459039;15373.461928832494;15416;15446.99594526355;916.1662886773055;944.914957653811;946.4794363100302;947.5215016416699;948.7817801905566;879.8284334554733;951.5955718819508;955.4124213608616;966.3235734985503;968.1480297338333;984.6356847966263;994.6866736977829;997.9051990060933;999.215615741643;1001.4341896828269;989.9703008909744;994.2344394815988;994.567363197008;994.8060128274989;995.0845222395413;732.4104096202555;738.1806195123409;738.7119023580808;740.311510295425;741.1032650492856;15990;16621.83378166227;16674.66650666992;17020.82979170205;17278.56803579908;13750.814356546376;13852;13986.720265594733;14013.229272390014;14066.788998165035;11145.72135696606;11293.040091592224;11372.829407558893;11399.943000285028;11716.179867409284;3578.8568457261676;3609.1338078861145;3622.510961020255;3674.8346324415197;3733.0667333166707;79981.20018799853;97663;113312;113946;115506;10408;10546.947265263625;10589.629362972259;10721;10847.132229421628;22377.776222237895;22713;22714.772852271264;22879;22903.656445153338;7435.8141046474275;7514.699412023567;7536.0956685198125;7579.886301705479;7771.222877712184;4138.255114079495;4194;4250.978745106317;4263.126059157865;4361.5856493633055;3394.35507253621;3492.7205823534055;3493.039414161075;3494.2312691207894;3495.650434956535;606.8422210225373;614.1923370767427;617.3733660334764;628.9119523266746;630.4357599948021;660.9008648702733;676.4655921821804;683.6820878291519;696.885013972699;697.7368279810355;7999.760007199677;9310.72067837966;10101.646442374482;10146.644867429604;10513.684589462327;556.8552176434075;669.397542212013;680.5221641598272;689.290031267795;692.5948320232619;4580.312953057068;4964;5006.19900815875;5018.749062546858;5059.19052951526;70960;91690.54154729316;94014.5299273513;97096.51451742696;99956.00043999612;49870.50388488351;62542.687286563276;67085.65828683399;77650;89066;47140;54219;72631.63684181546;85917;89582.55208723915;8886.289096872364;9481.899370066194;9669.145166924385;10488;11128.721781955515;52996.47003529916;53562.46437535575;54656.18015729847;54777.726111369186;55040.72479637736;58347.83304333974;59032;61064;68000;68023.36274387971;13008.479660813462;13015.414306356048;13273.137246078973;13422.328883555978;14124.43502259898;11229.831552526883;11644.825327619923;12157.392130393268;14189.787153192918;14646.414143434144;12606.684832878884;13840.446382145004;13852.151746888509;14079.103157831616;14114.435422583392;13093;13273.601791946257;13498.460061597427;13593.184408935496;14165.504207352693;13041;13298.190966814625;13560.728785424039;13587.932060339635;14264.072835265675;10608.310459820086;10927.56289748433;11056.944715276371;11153.665390038312;11653.53385864556;8029.350314396352;10151.390916545031;10364.689059328231;10513.78972420532;11303.095752339628 07:41:07 INFO - PROCESS | 2534 | __end_tp_report 07:41:07 INFO - PROCESS | 2534 | __start_cc_report 07:41:07 INFO - PROCESS | 2534 | _x_x_mozilla_cycle_collect,426 07:41:07 INFO - PROCESS | 2534 | __end_cc_report 07:41:07 INFO - PROCESS | 2534 | __startTimestamp1488901267760__endTimestamp 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | ------- Summary: start ------- 07:41:07 INFO - PROCESS | 2534 | Number of tests: 6 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | [#0] dojo.html Cycles:165 Average:5864.99 Median:6139.20 stddev:671.36 (10.9%) stddev-sans-first:645.23 07:41:07 INFO - PROCESS | 2534 | Values: 3411.1 3414.4 3432.3 3435.1 3446.3 5800.7 5988.3 6009.5 6028.0 6074.0 5936.3 6004.6 6023.1 6074.9 6117.5 4989.4 5410.4 5431.4 5496.9 5595.9 5385.9 5455.3 5513.8 5563.5 5581.6 5316.1 5322.3 5351.2 5353.7 5469.3 4553.4 4652.7 5370.3 5419.2 5728.2 4415.0 5301.4 5358.8 5387.4 5423.4 5234.4 5399.4 6004.3 6071.3 6080.4 6208.9 6235.0 6261.9 6277.3 6287.6 5431.8 6413.0 6422.1 6450.8 6512.4 6061.6 6139.2 6150.3 6164.3 6179.8 5294.7 6233.3 6366.1 6374.9 6383.7 6137.1 6185.1 6258.1 6266.1 6299.1 4834.4 6118.2 6246.4 6249.0 6307.7 6104.7 6250.2 6305.1 6328.0 6333.3 6198.1 6235.8 6307.3 6317.9 6321.1 5061.9 5073.4 5073.4 5099.2 5124.6 4581.2 4587.3 4589.7 4603.1 4635.9 6074.7 6114.9 6115.2 6120.5 6128.7 6193.9 6228.8 6371.2 6390.6 6404.5 5979.2 5994.2 6053.5 6062.5 6111.4 5633.8 5644.4 5646.7 5656.7 5657.9 6249.7 6436.2 6442.2 6486.7 6487.0 6244.7 6290.0 6351.3 6386.6 6405.5 6593.2 6599.0 6600.9 6609.3 6631.2 6292.8 6330.5 6341.8 6345.9 6361.7 5435.3 6225.3 6254.7 6259.6 6289.9 6259.7 6271.2 6273.4 6278.4 6295.2 6126.0 6190.6 6218.5 6283.6 6287.7 6138.0 6155.1 6225.2 6269.7 6279.9 6214.5 6256.4 6269.8 6284.7 6285.9 4890.8 5002.7 6218.8 6246.8 6252.9 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | [#1] ext.html Cycles:180 Average:53773.97 Median:30609.73 stddev:112236.56 (366.7%) stddev-sans-first:112480.67 07:41:07 INFO - PROCESS | 2534 | Values: 701.5 765.9 784.0 926.2 927.6 30513.4 36212.0 38565.6 38690.0 38809.8 37461.6 37704.9 37730.2 37735.4 37753.2 7688.8 7783.0 10425.5 10689.6 10848.8 10459.9 10531.3 10577.9 10579.4 10579.4 10578.5 10614.8 10627.3 10637.6 10644.9 10571.8 10574.8 10579.2 10608.8 10613.4 10343.4 10350.4 10359.3 10382.9 10382.9 32716.7 32813.7 32861.3 32886.0 32903.8 3338.7 3679.2 3706.4 3713.4 3723.3 24450.4 25291.6 25306.5 25358.6 25486.6 2986.4 3014.1 3048.9 3088.0 3140.7 324159.0 344500.0 346014.0 347613.0 348263.0 32901.7 42736.0 42782.0 42783.1 42856.6 43728.8 43776.8 43827.8 43900.9 43963.8 12820.4 12831.8 12910.0 12913.4 12919.4 10251.5 10990.2 10997.5 11014.6 11030.2 9275.4 11428.6 11501.3 11600.0 11635.9 5618.6 5691.3 5692.5 5705.7 5719.3 940.9 1086.0 1117.5 1117.8 1128.0 26006.9 26202.2 26291.5 26377.2 27775.6 1040.8 1040.8 1073.6 1074.2 1074.5 11268.2 12596.0 12828.9 13228.8 13508.4 465330.0 467683.0 470020.0 470083.0 473052.0 44338.6 44674.6 44691.0 44694.1 44704.8 1270.2 1351.7 1381.2 1394.7 1397.3 20406.8 25844.0 26191.0 26192.6 26278.2 38295.8 38763.6 38771.2 38777.4 38861.0 441083.0 443516.0 444423.0 444820.0 445902.0 28298.9 28520.7 28871.0 28879.7 28928.6 36372.3 36853.8 36940.3 37044.0 37054.4 29477.0 30706.1 31126.7 32366.0 33279.0 31291.7 31851.8 32800.0 33014.3 33168.0 32036.5 32145.5 32736.7 32935.0 32950.8 25869.4 27492.7 29151.7 29257.9 29497.7 22266.7 22818.9 22893.5 22992.9 23271.3 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | [#2] jquery.html Cycles:180 Average:39932.89 Median:11261.81 stddev:115493.41 (1025.5%) stddev-sans-first:115779.23 07:41:07 INFO - PROCESS | 2534 | Values: 385.7 386.2 387.3 398.5 414.5 13057.5 14622.5 19597.3 20836.8 20848.0 20231.5 20807.4 21420.1 21524.7 21691.7 5434.9 6405.6 6527.4 6553.7 6562.3 6526.9 6579.8 6622.9 6630.3 6974.4 7408.4 7458.3 7460.3 7468.3 7475.4 7133.1 7347.2 7364.0 7387.6 7429.0 6989.2 7043.8 7120.6 7128.1 7148.5 19861.8 20116.4 20342.5 20469.9 25811.9 2401.6 2809.8 2881.9 2927.7 3038.8 14818.9 14978.6 15856.4 16125.3 16222.0 1987.3 2026.7 2043.3 2053.7 2060.5 129897.0 151693.0 159404.4 161851.0 163901.0 15890.6 19386.9 19803.8 20834.3 20858.6 30267.5 30338.5 30404.1 30472.0 30626.5 9522.4 9642.8 9765.0 9910.9 9982.8 8122.3 8133.1 8151.6 8298.8 8299.0 9339.6 9357.2 9425.4 9663.5 9752.0 3538.8 3770.7 3912.5 3978.8 3990.9 1028.6 1036.9 1043.8 1056.5 1057.5 20016.3 20239.4 20329.5 20370.4 20429.9 921.9 1006.6 1048.4 1084.2 1086.0 10156.3 10490.5 10560.9 10580.5 10639.2 653838.5 678260.0 693229.0 717910.0 718180.0 127797.0 127930.0 129866.0 130509.7 133575.0 1188.8 1194.4 1217.5 1218.2 1221.7 16727.2 17681.9 18159.8 18233.3 18342.4 57940.0 58050.4 59379.1 59540.1 61486.4 62833.4 77121.3 81678.6 81818.0 82418.2 10539.2 10781.5 11071.2 11073.3 11292.7 12222.0 12465.0 12524.4 12537.5 12645.6 10610.9 10632.4 10826.9 10828.9 10883.2 10381.4 10409.1 10433.4 10730.6 10772.4 10763.6 10816.7 10853.3 10870.3 11039.5 9768.4 9831.9 10762.1 11106.0 11209.5 10007.7 10319.9 10667.3 10849.7 10851.6 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | [#3] mootools.html Cycles:180 Average:6543.97 Median:3093.61 stddev:4068.44 (131.5%) stddev-sans-first:4062.36 07:41:07 INFO - PROCESS | 2534 | Values: 1522.1 1544.8 1566.4 1566.8 1572.7 9101.5 9352.4 10147.9 10721.9 10754.3 9928.6 10311.4 10312.4 10333.0 10345.8 1981.8 2280.4 2316.6 2322.6 2325.8 2270.3 2293.4 2304.3 2318.0 2320.9 2285.0 2304.3 2309.4 2310.5 2314.8 1842.5 2282.6 2282.8 2283.3 2289.6 1800.9 2224.0 2326.4 2334.5 2335.9 10756.5 10816.1 10817.7 10835.8 10971.4 4833.7 5591.1 5702.1 5797.0 5829.2 2936.8 3250.4 3348.8 3570.4 3587.4 1130.8 1168.3 1171.4 1185.4 1221.3 14554.0 14562.8 14624.3 14633.8 14723.8 4711.5 4720.7 4829.7 4914.9 4967.1 12358.6 12383.2 12407.3 12418.3 12436.7 5799.8 5812.7 5813.4 5814.7 5824.5 5080.6 5092.0 5122.8 5130.9 5155.9 3909.6 3994.8 4025.1 4071.3 4088.4 1124.8 1132.4 1134.7 1141.5 1146.3 700.4 739.9 777.8 796.7 828.2 6190.7 6348.3 6849.8 6867.9 6868.1 1028.6 1031.8 1041.5 1044.3 1047.8 3333.3 4270.6 4312.8 4351.5 4400.6 12284.4 12763.4 13072.1 13511.7 13623.5 12069.5 12903.6 13438.7 13439.3 13459.1 9777.8 9784.5 9796.8 9980.9 9985.0 6372.3 6375.3 6466.3 6506.3 6522.6 11489.4 11809.1 11924.0 12050.5 12059.2 11896.8 12046.9 12049.8 12088.9 12112.6 8213.8 8533.2 8552.7 8553.8 8566.8 8377.8 9816.8 10114.7 10121.3 10131.8 7050.0 7895.7 8285.8 8736.3 9035.4 8718.4 8813.1 8836.6 8848.5 8898.0 7655.2 7696.3 7785.8 7788.0 7863.5 5766.1 5796.0 5796.2 5947.0 5965.8 5927.2 5948.9 5952.3 5953.9 5954.5 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | [#4] prototype.html Cycles:180 Average:4526.20 Median:4881.19 stddev:1265.90 (25.9%) stddev-sans-first:1229.34 07:41:07 INFO - PROCESS | 2534 | Values: 314.1 361.5 363.3 363.6 373.1 4865.5 4974.5 5027.4 5197.6 5285.1 4373.9 4895.6 4995.8 5123.9 5200.3 4123.2 4142.9 4251.4 4276.6 4314.9 4133.9 4211.5 4302.8 4309.8 4355.5 4244.0 4279.6 4302.1 4303.9 4336.7 3674.7 3859.9 4034.7 4129.6 4146.2 3232.7 3661.5 3916.6 3933.8 3959.7 4216.0 4448.5 4471.3 4652.0 4678.4 4561.1 4631.7 4694.0 4860.5 4928.2 4866.8 5520.0 5601.1 5622.1 5635.6 3838.8 4408.6 4439.7 4446.9 4447.3 5412.8 5481.5 5698.5 5775.1 5904.6 4353.5 4403.4 4408.5 4426.7 4484.4 4036.6 4548.6 4558.1 4582.0 4652.2 3825.5 4851.3 4942.9 4942.9 5002.8 5107.4 5217.7 5364.6 5397.1 5397.3 1363.4 1495.9 1515.7 1539.0 1552.5 1026.4 1033.8 1078.3 1156.8 1178.0 4626.7 5087.9 5099.3 5123.2 5129.9 5145.2 5302.7 5462.3 5705.0 5762.4 4326.7 4469.8 4944.3 5126.7 5144.9 2681.5 2795.1 2839.2 2910.2 2950.9 5244.6 5579.9 5810.5 5813.2 5871.3 4629.8 5039.4 5397.9 5519.3 5648.9 5390.7 5460.3 5588.9 5718.5 5903.5 5006.6 5440.4 5521.4 5621.6 5657.8 4451.7 4901.1 5131.8 5242.4 5554.2 4998.5 5375.0 5597.9 5629.0 5960.3 3664.6 3723.5 3979.9 4062.7 4565.8 5268.2 5371.6 5371.8 5440.8 5671.8 4589.9 5338.3 5474.6 5547.5 5598.3 4781.6 5309.4 5476.3 5484.5 5625.9 4614.3 4703.4 4903.8 4948.7 5245.5 4647.6 4850.8 5337.9 5440.9 5454.5 4654.6 5231.9 5373.9 5382.2 5400.2 07:41:07 INFO - PROCESS | 2534 | 07:41:07 INFO - PROCESS | 2534 | [#5] yui.html Cycles:180 Average:19342.09 Median:4257.05 stddev:27007.16 (634.4%) stddev-sans-first:27046.62 07:41:07 INFO - PROCESS | 2534 | Values: 691.6 720.6 749.4 758.6 832.8 12344.1 16480.4 16523.5 16537.6 16707.9 15236.7 15344.6 15373.5 15416.0 15447.0 916.2 944.9 946.5 947.5 948.8 879.8 951.6 955.4 966.3 968.1 984.6 994.7 997.9 999.2 1001.4 990.0 994.2 994.6 994.8 995.1 732.4 738.2 738.7 740.3 741.1 15990.0 16621.8 16674.7 17020.8 17278.6 13750.8 13852.0 13986.7 14013.2 14066.8 11145.7 11293.0 11372.8 11399.9 11716.2 3578.9 3609.1 3622.5 3674.8 3733.1 79981.2 97663.0 113312.0 113946.0 115506.0 10408.0 10546.9 10589.6 10721.0 10847.1 22377.8 22713.0 22714.8 22879.0 22903.7 7435.8 7514.7 7536.1 7579.9 7771.2 4138.3 4194.0 4251.0 4263.1 4361.6 3394.4 3492.7 3493.0 3494.2 3495.7 606.8 614.2 617.4 628.9 630.4 660.9 676.5 683.7 696.9 697.7 7999.8 9310.7 10101.6 10146.6 10513.7 556.9 669.4 680.5 689.3 692.6 4580.3 4964.0 5006.2 5018.7 5059.2 70960.0 91690.5 94014.5 97096.5 99956.0 49870.5 62542.7 67085.7 77650.0 89066.0 47140.0 54219.0 72631.6 85917.0 89582.6 8886.3 9481.9 9669.1 10488.0 11128.7 52996.5 53562.5 54656.2 54777.7 55040.7 58347.8 59032.0 61064.0 68000.0 68023.4 13008.5 13015.4 13273.1 13422.3 14124.4 11229.8 11644.8 12157.4 14189.8 14646.4 12606.7 13840.4 13852.2 14079.1 14114.4 13093.0 13273.6 13498.5 13593.2 14165.5 13041.0 13298.2 13560.7 13587.9 14264.1 10608.3 10927.6 11056.9 11153.7 11653.5 8029.4 10151.4 10364.7 10513.8 11303.1 07:41:07 INFO - PROCESS | 2534 | -------- Summary: end -------- 07:41:07 INFO - PROCESS | 2534 | 07:41:08 INFO - TEST-INFO | 2534: exit 0 07:41:08 INFO - TEST-OK | dromaeo_css | took 1116910ms 07:41:08 INFO - TEST-START | kraken 07:41:08 INFO - operating with platform_type : mac_ 07:41:08 INFO - Initialising browser for kraken test... 07:41:08 INFO - TEST-INFO | started process 2540 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmp7jl0Sx/profile http://localhost:54405/getInfo.html) 07:41:11 INFO - PROCESS | 2540 | 2017-03-07 07:41:11.117 plugin-container[2541:24079] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 07:41:11 INFO - PROCESS | 2540 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:11 INFO - PROCESS | 2540 | 2017-03-07 07:41:11.120 plugin-container[2541:24079] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 07:41:11 INFO - PROCESS | 2540 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:11 INFO - PROCESS | 2540 | 2017-03-07 07:41:11.120 plugin-container[2541:24079] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:41:11 INFO - PROCESS | 2540 | __metrics Screen width/height:1600/1200 07:41:11 INFO - PROCESS | 2540 | colorDepth:24 07:41:11 INFO - PROCESS | 2540 | Browser inner width/height: 1024/689 07:41:11 INFO - PROCESS | 2540 | __metrics 07:41:11 ERROR - PROCESS | 2540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:41:12 INFO - TEST-INFO | 2540: exit 0 07:41:12 INFO - Browser initialized. 07:41:12 INFO - Running cycle 1/1 for kraken test... 07:41:12 INFO - TEST-INFO | started process 2542 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmp7jl0Sx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:14 INFO - PROCESS | 2542 | 2017-03-07 07:41:14.627 plugin-container[2543:24205] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 07:41:14 INFO - PROCESS | 2542 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:14 INFO - PROCESS | 2542 | 2017-03-07 07:41:14.627 plugin-container[2543:24205] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 07:41:14 INFO - PROCESS | 2542 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:41:14 INFO - PROCESS | 2542 | 2017-03-07 07:41:14.627 plugin-container[2543:24205] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:41:24 INFO - PROCESS | 2542 | RSS: Main: 226635776 07:41:24 INFO - PROCESS | 2542 | 07:41:27 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54405/tests/kraken/driver.html?testName=audio-beat-detection) 07:41:28 INFO - PROCESS | 2542 | RSS: Main: 241680384 07:41:28 INFO - PROCESS | 2542 | 07:41:31 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54405/tests/kraken/driver.html?testName=audio-dft) 07:41:32 INFO - PROCESS | 2542 | RSS: Main: 249815040 07:41:32 INFO - PROCESS | 2542 | 07:41:35 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54405/tests/kraken/driver.html?testName=audio-fft) 07:41:36 INFO - PROCESS | 2542 | RSS: Main: 252153856 07:41:36 INFO - PROCESS | 2542 | 07:41:38 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54405/tests/kraken/driver.html?testName=audio-oscillator) 07:41:38 INFO - PROCESS | 2542 | RSS: Main: 253308928 07:41:38 INFO - PROCESS | 2542 | 07:41:40 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:41:41 INFO - PROCESS | 2542 | RSS: Main: 254984192 07:41:41 INFO - PROCESS | 2542 | 07:41:44 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54405/tests/kraken/driver.html?testName=imaging-darkroom) 07:41:45 INFO - PROCESS | 2542 | RSS: Main: 260788224 07:41:45 INFO - PROCESS | 2542 | 07:41:48 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54405/tests/kraken/driver.html?testName=imaging-desaturate) 07:41:49 INFO - PROCESS | 2542 | RSS: Main: 259899392 07:41:49 INFO - PROCESS | 2542 | 07:41:52 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54405/tests/kraken/driver.html?testName=json-parse-financial) 07:41:53 INFO - PROCESS | 2542 | RSS: Main: 259706880 07:41:53 INFO - PROCESS | 2542 | 07:41:54 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:41:55 INFO - PROCESS | 2542 | RSS: Main: 259690496 07:41:55 INFO - PROCESS | 2542 | 07:41:57 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:41:58 INFO - PROCESS | 2542 | RSS: Main: 259657728 07:41:58 INFO - PROCESS | 2542 | 07:42:00 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:42:01 INFO - PROCESS | 2542 | RSS: Main: 259862528 07:42:01 INFO - PROCESS | 2542 | 07:42:04 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:42:04 INFO - PROCESS | 2542 | RSS: Main: 260083712 07:42:04 INFO - PROCESS | 2542 | 07:42:07 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:42:08 INFO - PROCESS | 2542 | RSS: Main: 259821568 07:42:08 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:54405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54405/tests/kraken/driver.html?testName=ai-astar) 07:42:10 INFO - PROCESS | 2542 | RSS: Main: 263274496 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | __start_tp_report 07:42:10 INFO - PROCESS | 2542 | _x_x_mozilla_page_load 07:42:10 INFO - PROCESS | 2542 | _x_x_mozilla_page_load_details 07:42:10 INFO - PROCESS | 2542 | |i|pagename|runs| 07:42:10 INFO - PROCESS | 2542 | |0;ai-astar;151;181;107;178;182;157;118;147;157;126 07:42:10 INFO - PROCESS | 2542 | |1;audio-beat-detection;150;116;111;155;115;115;117;132;173;147 07:42:10 INFO - PROCESS | 2542 | |2;audio-dft;210;204;202;206;196;203;201;197;205;193 07:42:10 INFO - PROCESS | 2542 | |3;audio-fft;88;58;62;90;60;62;59;63;100;63 07:42:10 INFO - PROCESS | 2542 | |4;audio-oscillator;83;73;93;84;84;73;85;73;71;85 07:42:10 INFO - PROCESS | 2542 | |5;imaging-gaussian-blur;94;106;91;93;93;93;92;92;140;93 07:42:10 INFO - PROCESS | 2542 | |6;imaging-darkroom;126;101;151;154;92;101;99;99;125;102 07:42:10 INFO - PROCESS | 2542 | |7;imaging-desaturate;92;143;142;90;90;94;91;96;91;92 07:42:10 INFO - PROCESS | 2542 | |8;json-parse-financial;66;67;70;103;103;84;67;67;68;69 07:42:10 INFO - PROCESS | 2542 | |9;json-stringify-tinderbox;58;67;63;75;61;59;59;59;59;60 07:42:10 INFO - PROCESS | 2542 | |10;stanford-crypto-aes;107;107;109;90;91;89;90;82;88;88 07:42:10 INFO - PROCESS | 2542 | |11;stanford-crypto-ccm;180;144;139;144;162;130;140;165;220;198 07:42:10 INFO - PROCESS | 2542 | |12;stanford-crypto-pbkdf2;187;178;173;179;163;202;178;178;174;173 07:42:10 INFO - PROCESS | 2542 | |13;stanford-crypto-sha256-iterative;69;69;70;73;96;88;72;66;92;91 07:42:10 INFO - PROCESS | 2542 | __end_tp_report 07:42:10 INFO - PROCESS | 2542 | __start_cc_report 07:42:10 INFO - PROCESS | 2542 | _x_x_mozilla_cycle_collect,1017 07:42:10 INFO - PROCESS | 2542 | __end_cc_report 07:42:10 INFO - PROCESS | 2542 | __startTimestamp1488901330579__endTimestamp 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | ------- Summary: start ------- 07:42:10 INFO - PROCESS | 2542 | Number of tests: 14 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#0] ai-astar Cycles:10 Average:150.40 Median:157.00 stddev:26.51 (16.9%) stddev-sans-first:28.12 07:42:10 INFO - PROCESS | 2542 | Values: 151.0 181.0 107.0 178.0 182.0 157.0 118.0 147.0 157.0 126.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:139.50 stddev:21.72 (15.6%) stddev-sans-first:22.16 07:42:10 INFO - PROCESS | 2542 | Values: 150.0 116.0 111.0 155.0 115.0 115.0 117.0 132.0 173.0 147.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#2] audio-dft Cycles:10 Average:201.70 Median:203.50 stddev:5.12 (2.5%) stddev-sans-first:4.47 07:42:10 INFO - PROCESS | 2542 | Values: 210.0 204.0 202.0 206.0 196.0 203.0 201.0 197.0 205.0 193.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#3] audio-fft Cycles:10 Average:70.50 Median:62.50 stddev:15.68 (25.1%) stddev-sans-first:15.30 07:42:10 INFO - PROCESS | 2542 | Values: 88.0 58.0 62.0 90.0 60.0 62.0 59.0 63.0 100.0 63.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:84.00 stddev:7.35 (8.8%) stddev-sans-first:7.74 07:42:10 INFO - PROCESS | 2542 | Values: 83.0 73.0 93.0 84.0 84.0 73.0 85.0 73.0 71.0 85.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:93.00 stddev:15.13 (16.3%) stddev-sans-first:15.95 07:42:10 INFO - PROCESS | 2542 | Values: 94.0 106.0 91.0 93.0 93.0 93.0 92.0 92.0 140.0 93.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#6] imaging-darkroom Cycles:10 Average:115.00 Median:152.50 stddev:22.71 (14.9%) stddev-sans-first:23.73 07:42:10 INFO - PROCESS | 2542 | Values: 126.0 101.0 151.0 154.0 92.0 101.0 99.0 99.0 125.0 102.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:91.50 stddev:21.37 (23.4%) stddev-sans-first:22.35 07:42:10 INFO - PROCESS | 2542 | Values: 92.0 143.0 142.0 90.0 90.0 94.0 91.0 96.0 91.0 92.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#8] json-parse-financial Cycles:10 Average:76.40 Median:67.50 stddev:14.95 (22.2%) stddev-sans-first:15.38 07:42:10 INFO - PROCESS | 2542 | Values: 66.0 67.0 70.0 103.0 103.0 84.0 67.0 67.0 68.0 69.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:60.50 stddev:5.29 (8.7%) stddev-sans-first:5.41 07:42:10 INFO - PROCESS | 2542 | Values: 58.0 67.0 63.0 75.0 61.0 59.0 59.0 59.0 59.0 60.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:88.50 stddev:9.69 (10.9%) stddev-sans-first:9.08 07:42:10 INFO - PROCESS | 2542 | Values: 107.0 107.0 109.0 90.0 91.0 89.0 90.0 82.0 88.0 88.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#11] stanford-crypto-ccm Cycles:10 Average:162.20 Median:163.50 stddev:29.21 (17.9%) stddev-sans-first:30.26 07:42:10 INFO - PROCESS | 2542 | Values: 180.0 144.0 139.0 144.0 162.0 130.0 140.0 165.0 220.0 198.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.00 stddev:10.26 (5.8%) stddev-sans-first:10.41 07:42:10 INFO - PROCESS | 2542 | Values: 187.0 178.0 173.0 179.0 163.0 202.0 178.0 178.0 174.0 173.0 07:42:10 INFO - PROCESS | 2542 | 07:42:10 INFO - PROCESS | 2542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:80.50 stddev:11.63 (14.4%) stddev-sans-first:11.80 07:42:10 INFO - PROCESS | 2542 | Values: 69.0 69.0 70.0 73.0 96.0 88.0 72.0 66.0 92.0 91.0 07:42:10 INFO - PROCESS | 2542 | -------- Summary: end -------- 07:42:10 INFO - PROCESS | 2542 | 07:42:11 INFO - TEST-INFO | 2542: exit 0 07:42:11 INFO - TEST-OK | kraken | took 63067ms 07:42:11 INFO - SUITE-END | took 1179s 07:42:11 INFO - Completed test suite (00:19:40) 07:42:11 INFO - javascript benchmark 07:42:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7493.771071528343, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3411.1472131967007, 3414.3512732580793, 3432.3306955143757, 3435.1240433689404, 3446.345194413062, 5800.738966746496, 5988.281406231247, 6009.549283803716, 6027.969860150699, 6073.969630151854, 5936.347001829806, 6004.5796794224425, 6023.096535519674, 6074.939250607504, 6117.510599152069, 4989.426215985154, 5410.377806552257, 5431.429699881505, 5496.917546236809, 5595.944040559583, 5385.892282154355, 5455.345358556959, 5513.8345849624575, 5563.471470210324, 5581.553475721932, 5316.12283973144, 5322.281491998569, 5351.170568561879, 5353.732313384354, 5469.261649677303, 4553.385292985437, 4652.74409907455, 5370.275012873251, 5419.187121931703, 5728.169415434739, 4414.955850441519, 5301.443348448396, 5358.758855851496, 5387.353517577876, 5423.403425623178, 5234.398044224925, 5399.379071406799, 6004.309504406961, 6071.2714474263375, 6080.361562036011, 6208.87582248357, 6235.033569796688, 6261.937380626181, 6277.340879207663, 6287.591306565058, 5431.755570999315, 6413.0, 6422.068581042421, 6450.774222902176, 6512.381323774234, 6061.605995610359, 6139.201903752483, 6150.292716337589, 6164.321924588292, 6179.84550386244, 5294.655847369909, 6233.283172435137, 6366.108744775735, 6374.872502550016, 6383.71273292703, 6137.131844484677, 6185.072239164161, 6258.061290806416, 6266.091416744546, 6299.118123462719, 4834.419869615598, 6118.20463339763, 6246.406591373812, 6248.968755156286, 6307.747690092345, 6104.725287362079, 6250.15622890913, 6305.117283580303, 6327.96836015817, 6333.303336632966, 6198.0702894566175, 6235.781747638811, 6307.274663413675, 6317.873642527124, 6321.051842223703, 5061.924071138936, 5073.365829271341, 5073.441921388644, 5099.23511473282, 5124.590032797368, 4581.198290299184, 4587.266037434061, 4589.678722489461, 4603.125406172817, 4635.884102897455, 6074.726637301332, 6114.908276375858, 6115.205023346936, 6120.540959428061, 6128.662923539159, 6193.938060619336, 6228.750849966042, 6371.2477026750485, 6390.5526613136635, 6404.48764098871, 5979.1629171915965, 5994.1608174855555, 6053.4551890330085, 6062.514998800174, 6111.449969502766, 5633.774649014075, 5644.379118296984, 5646.661200327993, 5656.660600363992, 5657.915131273035, 6249.7187626557825, 6436.195475565554, 6442.194725659293, 6486.708098135689, 6487.0, 6244.718987645476, 6290.025046117859, 6351.3331100235655, 6386.648734319657, 6405.519586030973, 6593.208814942238, 6599.0, 6600.900986485302, 6609.272979972296, 6631.237407698177, 6292.779752708633, 6330.52521060913, 6341.841453963688, 6345.8730825384155, 6361.745530178741, 5435.266239057834, 6225.346338634378, 6254.655993920196, 6259.624422534663, 6289.9056514153235, 6259.655718935503, 6271.216097987752, 6273.435390814849, 6278.372162783685, 6295.244570651551, 6126.029144987285, 6190.597611155261, 6218.533609979179, 6283.560150789401, 6287.685615719104, 6137.989923150331, 6155.1382806406245, 6225.221847269091, 6269.686515674107, 6279.937200628118, 6214.5028397728975, 6256.405641464054, 6269.811905642838, 6284.717187726655, 6285.937140628535, 4890.828820991248, 5002.674826136289, 6218.756248750177, 6246.843828904132, 6252.874942501216], "value": 5824.497939591972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.5159539917456, 765.8851172324152, 784.019975031211, 926.1618235496878, 927.601131513449, 30513.38973220534, 36212.0, 38565.614343856556, 38690.0, 38809.80595097024, 37461.625383746155, 37704.86885393443, 37730.24539509208, 37735.43396849049, 37753.24493510135, 7688.807779805522, 7783.027121609799, 10425.530851111718, 10689.572417103307, 10848.837267440995, 10459.947700261526, 10531.31546449482, 10577.894221057806, 10579.3652380857, 10579.36523808574, 10578.523966421491, 10614.840777388345, 10627.256092073558, 10637.574497020149, 10644.893551064506, 10571.841422378671, 10574.841377379345, 10579.206559507991, 10608.840867386996, 10613.41626210558, 10343.37939723619, 10350.378977261389, 10359.326643768207, 10382.896171038268, 10382.9480852596, 32716.6728332716, 32813.6718632813, 32861.34277314464, 32886.01341959745, 32903.83548082268, 3338.749593780452, 3679.2089700714473, 3706.4069748840056, 3713.350163721365, 3723.3298006358846, 24450.388740281636, 25291.62062569063, 25306.49387012268, 25358.619620705704, 25486.617700734503, 2986.4475072111727, 3014.110837303001, 3048.878044878202, 3088.042706760911, 3140.654528001918, 324159.0, 344500.0, 346014.0, 347613.0, 348263.0, 32901.67098328986, 42736.0, 42782.0, 42783.14433711308, 42856.571434285885, 43728.781356093015, 43776.781116094215, 43827.78086109549, 43900.90247743768, 43963.78018109953, 12820.35898205086, 12831.807522887164, 12910.0, 12913.418896149697, 12919.418626161845, 10251.538680759384, 10990.230683852213, 10997.505112269968, 11014.559417623206, 11030.172737044593, 9275.350725449154, 11428.599998999995, 11501.309921404576, 11599.956003959684, 11635.941820290844, 5618.550515958714, 5691.345495268014, 5692.544596432275, 5705.686187259741, 5719.256496655408, 940.8917974433028, 1085.9674209773718, 1117.519466629341, 1117.7876203521305, 1128.041165009735, 26006.86996565043, 26202.213933582025, 26291.47417051648, 26377.208683739518, 27775.58336624952, 1040.7606250562412, 1040.8334666453331, 1073.5974009746344, 1074.2426589254712, 1074.4949873559415, 11268.15488838324, 12596.0, 12828.935855320664, 13228.801567976489, 13508.392122354519, 465330.0, 467683.0, 470020.0, 470083.0, 473052.0, 44338.556614433444, 44674.55325446769, 44691.0, 44694.10611787746, 44704.77647611806, 1270.2378572856212, 1351.6891115043595, 1381.240317825192, 1394.707111506595, 1397.3083323754806, 20406.795932040488, 25844.0, 26190.95236190607, 26192.607110893732, 26278.21165365042, 38295.80852095722, 38763.61236387713, 38771.224575508895, 38777.418338724376, 38861.0, 441083.0, 443516.0, 444423.0, 444820.0, 445902.0, 28298.858505708162, 28520.714792851806, 28871.0, 28879.7112028877, 28928.566071508525, 36372.27255454823, 36853.815730921175, 36940.26119477542, 37044.0, 37054.44418333673, 29477.0, 30706.078817635505, 31126.688733113286, 32366.029019129463, 33279.0, 31291.68708312979, 31851.840740797074, 32800.0, 33014.33971320512, 33168.00495985124, 32036.5194522087, 32145.517817232292, 32736.672633274316, 32935.0, 32950.83524582362, 25869.353266168495, 27492.725072749017, 29151.7084829149, 29257.85371073131, 29497.705022950355, 22266.666000010337, 22818.885905570365, 22893.54212915699, 22992.864627513198, 23271.301860944197], "value": 17605.510157199864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.66832524029337, 386.1658816955377, 387.275794264725, 398.4939127308318, 414.5150174296073, 13057.542985995493, 14622.488212912524, 19597.314094006713, 20836.791632083674, 20847.99999999998, 20231.49421264469, 20807.375778726662, 21420.14319427225, 21524.677129843065, 21691.67462488064, 5434.864128396792, 6405.647689377082, 6527.379898909619, 6553.737850485999, 6562.310957349481, 6526.869462610745, 6579.80260592183, 6622.8675426491445, 6630.336966303355, 6974.372306492414, 7408.444366672494, 7458.328750412462, 7460.29127232912, 7468.327850493454, 7475.439342049341, 7133.108361454818, 7347.191808901017, 7363.969044333798, 7387.630618469082, 7428.962855185717, 6989.196242432135, 7043.823904402379, 7120.608366539838, 7128.073350464459, 7148.49960502765, 19861.808291502555, 20116.39650810478, 20342.491437714027, 20469.8976505118, 25811.870940645364, 2401.5677178107935, 2809.761170300527, 2881.9135425937257, 2927.7072292770767, 3038.8024778389336, 14818.851811481854, 14978.62553436162, 15856.44502442409, 16125.274362653709, 16222.0, 1987.2547794577033, 2026.6656001759693, 2043.264424807083, 2053.712480252766, 2060.536379314657, 129897.0, 151693.0, 159404.40595594127, 161851.0, 163900.9999999988, 15890.602734931488, 19386.933718645327, 19803.801961980484, 20834.270800522212, 20858.582828343653, 30267.545986810215, 30338.54492182619, 30404.087877363716, 30472.0, 30626.54060189099, 9522.428654280766, 9642.807143857084, 9765.0, 9910.900890991143, 9982.800343993225, 8122.268995790408, 8133.146019667968, 8151.592420378957, 8298.751037468886, 8298.958505207556, 9339.579718912666, 9357.157855793012, 9425.434473931586, 9663.516824158763, 9752.0, 3538.8053657048595, 3770.6606405423095, 3912.5304963404005, 3978.8209530571194, 3990.920181596352, 1028.6348346337093, 1036.9014943580348, 1043.7912417516527, 1056.487603512296, 1057.4765491081964, 20016.2994295199, 20239.356915755307, 20329.491762705755, 20370.388888333375, 20429.897850510653, 921.8755468011867, 1006.6124542051363, 1048.3552615141632, 1084.1706094837455, 1086.0, 10156.339837910513, 10490.527926243338, 10560.943905609378, 10580.470976451146, 10639.202059845542, 653838.4616153872, 678260.0, 693229.0, 717910.0, 718180.0, 127797.0, 127930.0, 129866.0, 130509.69490305166, 133574.99637505444, 1188.7681902029194, 1194.4326444938758, 1217.549506682533, 1218.20207763913, 1221.7373264747944, 16727.24727387246, 17681.939083655023, 18159.819611725197, 18233.270669173085, 18342.358017469323, 57940.0, 58050.419495804505, 59379.14035587673, 59540.106898397426, 61486.38513614806, 62833.37166628275, 77121.30075447333, 81678.59160704158, 81818.0, 82418.17581824106, 10539.15686745074, 10781.514831832743, 11071.225014249247, 11073.280236784583, 11292.661220163409, 12222.0, 12465.0, 12524.373781310716, 12537.549170044504, 12645.620631381073, 10610.89389106099, 10632.415217162821, 10826.945865270623, 10828.891711082788, 10883.23817332779, 10381.377117372982, 10409.115225205942, 10433.426161561187, 10730.570777168827, 10772.407517586607, 10763.623273185402, 10816.729581760519, 10853.348799071766, 10870.286464136525, 11039.503222355173, 9768.413895166314, 9831.901680983385, 10762.139028877828, 11106.000459958643, 11209.49557269941, 10007.749806254902, 10319.94840025825, 10667.253292269466, 10849.728756781144, 10851.565937362733], "value": 11123.13152701087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.0791421190172, 1544.8068991376078, 1566.4204244429563, 1566.7884835547202, 1572.6854629074187, 9101.453912765239, 9352.392094513869, 10147.949260253698, 10721.946390268047, 10754.300970436925, 9928.55321510532, 10311.381317120959, 10312.38125712456, 10333.0, 10345.793084138313, 1981.782003979561, 2280.350100221433, 2316.6409206573007, 2322.581935251654, 2325.8139348852137, 2270.2962081754627, 2293.4037150340946, 2304.331743794298, 2318.026428899866, 2320.895559699809, 2285.02886273334, 2304.343262170282, 2309.4341886237894, 2310.5263420998654, 2314.8148148148107, 1842.5209445544122, 2282.5549017941507, 2282.8287878409187, 2283.3264187064856, 2289.5535370602656, 1800.891946483202, 2224.043661225672, 2326.441654003044, 2334.4747431827873, 2335.8832058397184, 10756.462176891202, 10816.134709223243, 10817.675469735921, 10835.83746243799, 10971.396573188471, 4833.734144622044, 5591.077472217079, 5702.059160238556, 5797.0, 5829.154772557956, 2936.809107408033, 3250.414925313443, 3348.782329148622, 3570.410882204459, 3587.3542762302777, 1130.7568872692411, 1168.299020587649, 1171.4025846818183, 1185.365829281339, 1221.2855479544478, 14554.0, 14562.781558276634, 14624.268786560735, 14633.780493292608, 14723.779143312859, 4711.481737008926, 4720.669553131248, 4829.66192366531, 4914.8771280718265, 4967.130752118364, 12358.62924112278, 12383.19509231897, 12407.25556466615, 12418.254904705747, 12436.689082773004, 5799.768009279666, 5812.709364531756, 5813.372255768391, 5814.651120932757, 5824.475797178275, 5080.568151707146, 5092.0, 5122.820701275437, 5130.9230361544605, 5155.948440515547, 3909.6481316681634, 3994.800259986989, 4025.094353770437, 4071.3485842265095, 4088.4055218464823, 1124.7975364434317, 1132.416805345248, 1134.6936327191613, 1141.4578075414113, 1146.3007565385108, 700.4396482813729, 739.8643082867773, 777.8249893773968, 796.7291121018766, 828.1676914700807, 6190.690465476709, 6348.333424990309, 6849.760258390932, 6867.896981545281, 6868.072810170663, 1028.6142696488816, 1031.8039572481205, 1041.520900385831, 1044.2637940252105, 1047.8218702820539, 3333.3499967506586, 4270.615644592001, 4312.762798046075, 4351.543087975717, 4400.559944005638, 12284.385780710929, 12763.361831908553, 13072.084954053315, 13511.729765404636, 13623.455061797416, 12069.456874440495, 12903.612891613267, 13438.731225375437, 13439.260840653858, 13459.125156864773, 9777.804443911082, 9784.510774461249, 9796.804063918824, 9980.850287245697, 9984.951580084133, 6372.267189273293, 6375.330590287953, 6466.256380516301, 6506.316836732075, 6522.597641507099, 11489.425528723697, 11809.11431642613, 11924.0, 12050.457729402022, 12059.15585908978, 11896.821547676966, 12046.879531204575, 12049.819252711392, 12088.939555302168, 12112.636620901387, 8213.835723285381, 8533.189347012023, 8552.700655477278, 8553.786155346166, 8566.78583035429, 8377.832443350977, 9816.754581135528, 10114.696559103239, 10121.342112762646, 10131.797364052825, 7050.012998180361, 7895.6841726332605, 8285.792855178668, 8736.344774141837, 9035.412698174598, 8718.389712720049, 8813.118688131392, 8836.602352894006, 8848.513331766815, 8897.955510222408, 7655.2344765523, 7696.307332340116, 7785.805354866174, 7787.961060194662, 7863.52818830872, 5766.077427611562, 5796.0, 5796.188533605383, 5947.018741907536, 5965.821025369246, 5927.214209321612, 5948.910766338422, 5952.285725712942, 5953.910691339547, 5954.46409823118], "value": 4995.880205715634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.08287799625094, 361.5318162978942, 363.31515094047745, 363.6182008890665, 373.098965997117, 4865.513448655132, 4974.527419895113, 5027.396712394518, 5197.570668066283, 5285.127953887604, 4373.890652733683, 4895.63282753794, 4995.825980894487, 5123.923141152876, 5200.349956255468, 4123.154753275587, 4142.937855932171, 4251.404803327537, 4276.593723596269, 4314.870553883388, 4133.937990930123, 4211.515675697304, 4302.752201861456, 4309.762963037032, 4355.499117601469, 4243.957560424403, 4279.572042795711, 4302.096559722462, 4303.892402689927, 4336.744892655817, 3674.706023518112, 3859.9192226176715, 4034.7175697701173, 4129.587041295861, 4146.232946904802, 3232.7090561849313, 3661.5423072115987, 3916.64750172483, 3933.7639741615594, 3959.6933012105937, 4216.0, 4448.532904045093, 4471.3274628013805, 4651.953480465186, 4678.415198100238, 4561.126490311116, 4631.698939568917, 4694.0, 4860.538248866352, 4928.162212423897, 4866.7566621668775, 5520.006398848206, 5601.103823388279, 5622.076520209509, 5635.6055076144685, 3838.827252773604, 4408.58118478744, 4439.711418757803, 4446.911061778746, 4447.3329000650165, 5412.783488660449, 5481.5340696040885, 5698.544116470673, 5775.123084997393, 5904.5571582131515, 4353.455818022747, 4403.392761641978, 4408.515063343029, 4426.73439593619, 4484.439445069366, 4036.6367026967127, 4548.590626843534, 4558.088382323548, 4581.9541804582195, 4652.209124448852, 3825.540935087807, 4851.296561998561, 4942.9258561121615, 4942.9258561121615, 5002.849914502571, 5107.387113546398, 5217.660852044605, 5364.597655175878, 5397.141044153371, 5397.298351214317, 1363.4205462678322, 1495.9079871693725, 1515.6514001779653, 1538.9769153462707, 1552.5109590478962, 1026.4098143567478, 1033.7829055898346, 1078.2667785905503, 1156.8322593224104, 1177.9764404711857, 4626.699264547794, 5087.949120508822, 5099.260607211933, 5123.181270648941, 5129.948700512947, 5145.228215767665, 5302.681839089667, 5462.317210348707, 5705.0, 5762.394948530344, 4326.697131200785, 4469.815498892796, 4944.307796908436, 5126.666766660155, 5144.897102058013, 2681.5441374966304, 2795.063653676041, 2839.2192147159285, 2910.2433367324647, 2950.904857551163, 5244.6328756987405, 5579.944200557942, 5810.477057064884, 5813.1515557377425, 5871.266091738533, 4629.768511574475, 5039.420466646309, 5397.893431846462, 5519.289020403688, 5648.858778530487, 5390.676559406448, 5460.34475862899, 5588.86027849307, 5718.485336319751, 5903.498202652737, 5006.574441172541, 5440.409329842285, 5521.355905102613, 5621.550275977994, 5657.811859509549, 4451.707370704025, 4901.077121501086, 5131.844625257476, 5242.449542798104, 5554.222408862844, 4998.475464983215, 5374.978754036721, 5597.888042239214, 5628.971855140698, 5960.284765828128, 3664.6152154023443, 3723.5238566353073, 3979.9254201366048, 4062.73592216505, 4565.840195593271, 5268.155196194166, 5371.570274377962, 5371.785128594813, 5440.755166017618, 5671.829845104653, 4589.885252868571, 5338.279332290091, 5474.562035037108, 5547.472990065938, 5598.300212473441, 4781.589431117898, 5309.36287645485, 5476.2607048048, 5484.506394424361, 5625.943740562542, 4614.284785858197, 4703.435587729357, 4903.798569350532, 4948.727819969936, 5245.531251249657, 4647.604953578849, 4850.7574621269505, 5337.866553336043, 5440.891182176413, 5454.536364408911, 4654.604358629419, 5231.869203269796, 5373.892522149457, 5382.178653156303, 5400.2439658447065], "value": 4149.56368076867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.6438034412275, 720.6324774365074, 749.3555542233678, 758.6168984662744, 832.7876391520159, 12344.135910486259, 16480.42318518852, 16523.50429487116, 16537.58656033598, 16707.916460417713, 15236.695266094672, 15344.61638459039, 15373.461928832494, 15416.0, 15446.99594526355, 916.1662886773055, 944.914957653811, 946.4794363100302, 947.5215016416699, 948.7817801905566, 879.8284334554733, 951.5955718819508, 955.4124213608616, 966.3235734985503, 968.1480297338333, 984.6356847966263, 994.6866736977829, 997.9051990060933, 999.215615741643, 1001.4341896828269, 989.9703008909744, 994.2344394815988, 994.567363197008, 994.8060128274989, 995.0845222395413, 732.4104096202555, 738.1806195123409, 738.7119023580808, 740.311510295425, 741.1032650492856, 15990.0, 16621.83378166227, 16674.66650666992, 17020.82979170205, 17278.56803579908, 13750.814356546376, 13852.0, 13986.720265594733, 14013.229272390014, 14066.788998165035, 11145.72135696606, 11293.040091592224, 11372.829407558893, 11399.943000285028, 11716.179867409284, 3578.8568457261676, 3609.1338078861145, 3622.510961020255, 3674.8346324415197, 3733.0667333166707, 79981.20018799853, 97663.0, 113312.0, 113946.0, 115506.0, 10408.0, 10546.947265263625, 10589.629362972259, 10721.0, 10847.132229421628, 22377.776222237895, 22713.0, 22714.772852271264, 22879.0, 22903.656445153338, 7435.8141046474275, 7514.699412023567, 7536.0956685198125, 7579.886301705479, 7771.222877712184, 4138.255114079495, 4194.0, 4250.978745106317, 4263.126059157865, 4361.5856493633055, 3394.35507253621, 3492.7205823534055, 3493.039414161075, 3494.2312691207894, 3495.650434956535, 606.8422210225373, 614.1923370767427, 617.3733660334764, 628.9119523266746, 630.4357599948021, 660.9008648702733, 676.4655921821804, 683.6820878291519, 696.885013972699, 697.7368279810355, 7999.760007199677, 9310.72067837966, 10101.646442374482, 10146.644867429604, 10513.684589462327, 556.8552176434075, 669.397542212013, 680.5221641598272, 689.290031267795, 692.5948320232619, 4580.312953057068, 4964.0, 5006.19900815875, 5018.749062546858, 5059.19052951526, 70960.0, 91690.54154729316, 94014.5299273513, 97096.51451742696, 99956.00043999612, 49870.50388488351, 62542.687286563276, 67085.65828683399, 77650.0, 89066.0, 47140.0, 54219.0, 72631.63684181546, 85917.0, 89582.55208723915, 8886.289096872364, 9481.899370066194, 9669.145166924385, 10488.0, 11128.721781955515, 52996.47003529916, 53562.46437535575, 54656.18015729847, 54777.726111369186, 55040.72479637736, 58347.83304333974, 59032.0, 61064.0, 68000.0, 68023.36274387971, 13008.479660813462, 13015.414306356048, 13273.137246078973, 13422.328883555978, 14124.43502259898, 11229.831552526883, 11644.825327619923, 12157.392130393268, 14189.787153192918, 14646.414143434144, 12606.684832878884, 13840.446382145004, 13852.151746888509, 14079.103157831616, 14114.435422583392, 13093.0, 13273.601791946257, 13498.460061597427, 13593.184408935496, 14165.504207352693, 13041.0, 13298.190966814625, 13560.728785424039, 13587.932060339635, 14264.072835265675, 10608.310459820086, 10927.56289748433, 11056.944715276371, 11153.665390038312, 11653.53385864556, 8029.350314396352, 10151.390916545031, 10364.689059328231, 10513.78972420532, 11303.095752339628], "value": 7488.826575168106, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 181.0, 107.0, 178.0, 182.0, 157.0, 118.0, 147.0, 157.0, 126.0], "value": 150.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 111.0, 155.0, 115.0, 115.0, 117.0, 132.0, 173.0, 147.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 204.0, 202.0, 206.0, 196.0, 203.0, 201.0, 197.0, 205.0, 193.0], "value": 201.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 58.0, 62.0, 90.0, 60.0, 62.0, 59.0, 63.0, 100.0, 63.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 73.0, 93.0, 84.0, 84.0, 73.0, 85.0, 73.0, 71.0, 85.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 106.0, 91.0, 93.0, 93.0, 93.0, 92.0, 92.0, 140.0, 93.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 101.0, 151.0, 154.0, 92.0, 101.0, 99.0, 99.0, 125.0, 102.0], "value": 115.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 143.0, 142.0, 90.0, 90.0, 94.0, 91.0, 96.0, 91.0, 92.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 70.0, 103.0, 103.0, 84.0, 67.0, 67.0, 68.0, 69.0], "value": 76.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 67.0, 63.0, 75.0, 61.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 109.0, 90.0, 91.0, 89.0, 90.0, 82.0, 88.0, 88.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 144.0, 139.0, 144.0, 162.0, 130.0, 140.0, 165.0, 220.0, 198.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 178.0, 173.0, 179.0, 163.0, 202.0, 178.0, 178.0, 174.0, 173.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 73.0, 96.0, 88.0, 72.0, 66.0, 92.0, 91.0], "value": 78.6, "unit": "score"}]}]} 07:42:11 INFO - Return code: 0 07:42:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:42:11 ERROR - # TBPL SUCCESS # 07:42:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:11 INFO - 2017-03-07 07:42:11.872 screenresolution[2547:24585] starting screenresolution argv=screenresolution get 07:42:11 INFO - 2017-03-07 07:42:11.876 screenresolution[2547:24585] Display 0: 1600x1200x32@60 07:42:11 INFO - 2017-03-07 07:42:11.883 screenresolution[2548:24588] starting screenresolution argv=screenresolution list 07:42:11 INFO - Available Modes on Display 0 07:42:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:12 INFO - Intel Iris: 07:42:12 INFO - Chipset Model: Intel Iris 07:42:12 INFO - Type: GPU 07:42:12 INFO - Bus: Built-In 07:42:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:12 INFO - Vendor: Intel (0x8086) 07:42:12 INFO - Device ID: 0x0a2e 07:42:12 INFO - Revision ID: 0x0009 07:42:12 INFO - Displays: 07:42:12 INFO - Display: 07:42:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:12 INFO - Display Serial Number: 1600x1200 60 07:42:12 INFO - Main Display: Yes 07:42:12 INFO - Mirror: Off 07:42:12 INFO - Online: Yes 07:42:12 INFO - Rotation: Supported 07:42:12 INFO - Return code: 0 07:42:12 INFO - Running post-action listener: _resource_record_post_action 07:42:12 INFO - [mozharness: 2017-03-07 15:42:12.126349Z] Finished run-tests step (success) 07:42:12 INFO - Running post-run listener: _resource_record_post_run 07:42:12 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 262144; Write bytes: 513545216; Read time: 3; Write time: 1625 07:42:12 INFO - TinderboxPrint: CPU usage
55.0% 07:42:12 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 3 07:42:12 INFO - TinderboxPrint: I/O write bytes / time
513,545,216 / 1,625 07:42:12 INFO - TinderboxPrint: CPU idle
2,165.0 (45.1%) 07:42:12 INFO - TinderboxPrint: CPU system
973.9 (20.3%) 07:42:12 INFO - TinderboxPrint: CPU user
1,666.8 (34.7%) 07:42:12 INFO - TinderboxPrint: Swap in / out
209,772,544 / 0 07:42:12 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201193984; Write bytes: 195469312; Read time: 15832; Write time: 437 07:42:12 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 262144; Write bytes: 302498816; Read time: 3; Write time: 1137 07:42:12 INFO - Running post-run listener: _upload_blobber_files 07:42:12 INFO - Blob upload gear active. 07:42:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:42:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:42:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:13 INFO - (blobuploader) - INFO - Done attempting. 07:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:14 INFO - (blobuploader) - INFO - Done attempting. 07:42:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:42:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:42:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:15 INFO - (blobuploader) - INFO - Done attempting. 07:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:42:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:18 INFO - (blobuploader) - INFO - Done attempting. 07:42:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:42:18 INFO - Return code: 0 07:42:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:42:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:42:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/088e2e434129b03a4fe06e79fe62e63fb614d6097942165ccd232406fa53e5227a19a2b8ed47a51ae35ccfd56a7663db036abc9c4d66c9bdffa853960df6dd67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/025392998bdfb485e4e79c6948323ce38e5f8ae3351d476b4dc3c104be91bab70c835a326ac6b73eeb0968fc59d8f6f355e31a74b64492399d632cc32539a198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31cdf89d9f07398983eb4d375b0d93914516d1bb1cd079cae8a33bb04e0c9e33f4cf416a3b03f9bb4c28dce1d3081bc60e732d486d852eab77260a4408945725", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2175f0c271a368068f1ab44fef634a55e49ca082fd072ee6c8105815a8d885886ce00af65d8b42d341ca94c29b06f3b1217e6af98d73d72602429f7d2d002b38"} 07:42:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:42:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:42:18 INFO - Contents: 07:42:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/088e2e434129b03a4fe06e79fe62e63fb614d6097942165ccd232406fa53e5227a19a2b8ed47a51ae35ccfd56a7663db036abc9c4d66c9bdffa853960df6dd67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/025392998bdfb485e4e79c6948323ce38e5f8ae3351d476b4dc3c104be91bab70c835a326ac6b73eeb0968fc59d8f6f355e31a74b64492399d632cc32539a198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31cdf89d9f07398983eb4d375b0d93914516d1bb1cd079cae8a33bb04e0c9e33f4cf416a3b03f9bb4c28dce1d3081bc60e732d486d852eab77260a4408945725", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2175f0c271a368068f1ab44fef634a55e49ca082fd072ee6c8105815a8d885886ce00af65d8b42d341ca94c29b06f3b1217e6af98d73d72602429f7d2d002b38"} 07:42:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:42:18 INFO - Copying logs to upload dir... 07:42:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:42:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.682932 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-07 07:42:18.228623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 07:42:18.232460) ========= 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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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/088e2e434129b03a4fe06e79fe62e63fb614d6097942165ccd232406fa53e5227a19a2b8ed47a51ae35ccfd56a7663db036abc9c4d66c9bdffa853960df6dd67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/025392998bdfb485e4e79c6948323ce38e5f8ae3351d476b4dc3c104be91bab70c835a326ac6b73eeb0968fc59d8f6f355e31a74b64492399d632cc32539a198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31cdf89d9f07398983eb4d375b0d93914516d1bb1cd079cae8a33bb04e0c9e33f4cf416a3b03f9bb4c28dce1d3081bc60e732d486d852eab77260a4408945725", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2175f0c271a368068f1ab44fef634a55e49ca082fd072ee6c8105815a8d885886ce00af65d8b42d341ca94c29b06f3b1217e6af98d73d72602429f7d2d002b38"} build_url:https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011590 build_url: 'https://queue.taskcluster.net/v1/task/bQNuOAy0TH-RMQXzTfn8Ug/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/088e2e434129b03a4fe06e79fe62e63fb614d6097942165ccd232406fa53e5227a19a2b8ed47a51ae35ccfd56a7663db036abc9c4d66c9bdffa853960df6dd67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/025392998bdfb485e4e79c6948323ce38e5f8ae3351d476b4dc3c104be91bab70c835a326ac6b73eeb0968fc59d8f6f355e31a74b64492399d632cc32539a198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31cdf89d9f07398983eb4d375b0d93914516d1bb1cd079cae8a33bb04e0c9e33f4cf416a3b03f9bb4c28dce1d3081bc60e732d486d852eab77260a4408945725", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2175f0c271a368068f1ab44fef634a55e49ca082fd072ee6c8105815a8d885886ce00af65d8b42d341ca94c29b06f3b1217e6af98d73d72602429f7d2d002b38"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 07:42:18.272192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 07:42:18.272527) ========= 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.Oh4IBao0L7/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.rLXrnUWZ80/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.005478 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 07:42:18.321968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 07:42:18.322301) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 07:42:18.322679) ========= ========= Total master_lag: 0.20 =========