builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0087 starttime: 1485606772.47 results: success (0) buildid: 20170128030204 builduid: ea30df4025e943fc8ebcec455cf85407 revision: 045d8fe30f546ab08466c9586ce298e6459c2069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:52.471911) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:52.472377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:52.472748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:52.501346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:52.502071) ========= 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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-01-28 04:32:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-01-28 04:32:53 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.588781 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:53.178732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:53.179146) ========= 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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.027481 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:53.271775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-28 04:32:53.272188) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 045d8fe30f546ab08466c9586ce298e6459c2069 --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 045d8fe30f546ab08466c9586ce298e6459c2069 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-01-28 04:32:53,385 truncating revision to first 12 chars 2017-01-28 04:32:53,386 Setting DEBUG logging. 2017-01-28 04:32:53,386 attempt 1/10 2017-01-28 04:32:53,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/045d8fe30f54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-28 04:32:54,479 unpacking tar archive at: mozilla-central-045d8fe30f54/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368480 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-28 04:32:54.680700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:54.681049) ========= script_repo_revision: 045d8fe30f546ab08466c9586ce298e6459c2069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:54.681518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:54.681837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-28 04:32:54.706899) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-28 04:32:54.707684) ========= /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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:32:54 INFO - MultiFileLogger online at 20170128 04:32:54 in /builds/slave/test 04:32:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:32:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:54 INFO - {'append_to_log': False, 04:32:54 INFO - 'base_work_dir': '/builds/slave/test', 04:32:54 INFO - 'blob_upload_branch': 'Firefox', 04:32:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:54 INFO - 'branch': 'Firefox', 04:32:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:54 INFO - 'config_files': ('talos/mac_config.py',), 04:32:54 INFO - 'default_actions': ('clobber', 04:32:54 INFO - 'read-buildbot-config', 04:32:54 INFO - 'download-and-extract', 04:32:54 INFO - 'populate-webroot', 04:32:54 INFO - 'create-virtualenv', 04:32:54 INFO - 'install', 04:32:54 INFO - 'run-tests'), 04:32:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:54 INFO - 'download_minidump_stackwalk': True, 04:32:54 INFO - 'download_symbols': 'ondemand', 04:32:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:54 INFO - 'installer_path': 'installer.exe', 04:32:54 INFO - 'log_level': 'info', 04:32:54 INFO - 'log_name': 'talos', 04:32:54 INFO - 'log_to_console': True, 04:32:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:32:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:32:54 INFO - 'opt_config_files': (), 04:32:54 INFO - 'pip_index': False, 04:32:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:54 INFO - 'cmd': ('bash', 04:32:54 INFO - '-c', 04:32:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:54 INFO - 'enabled': True, 04:32:54 INFO - 'halt_on_failure': False, 04:32:54 INFO - 'name': 'check_screen_resolution'},), 04:32:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:54 INFO - 'cmd': ('bash', 04:32:54 INFO - '-c', 04:32:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:54 INFO - 'enabled': True, 04:32:54 INFO - 'halt_on_failure': False, 04:32:54 INFO - 'name': 'check_screen_resolution'},), 04:32:54 INFO - 'run_cmd_checks_enabled': True, 04:32:54 INFO - 'sps_profile': False, 04:32:54 INFO - 'sps_profile_interval': 0, 04:32:54 INFO - 'suite': 'dromaeojs-e10s', 04:32:54 INFO - 'system_bits': '32', 04:32:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:54 INFO - 'title': 't-yosemite-r7-0087', 04:32:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:54 INFO - 'use_talos_json': True, 04:32:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:54 INFO - 'work_dir': 'build'} 04:32:54 INFO - [mozharness: 2017-01-28 12:32:54.937298Z] Running clobber step. 04:32:54 INFO - Running pre-action listener: _resource_record_pre_action 04:32:54 INFO - Running main action method: clobber 04:32:54 INFO - rmtree: /builds/slave/test/build 04:32:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:57 INFO - Running post-action listener: _resource_record_post_action 04:32:57 INFO - [mozharness: 2017-01-28 12:32:57.469926Z] Finished clobber step (success) 04:32:57 INFO - [mozharness: 2017-01-28 12:32:57.470047Z] Running read-buildbot-config step. 04:32:57 INFO - Running pre-action listener: _resource_record_pre_action 04:32:57 INFO - Running main action method: read_buildbot_config 04:32:57 INFO - Using buildbot properties: 04:32:57 INFO - { 04:32:57 INFO - "project": "", 04:32:57 INFO - "product": "firefox", 04:32:57 INFO - "script_repo_revision": "production", 04:32:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:32:57 INFO - "repository": "", 04:32:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:32:57 INFO - "buildid": "20170128030204", 04:32:57 INFO - "stage_platform": "macosx64", 04:32:57 INFO - "basedir": "/builds/slave/test", 04:32:57 INFO - "nightly_build": "True", 04:32:57 INFO - "buildnumber": 68, 04:32:57 INFO - "slavename": "t-yosemite-r7-0087", 04:32:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:32:57 INFO - "platform": "yosemite_r7", 04:32:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:32:57 INFO - "branch": "mozilla-central", 04:32:57 INFO - "repo_path": "mozilla-central", 04:32:57 INFO - "revision": "045d8fe30f546ab08466c9586ce298e6459c2069", 04:32:57 INFO - "pgo_build": "False", 04:32:57 INFO - "builduid": "ea30df4025e943fc8ebcec455cf85407", 04:32:57 INFO - "slavebuilddir": "test" 04:32:57 INFO - } 04:32:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:32:57 INFO - Running post-action listener: _resource_record_post_action 04:32:57 INFO - [mozharness: 2017-01-28 12:32:57.473299Z] Finished read-buildbot-config step (success) 04:32:57 INFO - [mozharness: 2017-01-28 12:32:57.473405Z] Running download-and-extract step. 04:32:57 INFO - Running pre-action listener: _resource_record_pre_action 04:32:57 INFO - Running main action method: download_and_extract 04:32:57 INFO - mkdir: /builds/slave/test/build/tests 04:32: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')]} 04:32:57 INFO - trying https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:32:57 INFO - Downloading https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:32:58 INFO - Downloaded 1199 bytes. 04:32:58 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:32:58 INFO - Using the following test package requirements: 04:32:58 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:32:58 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:32:58 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:32:58 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'jsshell-mac.zip'], 04:32:58 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:32:58 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:32:58 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:32:58 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:32:58 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:32:58 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:32:58 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:32:58 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:32:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:32:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:32:59 INFO - Expected file size: 16361222 04:32:59 INFO - Obtained file size: 16361222 04:33:06 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:33:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:33:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:06 INFO - Fetch https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:33:07 INFO - Expected file size: 16361222 04:33:07 INFO - Obtained file size: 16361222 04:33:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:33:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:33:13 INFO - Fetch https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:33:14 INFO - Expected file size: 14403454 04:33:14 INFO - Obtained file size: 14403454 04:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:15 INFO - trying https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:33:17 INFO - Downloaded 70204016 bytes. 04:33:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:33:17 INFO - mkdir: /builds/slave/test/properties 04:33:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:17 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:17 INFO - Contents: 04:33:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:33:18 INFO - Running post-action listener: _resource_record_post_action 04:33:18 INFO - Running post-action listener: set_extra_try_arguments 04:33:18 INFO - [mozharness: 2017-01-28 12:33:18.439755Z] Finished download-and-extract step (success) 04:33:18 INFO - [mozharness: 2017-01-28 12:33:18.439880Z] Running populate-webroot step. 04:33:18 INFO - Running pre-action listener: _resource_record_pre_action 04:33:18 INFO - Running main action method: populate_webroot 04:33:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:18 INFO - '--tppagecycles', 04:33:18 INFO - '7'], 04:33:18 INFO - 'tests': ['tsvgm']}}, 04:33:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['damp', 'tps']}, 04:33:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'tests': ['damp', 'tps']}, 04:33:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['dromaeo_dom']}, 04:33:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['basic_compositor_video']}, 04:33:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:33:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['a11yr', 04:33:18 INFO - 'ts_paint', 04:33:18 INFO - 'tpaint', 04:33:18 INFO - 'sessionrestore', 04:33:18 INFO - 'sessionrestore_no_auto_restore', 04:33:18 INFO - 'tabpaint']}, 04:33:18 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:18 INFO - 'ts_paint', 04:33:18 INFO - 'tpaint', 04:33:18 INFO - 'sessionrestore', 04:33:18 INFO - 'sessionrestore_no_auto_restore', 04:33:18 INFO - 'tabpaint']}, 04:33:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:18 INFO - 'ts_paint', 04:33:18 INFO - 'tpaint', 04:33:18 INFO - 'sessionrestore', 04:33:18 INFO - 'sessionrestore_no_auto_restore', 04:33:18 INFO - 'tabpaint']}, 04:33:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:18 INFO - 'ts_paint', 04:33:18 INFO - 'tpaint', 04:33:18 INFO - 'sessionrestore', 04:33:18 INFO - 'sessionrestore_no_auto_restore', 04:33:18 INFO - 'tabpaint']}, 04:33:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['a11yr', 04:33:18 INFO - 'ts_paint', 04:33:18 INFO - 'tpaint', 04:33:18 INFO - 'sessionrestore', 04:33:18 INFO - 'sessionrestore_no_auto_restore', 04:33:18 INFO - 'tabpaint']}, 04:33:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['a11yr', 04:33:18 INFO - 'ts_paint', 04:33:18 INFO - 'tpaint', 04:33:18 INFO - 'sessionrestore', 04:33:18 INFO - 'sessionrestore_no_auto_restore', 04:33:18 INFO - 'tabpaint']}, 04:33:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['tsvgx', 04:33:18 INFO - 'tsvgr_opacity', 04:33:18 INFO - 'tart', 04:33:18 INFO - 'tscrollx', 04:33:18 INFO - 'cart', 04:33:18 INFO - 'tsvg_static']}, 04:33:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:18 INFO - 'tsvgr_opacity', 04:33:18 INFO - 'tart', 04:33:18 INFO - 'tscrollx', 04:33:18 INFO - 'cart', 04:33:18 INFO - 'tsvg_static']}, 04:33:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'talos_options': ['--disable-e10s'], 04:33:18 INFO - 'tests': ['tp5o']}, 04:33:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:33:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'talos_options': ['--disable-e10s', 04:33:18 INFO - '--xperf_path', 04:33:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:18 INFO - 'tests': ['tp5n']}, 04:33:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:33:18 INFO - 'talos_options': ['--xperf_path', 04:33:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:18 INFO - 'tests': ['tp5n']}}, 04:33:18 INFO - 'talos.zip': {'path': '', 04:33:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:18 INFO - Running post-action listener: _resource_record_post_action 04:33:18 INFO - [mozharness: 2017-01-28 12:33:18.458263Z] Finished populate-webroot step (success) 04:33:18 INFO - [mozharness: 2017-01-28 12:33:18.458374Z] Running create-virtualenv step. 04:33:18 INFO - Running pre-action listener: _resource_record_pre_action 04:33:18 INFO - Running main action method: create_virtualenv 04:33:18 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:33:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:18 INFO - Using real prefix '/tools/python27' 04:33:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:22 INFO - Installing pip.................done. 04:33:22 INFO - Return code: 0 04:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:33:22 INFO - Reading from file tmpfile_stdout 04:33:22 INFO - Output received: 04:33:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:33:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:22 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:22 INFO - 'HOME': '/Users/cltbld', 04:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:22 INFO - 'LOGNAME': 'cltbld', 04:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:22 INFO - 'MOZ_NO_REMOTE': '1', 04:33:22 INFO - 'NO_EM_RESTART': '1', 04:33:22 INFO - 'PAGER': '/bin/cat', 04:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:22 INFO - 'PWD': '/builds/slave/test', 04:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:22 INFO - 'SHELL': '/bin/bash', 04:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:22 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:22 INFO - 'USER': 'cltbld', 04:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:22 INFO - 'XPC_FLAGS': '0x0', 04:33:22 INFO - 'XPC_SERVICE_NAME': '0', 04:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:33:22 INFO - Cleaning up... 04:33:22 INFO - Return code: 0 04:33:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:22 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:22 INFO - 'HOME': '/Users/cltbld', 04:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:22 INFO - 'LOGNAME': 'cltbld', 04:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:22 INFO - 'MOZ_NO_REMOTE': '1', 04:33:22 INFO - 'NO_EM_RESTART': '1', 04:33:22 INFO - 'PAGER': '/bin/cat', 04:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:22 INFO - 'PWD': '/builds/slave/test', 04:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:22 INFO - 'SHELL': '/bin/bash', 04:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:22 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:22 INFO - 'USER': 'cltbld', 04:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:22 INFO - 'XPC_FLAGS': '0x0', 04:33:22 INFO - 'XPC_SERVICE_NAME': '0', 04:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:22 INFO - Downloading/unpacking psutil>=3.1.1 04:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:27 INFO - Installing collected packages: psutil 04:33:27 INFO - Running setup.py install for psutil 04:33:27 INFO - building 'psutil._psutil_osx' extension 04:33:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:33:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:33:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:33:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:33:28 INFO - building 'psutil._psutil_posix' extension 04:33:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:33:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:33:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:33:28 INFO - ^ 04:33:28 INFO - 1 warning generated. 04:33:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:33:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:28 INFO - Successfully installed psutil 04:33:28 INFO - Cleaning up... 04:33:28 INFO - Return code: 0 04:33:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:28 INFO - 'HOME': '/Users/cltbld', 04:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:28 INFO - 'LOGNAME': 'cltbld', 04:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:28 INFO - 'MOZ_NO_REMOTE': '1', 04:33:28 INFO - 'NO_EM_RESTART': '1', 04:33:28 INFO - 'PAGER': '/bin/cat', 04:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:28 INFO - 'PWD': '/builds/slave/test', 04:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:28 INFO - 'SHELL': '/bin/bash', 04:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:28 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:28 INFO - 'USER': 'cltbld', 04:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:28 INFO - 'XPC_FLAGS': '0x0', 04:33:28 INFO - 'XPC_SERVICE_NAME': '0', 04:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:33:31 INFO - Installing collected packages: mozsystemmonitor 04:33:31 INFO - Running setup.py install for mozsystemmonitor 04:33:31 INFO - Successfully installed mozsystemmonitor 04:33:31 INFO - Cleaning up... 04:33:31 INFO - Return code: 0 04:33:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:33: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')]} 04:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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')]} 04:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:31 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:31 INFO - 'HOME': '/Users/cltbld', 04:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:31 INFO - 'LOGNAME': 'cltbld', 04:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:31 INFO - 'MOZ_NO_REMOTE': '1', 04:33:31 INFO - 'NO_EM_RESTART': '1', 04:33:31 INFO - 'PAGER': '/bin/cat', 04:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:31 INFO - 'PWD': '/builds/slave/test', 04:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:31 INFO - 'SHELL': '/bin/bash', 04:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:31 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:31 INFO - 'USER': 'cltbld', 04:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:31 INFO - 'XPC_FLAGS': '0x0', 04:33:31 INFO - 'XPC_SERVICE_NAME': '0', 04:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:31 INFO - Downloading/unpacking jsonschema==2.5.1 04:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:34 INFO - warning: no files found matching '*.txt' 04:33:34 INFO - no previously-included directories found matching 'build' 04:33:34 INFO - no previously-included directories found matching 'dist' 04:33:34 INFO - no previously-included directories found matching '.git*' 04:33:34 INFO - Installing collected packages: jsonschema, functools32 04:33:35 INFO - Running setup.py install for functools32 04:33:35 INFO - warning: no files found matching '*.txt' 04:33:35 INFO - no previously-included directories found matching 'build' 04:33:35 INFO - no previously-included directories found matching 'dist' 04:33:35 INFO - no previously-included directories found matching '.git*' 04:33:35 INFO - Successfully installed jsonschema functools32 04:33:35 INFO - Cleaning up... 04:33:35 INFO - Return code: 0 04:33:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:35 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:35 INFO - 'HOME': '/Users/cltbld', 04:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:35 INFO - 'LOGNAME': 'cltbld', 04:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:35 INFO - 'MOZ_NO_REMOTE': '1', 04:33:35 INFO - 'NO_EM_RESTART': '1', 04:33:35 INFO - 'PAGER': '/bin/cat', 04:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:35 INFO - 'PWD': '/builds/slave/test', 04:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:35 INFO - 'SHELL': '/bin/bash', 04:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:35 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:35 INFO - 'USER': 'cltbld', 04:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:35 INFO - 'XPC_FLAGS': '0x0', 04:33:35 INFO - 'XPC_SERVICE_NAME': '0', 04:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:33:35 INFO - Cleaning up... 04:33:35 INFO - Return code: 0 04:33:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:35 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:35 INFO - 'HOME': '/Users/cltbld', 04:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:35 INFO - 'LOGNAME': 'cltbld', 04:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:35 INFO - 'MOZ_NO_REMOTE': '1', 04:33:35 INFO - 'NO_EM_RESTART': '1', 04:33:35 INFO - 'PAGER': '/bin/cat', 04:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:35 INFO - 'PWD': '/builds/slave/test', 04:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:35 INFO - 'SHELL': '/bin/bash', 04:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:35 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:35 INFO - 'USER': 'cltbld', 04:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:35 INFO - 'XPC_FLAGS': '0x0', 04:33:35 INFO - 'XPC_SERVICE_NAME': '0', 04:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:39 INFO - Downloading docopt-0.6.1.tar.gz 04:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:39 INFO - Running setup.py install for blobuploader 04:33:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:39 INFO - Running setup.py install for requests 04:33:40 INFO - Running setup.py install for docopt 04:33:40 INFO - Successfully installed blobuploader requests docopt 04:33:40 INFO - Cleaning up... 04:33:40 INFO - Return code: 0 04:33:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:40 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:40 INFO - 'HOME': '/Users/cltbld', 04:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:40 INFO - 'LOGNAME': 'cltbld', 04:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:40 INFO - 'MOZ_NO_REMOTE': '1', 04:33:40 INFO - 'NO_EM_RESTART': '1', 04:33:40 INFO - 'PAGER': '/bin/cat', 04:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:40 INFO - 'PWD': '/builds/slave/test', 04:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:40 INFO - 'SHELL': '/bin/bash', 04:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:40 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:40 INFO - 'USER': 'cltbld', 04:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:40 INFO - 'XPC_FLAGS': '0x0', 04:33:40 INFO - 'XPC_SERVICE_NAME': '0', 04:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:40 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-6T0Wvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:40 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-arxQwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ipNVfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-0XjuGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-gcFBy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-BuMMky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-RxdXp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ENXcJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VVJUGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ge2SOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-rNXM8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:41 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-55MqbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:42 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-BBdFWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:42 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VHnDLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:42 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-g0V173-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:42 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-eSsZZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:42 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Fb7cmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:42 INFO - Running setup.py install for manifestparser 04:33:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:42 INFO - Running setup.py install for mozcrash 04:33:42 INFO - Running setup.py install for mozdebug 04:33:43 INFO - Running setup.py install for mozdevice 04:33:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Running setup.py install for mozfile 04:33:43 INFO - Running setup.py install for mozhttpd 04:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Running setup.py install for mozinfo 04:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Running setup.py install for mozInstall 04:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:43 INFO - Running setup.py install for mozleak 04:33:43 INFO - Running setup.py install for mozlog 04:33:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:44 INFO - Running setup.py install for moznetwork 04:33:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:44 INFO - Running setup.py install for mozprocess 04:33:44 INFO - Running setup.py install for mozprofile 04:33:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:44 INFO - Running setup.py install for mozrunner 04:33:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:44 INFO - Running setup.py install for mozscreenshot 04:33:44 INFO - Running setup.py install for moztest 04:33:45 INFO - Running setup.py install for mozversion 04:33:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:45 INFO - Cleaning up... 04:33:45 INFO - Return code: 0 04:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:45 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:45 INFO - 'HOME': '/Users/cltbld', 04:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:45 INFO - 'LOGNAME': 'cltbld', 04:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:45 INFO - 'MOZ_NO_REMOTE': '1', 04:33:45 INFO - 'NO_EM_RESTART': '1', 04:33:45 INFO - 'PAGER': '/bin/cat', 04:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:45 INFO - 'PWD': '/builds/slave/test', 04:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:45 INFO - 'SHELL': '/bin/bash', 04:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:45 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:45 INFO - 'USER': 'cltbld', 04:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:45 INFO - 'XPC_FLAGS': '0x0', 04:33:45 INFO - 'XPC_SERVICE_NAME': '0', 04:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:45 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-MLMO3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:45 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ZlF6u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:45 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-k8oup7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:45 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7JwJtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:45 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)) 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:45 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ZIwLru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:45 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-JdsSZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-eraFmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-6pJ1d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Y8SvNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-nFOBzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-eUaDL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-tskzFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-C2R_e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-qAzqJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:46 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-1aGntg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:47 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-DzU7TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:47 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-9MLgxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:33:47 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)) 04:33:47 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)) 04:33:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:49 INFO - Downloading blessings-1.6.tar.gz 04:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:49 INFO - Installing collected packages: blessings 04:33:49 INFO - Running setup.py install for blessings 04:33:50 INFO - Successfully installed blessings 04:33:50 INFO - Cleaning up... 04:33:50 INFO - Return code: 0 04:33:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:50 INFO - Reading from file tmpfile_stdout 04:33:50 INFO - Current package versions: 04:33:50 INFO - blessings == 1.6 04:33:50 INFO - blobuploader == 1.2.4 04:33:50 INFO - docopt == 0.6.1 04:33:50 INFO - functools32 == 3.2.3-2 04:33:50 INFO - jsonschema == 2.5.1 04:33:50 INFO - manifestparser == 1.1 04:33:50 INFO - mozInstall == 1.12 04:33:50 INFO - mozcrash == 1.0 04:33:50 INFO - mozdebug == 0.1 04:33:50 INFO - mozdevice == 0.49 04:33:50 INFO - mozfile == 1.2 04:33:50 INFO - mozhttpd == 0.7 04:33:50 INFO - mozinfo == 0.9 04:33:50 INFO - mozleak == 0.1 04:33:50 INFO - mozlog == 3.4 04:33:50 INFO - moznetwork == 0.27 04:33:50 INFO - mozprocess == 0.24 04:33:50 INFO - mozprofile == 0.28 04:33:50 INFO - mozrunner == 6.13 04:33:50 INFO - mozscreenshot == 0.1 04:33:50 INFO - mozsystemmonitor == 0.3 04:33:50 INFO - moztest == 0.8 04:33:50 INFO - mozversion == 1.4 04:33:50 INFO - psutil == 3.1.1 04:33:50 INFO - requests == 1.2.3 04:33:50 INFO - wsgiref == 0.1.2 04:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:50 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 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:50 INFO - 'HOME': '/Users/cltbld', 04:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:50 INFO - 'LOGNAME': 'cltbld', 04:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:50 INFO - 'MOZ_NO_REMOTE': '1', 04:33:50 INFO - 'NO_EM_RESTART': '1', 04:33:50 INFO - 'PAGER': '/bin/cat', 04:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:50 INFO - 'PWD': '/builds/slave/test', 04:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:50 INFO - 'SHELL': '/bin/bash', 04:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:50 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:50 INFO - 'USER': 'cltbld', 04:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:50 INFO - 'XPC_FLAGS': '0x0', 04:33:50 INFO - 'XPC_SERVICE_NAME': '0', 04:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:33:50 INFO - Cleaning up... 04:33:50 INFO - Return code: 0 04:33:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5d0cb4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, '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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33: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'] in /builds/slave/test/build 04:33: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 04:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:50 INFO - 'HOME': '/Users/cltbld', 04:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:50 INFO - 'LOGNAME': 'cltbld', 04:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:50 INFO - 'MOZ_NO_REMOTE': '1', 04:33:50 INFO - 'NO_EM_RESTART': '1', 04:33:50 INFO - 'PAGER': '/bin/cat', 04:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:50 INFO - 'PWD': '/builds/slave/test', 04:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:50 INFO - 'SHELL': '/bin/bash', 04:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:33:50 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:50 INFO - 'USER': 'cltbld', 04:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:50 INFO - 'XPC_FLAGS': '0x0', 04:33:50 INFO - 'XPC_SERVICE_NAME': '0', 04:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:33:51 INFO - Cleaning up... 04:33:51 INFO - Return code: 0 04:33:51 INFO - Running post-action listener: _resource_record_post_action 04:33:51 INFO - Running post-action listener: _start_resource_monitoring 04:33:51 INFO - Starting resource monitoring. 04:33:51 INFO - [mozharness: 2017-01-28 12:33:51.093468Z] Finished create-virtualenv step (success) 04:33:51 INFO - [mozharness: 2017-01-28 12:33:51.094426Z] Running install step. 04:33:51 INFO - Running pre-action listener: _resource_record_pre_action 04:33:51 INFO - Running main action method: install 04:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:51 INFO - Reading from file tmpfile_stdout 04:33:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:51 INFO - Reading from file tmpfile_stdout 04:33:51 INFO - Output received: 04:33:51 INFO - Usage: mozinstall [options] installer 04:33:51 INFO - Options: 04:33:51 INFO - -h, --help show this help message and exit 04:33:51 INFO - -d DEST, --destination=DEST 04:33:51 INFO - Directory to install application into. [default: 04:33:51 INFO - "/builds/slave/test"] 04:33:51 INFO - --app=APP Application being installed. [default: firefox] 04:33:51 INFO - mkdir: /builds/slave/test/build/application 04:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:34:13 INFO - Reading from file tmpfile_stdout 04:34:13 INFO - Output received: 04:34:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:34:13 INFO - Running post-action listener: _resource_record_post_action 04:34:13 INFO - [mozharness: 2017-01-28 12:34:13.639527Z] Finished install step (success) 04:34:13 INFO - [mozharness: 2017-01-28 12:34:13.639697Z] Running run-tests step. 04:34:13 INFO - Running pre-action listener: _resource_record_pre_action 04:34:13 INFO - Running main action method: run_tests 04:34:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:13 INFO - 2017-01-28 04:34:13.654 screenresolution[1769:20106] starting screenresolution argv=screenresolution get 04:34:13 INFO - 2017-01-28 04:34:13.657 screenresolution[1769:20106] Display 0: 1600x1200x32@60 04:34:13 INFO - 2017-01-28 04:34:13.663 screenresolution[1770:20109] starting screenresolution argv=screenresolution list 04:34:13 INFO - Available Modes on Display 0 04:34:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:13 INFO - Intel Iris: 04:34:13 INFO - Chipset Model: Intel Iris 04:34:13 INFO - Type: GPU 04:34:13 INFO - Bus: Built-In 04:34:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:13 INFO - Vendor: Intel (0x8086) 04:34:13 INFO - Device ID: 0x0a2e 04:34:13 INFO - Revision ID: 0x0009 04:34:13 INFO - Displays: 04:34:13 INFO - Display: 04:34:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:13 INFO - Display Serial Number: 1600x1200 60 04:34:13 INFO - Main Display: Yes 04:34:13 INFO - Mirror: Off 04:34:13 INFO - Online: Yes 04:34:13 INFO - Rotation: Supported 04:34:13 INFO - Return code: 0 04:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:13 INFO - Python 2.7.3 04:34:13 INFO - Return code: 0 04:34:13 INFO - grabbing minidump binary from tooltool 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 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 0x1068f5d30>, '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 0x10681cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068eabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:34:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:34:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:34:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:14 INFO - Return code: 0 04:34:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:34:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:34:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gf3ARSGMp1/Render', 04:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:14 INFO - 'HOME': '/Users/cltbld', 04:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:14 INFO - 'LOGNAME': 'cltbld', 04:34:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:14 INFO - 'MOZ_NO_REMOTE': '1', 04:34:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:14 INFO - 'NO_EM_RESTART': '1', 04:34:14 INFO - 'PAGER': '/bin/cat', 04:34:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:14 INFO - 'PWD': '/builds/slave/test', 04:34:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:14 INFO - 'SHELL': '/bin/bash', 04:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euDeqyT2Ss/Listeners', 04:34:14 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 04:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:14 INFO - 'USER': 'cltbld', 04:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:14 INFO - 'XPC_FLAGS': '0x0', 04:34:14 INFO - 'XPC_SERVICE_NAME': '0', 04:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:34:14 INFO - mozversion application_buildid: 20170128030204 04:34:14 INFO - mozversion application_changeset: 045d8fe30f546ab08466c9586ce298e6459c2069 04:34:14 INFO - mozversion application_display_name: Nightly 04:34:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:14 INFO - mozversion application_name: Firefox 04:34:14 INFO - mozversion application_remotingname: firefox 04:34:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:34:14 INFO - mozversion application_vendor: Mozilla 04:34:14 INFO - mozversion application_version: 54.0a1 04:34:14 INFO - mozversion platform_buildid: 20170128030204 04:34:14 INFO - mozversion platform_changeset: 045d8fe30f546ab08466c9586ce298e6459c2069 04:34:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:34:14 INFO - mozversion platform_version: 54.0a1 04:34:14 INFO - using testdate: 1485606854 04:34:14 INFO - actual date: 1485606854 04:34:14 INFO - starting webserver on 'localhost:49235' 04:34:14 INFO - SUITE-START | Running 2 tests 04:34:14 INFO - TEST-START | dromaeo_css 04:34:14 INFO - operating with platform_type : mac_ 04:34:14 INFO - Initialising browser for dromaeo_css test... 04:34:14 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpnnJo_K/profile http://localhost:49235/getInfo.html) 04:34:17 INFO - PROCESS | 1780 | 2017-01-28 04:34:17.251 plugin-container[1783:20286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:34:17 INFO - PROCESS | 1780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:17 INFO - PROCESS | 1780 | 2017-01-28 04:34:17.253 plugin-container[1783:20286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 04:34:17 INFO - PROCESS | 1780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:17 INFO - PROCESS | 1780 | 2017-01-28 04:34:17.253 plugin-container[1783:20286] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:34:17 INFO - PROCESS | 1780 | __metrics Screen width/height:1600/1200 04:34:17 INFO - PROCESS | 1780 | colorDepth:24 04:34:17 INFO - PROCESS | 1780 | Browser inner width/height: 1024/689 04:34:17 INFO - PROCESS | 1780 | __metrics 04:34:17 ERROR - PROCESS | 1780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 04:34:18 INFO - TEST-INFO | 1780: exit 0 04:34:18 INFO - Browser initialized. 04:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:18 INFO - TEST-INFO | started process 1785 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpnnJo_K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:20 INFO - PROCESS | 1785 | 2017-01-28 04:34:20.408 plugin-container[1786:20420] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:34:20 INFO - PROCESS | 1785 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:20 INFO - PROCESS | 1785 | 2017-01-28 04:34:20.408 plugin-container[1786:20420] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 04:34:20 INFO - PROCESS | 1785 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:20 INFO - PROCESS | 1785 | 2017-01-28 04:34:20.408 plugin-container[1786:20420] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:34:30 INFO - PROCESS | 1785 | RSS: Main: 233525248 04:34:30 INFO - PROCESS | 1785 | 04:37:32 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 04:37:34 INFO - PROCESS | 1785 | RSS: Main: 257265664 04:37:34 INFO - PROCESS | 1785 | 04:39:18 INFO - PROCESS | 1785 | ************************* 04:39:18 INFO - PROCESS | 1785 | A coding exception was thrown and uncaught in a Task. 04:39:18 INFO - PROCESS | 1785 | 04:39:18 ERROR - PROCESS | 1785 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:18 INFO - PROCESS | 1785 | Full stack: 04:39:18 INFO - PROCESS | 1785 | ************************* 04:40:36 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 04:40:37 INFO - PROCESS | 1785 | RSS: Main: 263454720 04:40:37 INFO - PROCESS | 1785 | 04:43:39 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 04:43:39 INFO - PROCESS | 1785 | RSS: Main: 274513920 04:43:39 INFO - PROCESS | 1785 | 04:46:41 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 04:46:42 INFO - PROCESS | 1785 | RSS: Main: 267464704 04:46:42 INFO - PROCESS | 1785 | 04:49:44 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 04:49:45 INFO - PROCESS | 1785 | RSS: Main: 272474112 04:49:45 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 04:52:48 INFO - PROCESS | 1785 | RSS: Main: 274518016 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | __start_tp_report 04:52:48 INFO - PROCESS | 1785 | _x_x_mozilla_page_load 04:52:48 INFO - PROCESS | 1785 | _x_x_mozilla_page_load_details 04:52:48 INFO - PROCESS | 1785 | |i|pagename|runs| 04:52:48 INFO - PROCESS | 1785 | |0;dojo.html;2965.8072225305355;3302.8678852845887;3327.8336083195836;3337.682920122589;3338.966610333896;5518.061929471989;5533.861653458665;5535.975844468776;5544.1960915667205;5627.887442251153;4927.408710954682;5523.143912693529;5611.8316450506445;5634.0703783875715;5692.089265717486;5094.032133894567;5104.3619547556555;5193.844184674465;5220.556252718505;5225.137852254374;5065.924011139836;5234.345706786652;5276.234945932837;5282.5245727884485;5288.867778305554;5067.037262920034;5085.95737873735;5125.359330083739;5179.7410129493755;5191.532762051395;5121.487851214886;5158.974205128988;5163.612729045299;5207.739613019334;5246.685198888079;5075.746212689351;5096.337476128079;5117.437081920985;5129.7435128243815;5141.126008578551;5540.058190107691;5559.999200143972;5614.719264036782;5615.298087739033;5670.489655930986;6145.078238264251;6160.5687601867885;6201.596896201732;6253.093301471261;6267.59260648061;6230.971889638205;6233.968830155865;6241.531885108589;6245.56281060326;6268.686565671744;5671.262735844314;5861.384554621789;5864.882702345929;5866.560007999417;5893;6168.876622467616;6177.722002509898;6187.907181392283;6191.349908259658;6210.534209934273;6058.757649693963;6094.370893987578;6122.020476723792;6136.693165341715;6137.3862613738265;6114.48026917717;6213.433941255743;6223.937760622426;6245.5628106033055;6276.843078922972;6002.579819412686;6106.582013105394;6122.245686735438;6129.570930034944;6166;6146.692665366714;6205.565610407228;6213.96893015532;6214.378562143749;6234.438900498977;4891.388576427947;4921.114199444134;4927.778249978688;4927.802887884516;4945.258211268267;4318.114786468766;4352.086061927031;4376.015396535754;4390.912181756347;4414.646828253732;5660.122680984454;5718.828435146952;5722.456366645162;5726.997775389374;5741.45456181662;6168.537359697951;6204.689765511706;6233.594816336924;6257.624542527463;6260.436560709558;5608.96234196675;5647.548196144298;5704.1443783432815;5719.399463056402;5758.596898217084;5432.049391356497;5442.6462279951675;5452.563794896399;5479.835604931779;5481.314835645544;5595.972020139955;6077.361877002851;6207.596506227081;6209.223847019122;6218.06728990655;6104.610739188311;6117.857853872152;6173.166622505904;6227.844303892439;6238.282597501164;6105.09585775316;6170.876582468415;6196.597221180609;6209.565330426827;6231.5637905348;5298.788048478018;5328.920066199088;6171;6191.040388739752;6204.13142160089;6127.019676851683;6127.708789264132;6141.938580614136;6258.311585725475;6264.780732674334;5951.137085122719;6053.424924632153;6063.484603808725;6100.962836317748;6120.60216085953;6029.427204415573;6060.181875446935;6063;6089.421504957022;6117.510599152146;5121.385433747825;5651.208830763779;5661.2923384576925;5887.646741195542;5921.940780592139;6109.43503133753;6112.1387513176505;6115.571909966259;6119.837693858789;6124.686092398567;5316.803719163312;5671.234383358194;5909.645421274738;5957.314908785545;5963.493103086286 04:52:48 INFO - PROCESS | 1785 | |1;ext.html;475.2087773856529;496.6970148209594;507.65986788851467;513.5378159656309;525.2987262005223;29937;41092.7672169835;41137.17725645485;42994.570054299445;43057.35413968793;42959;43025.35461968073;43383.34924976128;43455;43473.565264347344;9477.099675530813;9683.176929960926;9694.079062489052;9713.07725766051;11128.888711112866;11160.665180044612;11402.030827379682;11419.657410277705;11422.771544569103;11430.542778288858;11428.942855285753;11474.942625286862;11475.254108482965;11483.59807406741;11495.367754773526;11330.943345283262;11358.772824543505;11379.260348077349;11391.715207119805;11420.257683250562;10691.78616427675;11264.324140551593;11330.923562261572;11338.206325557214;11350.659480215607;33892;36087.27825443503;37761.244775104344;37984.81007594944;38084;3886.630770076838;3914.373700207953;3931.960680393188;3956.6834653227675;4058.7361821481804;28837;29003.709962900313;29082.12753617395;29144.562831557545;29165.56251656227;3142;3236.1100697308193;3239.449293620067;3296.3736889990823;3298.472244440878;465459;473529;479122.9999999965;479478;480102.9999999965;56980;57142;57320.71339643275;57379.42620573741;57426.13860792091;60046.69976650089;60407;60529.09206361908;60569;60763;15128;15535.611609709847;15651.98262112959;15716.842831571537;15718.13550254747;10112.747181320527;11038.944805275922;11293.830592541119;11984.58053968107;12167.087468439902;14568.41726330956;15618.141002244758;17094.91452542729;17641.911790441223;18224.271029158685;6247.781327653601;6743.460523158234;7725.690972361155;8050;8058.315043221274;859.2095272349453;868.3400615532241;871.2492718845431;876.8991565969867;884.0717246890739;25432.74567254341;30208.84895575552;30275.10610666864;30507.237319066757;30786;1054.5096530113533;1058.9788204235872;1097.961571345015;1098.1434481104752;1215.1129675337054;12192.963598094084;15742;15869.920650396674;15913.761293580606;16287.51137465878;245646;246132;247088;247274;247363.76318118293;51494.485055148965;61545.692271538355;62178;62223.688881556205;62387.37612623816;1382.7096309774859;1407.3526177958254;1433.1401159304542;1434.3258668425824;1434.8206474190727;26969.73030269672;29912.85043574768;29951.80192792264;29975.400491990473;30507.38985220239;52268;52543.474565253855;52728;52766;52905.20642190447;535066;537579;539530;541384;541865;24521.754782451946;24613;24815.255542333758;25355.985760569372;27190.72809271961;43182;43426.78286608673;44162.779186103864;44508.10983780371;44690.776546117064;36462;36611.63388366082;37297.81351093336;37318.440223397214;37583.06042348963;36186;36323.45514817227;36961.89114326575;37236.81381593075;37311;35265.64734352624;35373.82313088418;35476;35535.93392198238;36225.91322260336;28776.712232878243;31338.529922050733;32908.34183316368;32988.50517242195;33205;23856.284311470685;24060.87969560141;24173.505392183528;24578.754212457647;24701.38246543779 04:52:48 INFO - PROCESS | 1785 | |2;jquery.html;387.55237700455984;395.6696158707481;407.7145997801538;409.2694540245662;423.8516519218274;18047.368342108028;18956.810431895676;21182;21403.892980535114;21457.785422145793;21680.674789878165;21828.45428864279;22067.227647032356;22072.668909966324;22121.77878221217;5690.857728556778;5956.255468066492;5981.371955944628;5987.341392446828;6022.849428764294;5786.978050255075;5789.652620842763;5810.796622118227;5860.765569377219;5931.911021334683;5843.123531470271;5861.531077513789;5871.471567558919;5881.794137205198;5902.557308201881;5680.289963754531;5762.683052432136;5798.478136967651;5818.0981947798155;5895;5159.097157997336;5160.354955630546;5165.225216217597;5171.7672704728;5188.974055129738;26968.86515567429;27198.864005679847;27228.59157112645;27259.45481090387;27545.173644790688;2689.6906855711454;2763;2764.903228387017;2766.5573508238585;2788.832670039784;15423.768643470357;15694.76457853133;15699.37202511898;15914.010748656417;16256.918715406466;1864.4686264414713;1871.5414723392719;1883.1431698577114;1898.506388339028;1901.439075472725;131430.68569314375;134781.978270326;135357;135428.32285838606;136088;10434.895651043544;10833.945830270955;11629;11753.529858805552;11950.760984780256;13309.267990260629;13894.861051389356;15238.771418428732;15267.160306183267;15279.541613751606;8542.914570854213;8673.869891951626;8934;8989.190972812477;9075.319351048565;8785.472871627595;8821.779455513664;8833.425827321204;8977.832881725333;8991.640334386682;7593.886091708629;7677.9232207677205;7716.42126840478;7773.3004029637605;7776.416768742367;1798.5593529585335;1937.302571074412;2036.1041141897517;2039.3066357438543;2039.5716899450986;977.7555611097225;1003.5032658833778;1040.2510192661273;1048.5910494906993;1060.692399204222;21709.56580868374;21747;22298.442538936655;22545.43636409103;22569.548609028057;1044.738815296176;1053.710229686827;1058.0583280880023;1091.6452153050132;1095.649392194506;11169.888301117047;11763.000144987773;11829.763404731857;11838.644840654793;11933.04535637147;625672.8447219887;708394;719614;727024;735170;134725;135601;135689;136178;136683;851.5231470376609;980.1374790184734;1025.825609646362;1026.7843752811993;1049.7847941172042;15686.529404117895;20435.773853568833;20649.896750516153;20906.47733806667;21017;48851.77870553265;56185;57382.51510894853;60293;64527.032094519556;67369.66315168393;94051;95529.04470955202;96151.51924240334;96847.51576242073;5550.611457197957;7397.704091836266;7583.393328533814;7732.806679833049;8500.574971251537;11559.942200288944;13491.86508134906;13542.526011589547;13867.959903007113;14011.299435028004;9568.569414376509;11021.614243501439;11773;11842.407879606157;11995.340256285988;11048.613298534512;11084.944575277072;11593.942030289794;11771;11902.880971190178;9814.362066465657;11517.596884109016;11726.413679315829;12028.578999734968;12059.939700301442;7512.361449276873;7914.6834126636595;8555.101714319906;8724.825503490021;8860.911390886009;11330.37682927447;11543.307401555934;11791.705207369885;11813.704657383634;11924.821127683264 04:52:48 INFO - PROCESS | 1785 | |3;mootools.html;1421.5806337130552;1444.306732768271;1446.284089375759;1446.8263808342997;1452.2811208451817;6152.692365381736;7619.466637335388;7940;8342.833143337137;8382.287505562026;7796.96101519493;8139.186081391873;8151.266386025257;8162.591870406485;8174.877376839338;2193.1775584155944;2222.6666000099954;2243.9439014024615;2250.9437264068447;2264.7961683448484;2036.226234031066;2112.2712664130927;2268.0587556164173;2305.896234669444;2318.9768102319013;2207.2605677098113;2284.246198754407;2286.0969916882823;2294.357579877637;2295.9426014349606;2272.749997500274;2274.124462082094;2283.897224624896;2291.1522736587403;2296.517731276434;2267.9206227781947;2292.56441276157;2302.1482051640833;2328.3247858121126;2333.404981729648;8150.470219435718;8170.10128885828;8234;8253.546054966975;8268.669253229864;5046.798128074873;5138.743062846843;5161.793528258865;5177.637565370425;5182.222666600002;2966.7033296670375;3140.7487401007866;3186.2512309607223;3195.472746996743;3197.2006998250436;1069.48664640972;1099.5272033025797;1125.1224045244721;1136.0797753819434;1139.128566646516;10423.895761042444;10457.163426925828;10505.894941050568;10547.314424562379;10553.261271710984;3908.6677632400997;4360;4655.394798676218;4659.603933665609;4663.626909847272;9300.72097837066;9301.488418137067;9349.859752103588;9352.672656457127;9401.10689484498;4468;5214.7914083436235;5215.035218484592;5216.947830521646;5222.791088356499;4502.739233014696;4526.207913615104;4639.141758774637;4686.74222917736;4694.741789201558;3766.642168993941;3846.4038074098557;3900.687944964396;3927.6465118139504;3929.842806287774;1100.741325788439;1188.8395066666062;1223.9938800305943;1284.0818814547642;1310.5151094095245;759.8176437655034;762.79785856748;792;817.235884448043;846.0059430169526;5459.590530710133;5488.643238189505;5602.411746766612;5637.126245431965;5771.7114144293455;945.1965829045256;995.6963126246419;997.9051990060933;1012.9493525323704;1048.5124417145912;3688.9262214755554;3710.9609309393413;3770.1140232045445;3829.7127715421457;3865.903352416156;9288.953555232181;9586.712398628053;9632;9639.325247232626;9732.296848051563;8423.578821058922;9281.535923203814;9536.189423898908;9580.856287155699;9602.567884445216;7271.963640181765;7447.702091916262;7592.8481430372185;7634.8091297718;7722.918791369213;4805.567498925114;5551.611387202857;5607.8878422432135;5608;5639.661620302795;8725.432846864933;8780.25367843715;8797.648094076165;8903.020667726416;9091.272698183997;8857.51283679378;9006.684766033157;9040.773980650536;9076;9150.679726209817;6921.515493915377;7063.364297213276;7105.964470177616;7118.145822501333;7151.2848715128075;7608.01095857535;7608.201138880338;7688.077430708351;7690.154083050972;7708.997830282027;5916.319623243382;6757.898631520629;6887.414569761426;6972.1284839395075;7109.2179860216365;6864.38220560152;6880.518363714492;6916.515843890879;6961.095057642474;6973.6164510952385;5420.241166236651;6129.969350153221;6317.399847014526;6369.840753981188;6390.616563006234;4414.55854414556;4944.678595891256;4969.552740253394;5001.624878134082;5025.949740502694;4923.08922849274;4966.304717339648;4987.2046063417865;5049.747512624281;5058.064258112261 04:52:48 INFO - PROCESS | 1785 | |4;prototype.html;333.20364329253084;358.23874267182237;370.8739028730232;373.54054512949057;377.09309111586646;4369.300911854108;4654.882028676952;5480.287562616864;5533.584981126412;5683.545316374685;4040.888755592214;4619.653525985547;5485.040117979358;5496.45478666261;5515.31782806244;3634.7092232621458;4308.655307575402;4323.329883867989;4345.152695224432;4351.586599273064;3270.5119170777357;4180.602842729951;4328.458942632171;4351.543087975749;4377.802998865059;3767.491388662537;4225.485835927618;4266.765327906964;4306.5262821089655;4311.82752689892;3591.3356029134693;3790.355639541257;4055.371417430303;4282.978585107086;4343.413639158736;3354.832258387071;3664.76179048361;3821.312163810513;3829.8468061277517;3837.4627552142724;5150.742462876841;5325.387580428262;5362.88166174359;5369.704666243355;5418.485243901823;4216.2199993001395;4951.579115775164;4997.825076122318;5018.372703412074;5022.468147215098;4832.44426890905;5330.9733451332495;5404.486573775485;5408.457460363468;5987.221661184061;4092.9795351023354;4109.486314210723;4154.881010684542;4211.968067823403;4215.840643822942;5588.804391846306;5902.439268269508;5950.940490595125;6110.2056732624915;6205.441510264098;4320.675949303814;4334.934975975363;4340.414044104005;4344.695871288979;4354.804033818486;4218.388333691598;4308.289132293136;4343.4353534041;4348.021695118637;4360.215161271001;4605.286180641939;4996.7501624918605;5008.724520151427;5035.194368901031;5037.448598737881;5884.175286064093;5958.880822383528;5972.492338151219;5988.3113441953865;6029.457348838626;1096.6764804382726;1111.7220694826294;1318.8328329428334;1323.6889331007205;1334.3261652865242;801.5190885468672;827.4290739389802;842.2798507276314;870.3211495033884;904.5522466379184;5250.789968401297;5284.682919024871;5302.144249512639;5321.5476684482255;5356.678599284055;5035.84892453227;5799.39106393831;5809.854753631109;5827.388124246978;5845.298564172326;4148.610215577815;4555.817767289338;4585.922308257557;4814.133455977958;5253.264542963988;2729.249456399506;2852.914412567626;2939.4415061138316;2963.688812674638;2974.6168031865286;4868.732219727878;5293.57651387888;6022.849428764228;6023.608465449732;6046.455818976313;5583.916241256385;5667.753094319243;5768.451997060272;5958.267158111306;5973.522118230531;5058.31712718793;5276.208568714724;5488.5334746545395;5767.769289228384;6008.279006519246;5185.444366689902;5202.375714914235;5575.944240557543;5709.343425505954;5852.4440178183;4758.547937945889;5321.882404694902;5707.4577915098;5718.79984200551;5791.305043394651;5353.437889021597;5367.463253674601;5615.606907516598;6009.338972712911;6016.42843929826;3378.9790149721753;3606.1165014570547;3782.3759079751535;3855.3445914194094;3887.2614203302414;4991.675541089818;5263.710390954241;5821.359650438364;5843.2695913010875;5925.614835035882;4663.626909847272;4753.336332283673;5185.844424667266;5723.484886360247;5862.589618726648;4956.8760780980765;5464.808731694372;5488.313960754906;5823.4467725566;5865.882682346244;5203.869903252449;5361.597880158925;5679.6024278301775;5689.459501347365;5692.459216374438;4707.023050318943;4792.544708252711;5514.61397702157;5525.281713377235;5791.218185545066;4952.479989601185;5027.366106015486;5563.833085007456;5579.916301255404;5644.463775941279 04:52:48 INFO - PROCESS | 1785 | |5;yui.html;697.0972590495314;721.1706537481898;728.7303697631877;733.8092096055024;741.6588369350101;14909.32908019139;14943;15966.042037477744;16024.679506409864;16042.59893502663;14630.414783408678;14719.55841324762;14729.263536823142;14761.630959226024;14788.260586970662;666.9399754022137;691.3673988300699;840.2689659995813;865.2299453486402;874.8731433942074;864.8486514859906;868.8522951098329;875.5140896802272;875.5665945357057;878.6221924572432;922.280621115531;925.5557332480413;926.2589928057561;927.6335847340297;928.5542939389063;905.248643625789;916.4776077635751;919.5540163020929;920.1902325953151;920.2775820980531;672.8486090629618;685.7839780469136;686.193722376206;686.6944209826629;688.683205725367;15627.218639068114;15907.284172212278;16046.5988350291;16095.034297942044;16200.189990500545;14784.852151478455;14798.556043318718;14907.478238261609;14937.775933361008;15428.228588570639;11749.706257343549;11925.880741192565;11987.760244795056;12022.218555793845;12561.685957851036;3791.696664266852;3800.8669696560764;3822.694184465236;3844.519435070616;3961.841526338943;107268;108283;109701.80596388107;110113;110233.52781485746;9994.350367226107;10463.372197668165;11266.94366528162;11527.020203282815;11725.296482211095;22353;23203.591317649592;24380.634290485657;24451.26646200617;24589.87705061499;7991.880121798177;8048.5170889746805;8067.072286686989;8195.918040819635;8339.83320333602;4245.341971994346;4304.133485020867;4339.457567804025;4358.782060896942;4437.755923424178;3676.5771936227675;3724.6089160637744;3724.7206459515646;3763.736538442283;3765.491658626105;672.3814091036259;673.3367632881608;678.372505432473;680.0377465885716;689.675852349395;606.2512796696077;674.2347435660561;690.4476418864888;698.9266127056687;711.2141084101993;9341.392809467363;9873.555689993967;10245.231607629457;10335.948320258502;10351.792964140675;665.9598930880611;690.1338819781242;698.6925752668911;704.8907419350008;711.3775446484326;4775.355327030876;4981.37732783402;4996.425411077773;5006.699598024057;5012.649114561946;73368.63315683388;89070.55464722635;91619;99351;99526.00473995312;79437.20562794298;84561;85658.28683426297;86343.56828215819;89537;57158;58214.12678809821;69522.30477695158;76118.61940690261;77091.61454192693;9532.61869525239;9889.307748457539;10465.215108866712;10885.782284354427;10919.290246133976;41449.96375090647;50502.747486262335;50642.74678626583;51278.43607819669;53243;68127.65936170287;68534.65732671304;68635;70008.64995675193;71159.28840711527;12795.552155674506;12866.549670761478;12933.870661293267;13294.734105318033;13553.525626603021;11369.715757106138;14575.271236438348;14640.487582934546;14898.478553250585;14953.476628317956;11356.602518911799;13445.327733613085;13519.391627376988;13628.182309061489;13709.725805484033;13227.40476678571;13481.865181348061;13497.932510337385;13625.437881975598;14001;13260.53588124411;13379.598612041655;13983.790243146565;13990.790138148139;14084.084534505224;10431.68704938853;10522.547606026013;10603.787924241318;10919.12646988223;10962.232643714864;8121.431499794958;8446.493210407149;9945.701628951143;10659.467026648792;10727.517261723397 04:52:48 INFO - PROCESS | 1785 | __end_tp_report 04:52:48 INFO - PROCESS | 1785 | __start_cc_report 04:52:48 INFO - PROCESS | 1785 | _x_x_mozilla_cycle_collect,391 04:52:48 INFO - PROCESS | 1785 | __end_cc_report 04:52:48 INFO - PROCESS | 1785 | __startTimestamp1485607968385__endTimestamp 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | ------- Summary: start ------- 04:52:48 INFO - PROCESS | 1785 | Number of tests: 6 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | [#0] dojo.html Cycles:165 Average:5675.16 Median:5887.65 stddev:645.74 (11.0%) stddev-sans-first:611.75 04:52:48 INFO - PROCESS | 1785 | Values: 2965.8 3302.9 3327.8 3337.7 3339.0 5518.1 5533.9 5536.0 5544.2 5627.9 4927.4 5523.1 5611.8 5634.1 5692.1 5094.0 5104.4 5193.8 5220.6 5225.1 5065.9 5234.3 5276.2 5282.5 5288.9 5067.0 5086.0 5125.4 5179.7 5191.5 5121.5 5159.0 5163.6 5207.7 5246.7 5075.7 5096.3 5117.4 5129.7 5141.1 5540.1 5560.0 5614.7 5615.3 5670.5 6145.1 6160.6 6201.6 6253.1 6267.6 6231.0 6234.0 6241.5 6245.6 6268.7 5671.3 5861.4 5864.9 5866.6 5893.0 6168.9 6177.7 6187.9 6191.3 6210.5 6058.8 6094.4 6122.0 6136.7 6137.4 6114.5 6213.4 6223.9 6245.6 6276.8 6002.6 6106.6 6122.2 6129.6 6166.0 6146.7 6205.6 6214.0 6214.4 6234.4 4891.4 4921.1 4927.8 4927.8 4945.3 4318.1 4352.1 4376.0 4390.9 4414.6 5660.1 5718.8 5722.5 5727.0 5741.5 6168.5 6204.7 6233.6 6257.6 6260.4 5609.0 5647.5 5704.1 5719.4 5758.6 5432.0 5442.6 5452.6 5479.8 5481.3 5596.0 6077.4 6207.6 6209.2 6218.1 6104.6 6117.9 6173.2 6227.8 6238.3 6105.1 6170.9 6196.6 6209.6 6231.6 5298.8 5328.9 6171.0 6191.0 6204.1 6127.0 6127.7 6141.9 6258.3 6264.8 5951.1 6053.4 6063.5 6101.0 6120.6 6029.4 6060.2 6063.0 6089.4 6117.5 5121.4 5651.2 5661.3 5887.6 5921.9 6109.4 6112.1 6115.6 6119.8 6124.7 5316.8 5671.2 5909.6 5957.3 5963.5 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | [#1] ext.html Cycles:180 Average:57405.90 Median:33096.75 stddev:116931.86 (353.3%) stddev-sans-first:117181.76 04:52:48 INFO - PROCESS | 1785 | Values: 475.2 496.7 507.7 513.5 525.3 29937.0 41092.8 41137.2 42994.6 43057.4 42959.0 43025.4 43383.3 43455.0 43473.6 9477.1 9683.2 9694.1 9713.1 11128.9 11160.7 11402.0 11419.7 11422.8 11430.5 11428.9 11474.9 11475.3 11483.6 11495.4 11330.9 11358.8 11379.3 11391.7 11420.3 10691.8 11264.3 11330.9 11338.2 11350.7 33892.0 36087.3 37761.2 37984.8 38084.0 3886.6 3914.4 3932.0 3956.7 4058.7 28837.0 29003.7 29082.1 29144.6 29165.6 3142.0 3236.1 3239.4 3296.4 3298.5 465459.0 473529.0 479123.0 479478.0 480103.0 56980.0 57142.0 57320.7 57379.4 57426.1 60046.7 60407.0 60529.1 60569.0 60763.0 15128.0 15535.6 15652.0 15716.8 15718.1 10112.7 11038.9 11293.8 11984.6 12167.1 14568.4 15618.1 17094.9 17641.9 18224.3 6247.8 6743.5 7725.7 8050.0 8058.3 859.2 868.3 871.2 876.9 884.1 25432.7 30208.8 30275.1 30507.2 30786.0 1054.5 1059.0 1098.0 1098.1 1215.1 12193.0 15742.0 15869.9 15913.8 16287.5 245646.0 246132.0 247088.0 247274.0 247363.8 51494.5 61545.7 62178.0 62223.7 62387.4 1382.7 1407.4 1433.1 1434.3 1434.8 26969.7 29912.9 29951.8 29975.4 30507.4 52268.0 52543.5 52728.0 52766.0 52905.2 535066.0 537579.0 539530.0 541384.0 541865.0 24521.8 24613.0 24815.3 25356.0 27190.7 43182.0 43426.8 44162.8 44508.1 44690.8 36462.0 36611.6 37297.8 37318.4 37583.1 36186.0 36323.5 36961.9 37236.8 37311.0 35265.6 35373.8 35476.0 35535.9 36225.9 28776.7 31338.5 32908.3 32988.5 33205.0 23856.3 24060.9 24173.5 24578.8 24701.4 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | [#2] jquery.html Cycles:180 Average:39573.91 Median:22097.22 stddev:117259.87 (530.7%) stddev-sans-first:117551.90 04:52:48 INFO - PROCESS | 1785 | Values: 387.6 395.7 407.7 409.3 423.9 18047.4 18956.8 21182.0 21403.9 21457.8 21680.7 21828.5 22067.2 22072.7 22121.8 5690.9 5956.3 5981.4 5987.3 6022.8 5787.0 5789.7 5810.8 5860.8 5931.9 5843.1 5861.5 5871.5 5881.8 5902.6 5680.3 5762.7 5798.5 5818.1 5895.0 5159.1 5160.4 5165.2 5171.8 5189.0 26968.9 27198.9 27228.6 27259.5 27545.2 2689.7 2763.0 2764.9 2766.6 2788.8 15423.8 15694.8 15699.4 15914.0 16256.9 1864.5 1871.5 1883.1 1898.5 1901.4 131430.7 134782.0 135357.0 135428.3 136088.0 10434.9 10833.9 11629.0 11753.5 11950.8 13309.3 13894.9 15238.8 15267.2 15279.5 8542.9 8673.9 8934.0 8989.2 9075.3 8785.5 8821.8 8833.4 8977.8 8991.6 7593.9 7677.9 7716.4 7773.3 7776.4 1798.6 1937.3 2036.1 2039.3 2039.6 977.8 1003.5 1040.3 1048.6 1060.7 21709.6 21747.0 22298.4 22545.4 22569.5 1044.7 1053.7 1058.1 1091.6 1095.6 11169.9 11763.0 11829.8 11838.6 11933.0 625672.8 708394.0 719614.0 727024.0 735170.0 134725.0 135601.0 135689.0 136178.0 136683.0 851.5 980.1 1025.8 1026.8 1049.8 15686.5 20435.8 20649.9 20906.5 21017.0 48851.8 56185.0 57382.5 60293.0 64527.0 67369.7 94051.0 95529.0 96151.5 96847.5 5550.6 7397.7 7583.4 7732.8 8500.6 11559.9 13491.9 13542.5 13868.0 14011.3 9568.6 11021.6 11773.0 11842.4 11995.3 11048.6 11084.9 11593.9 11771.0 11902.9 9814.4 11517.6 11726.4 12028.6 12059.9 7512.4 7914.7 8555.1 8724.8 8860.9 11330.4 11543.3 11791.7 11813.7 11924.8 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | [#3] mootools.html Cycles:180 Average:5290.22 Median:5215.99 stddev:2853.24 (54.7%) stddev-sans-first:2846.43 04:52:48 INFO - PROCESS | 1785 | Values: 1421.6 1444.3 1446.3 1446.8 1452.3 6152.7 7619.5 7940.0 8342.8 8382.3 7797.0 8139.2 8151.3 8162.6 8174.9 2193.2 2222.7 2243.9 2250.9 2264.8 2036.2 2112.3 2268.1 2305.9 2319.0 2207.3 2284.2 2286.1 2294.4 2295.9 2272.7 2274.1 2283.9 2291.2 2296.5 2267.9 2292.6 2302.1 2328.3 2333.4 8150.5 8170.1 8234.0 8253.5 8268.7 5046.8 5138.7 5161.8 5177.6 5182.2 2966.7 3140.7 3186.3 3195.5 3197.2 1069.5 1099.5 1125.1 1136.1 1139.1 10423.9 10457.2 10505.9 10547.3 10553.3 3908.7 4360.0 4655.4 4659.6 4663.6 9300.7 9301.5 9349.9 9352.7 9401.1 4468.0 5214.8 5215.0 5216.9 5222.8 4502.7 4526.2 4639.1 4686.7 4694.7 3766.6 3846.4 3900.7 3927.6 3929.8 1100.7 1188.8 1224.0 1284.1 1310.5 759.8 762.8 792.0 817.2 846.0 5459.6 5488.6 5602.4 5637.1 5771.7 945.2 995.7 997.9 1012.9 1048.5 3688.9 3711.0 3770.1 3829.7 3865.9 9289.0 9586.7 9632.0 9639.3 9732.3 8423.6 9281.5 9536.2 9580.9 9602.6 7272.0 7447.7 7592.8 7634.8 7722.9 4805.6 5551.6 5607.9 5608.0 5639.7 8725.4 8780.3 8797.6 8903.0 9091.3 8857.5 9006.7 9040.8 9076.0 9150.7 6921.5 7063.4 7106.0 7118.1 7151.3 7608.0 7608.2 7688.1 7690.2 7709.0 5916.3 6757.9 6887.4 6972.1 7109.2 6864.4 6880.5 6916.5 6961.1 6973.6 5420.2 6130.0 6317.4 6369.8 6390.6 4414.6 4944.7 4969.6 5001.6 5025.9 4923.1 4966.3 4987.2 5049.7 5058.1 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | [#4] prototype.html Cycles:180 Average:4620.50 Median:5104.53 stddev:1393.84 (27.3%) stddev-sans-first:1360.10 04:52:48 INFO - PROCESS | 1785 | Values: 333.2 358.2 370.9 373.5 377.1 4369.3 4654.9 5480.3 5533.6 5683.5 4040.9 4619.7 5485.0 5496.5 5515.3 3634.7 4308.7 4323.3 4345.2 4351.6 3270.5 4180.6 4328.5 4351.5 4377.8 3767.5 4225.5 4266.8 4306.5 4311.8 3591.3 3790.4 4055.4 4283.0 4343.4 3354.8 3664.8 3821.3 3829.8 3837.5 5150.7 5325.4 5362.9 5369.7 5418.5 4216.2 4951.6 4997.8 5018.4 5022.5 4832.4 5331.0 5404.5 5408.5 5987.2 4093.0 4109.5 4154.9 4212.0 4215.8 5588.8 5902.4 5950.9 6110.2 6205.4 4320.7 4334.9 4340.4 4344.7 4354.8 4218.4 4308.3 4343.4 4348.0 4360.2 4605.3 4996.8 5008.7 5035.2 5037.4 5884.2 5958.9 5972.5 5988.3 6029.5 1096.7 1111.7 1318.8 1323.7 1334.3 801.5 827.4 842.3 870.3 904.6 5250.8 5284.7 5302.1 5321.5 5356.7 5035.8 5799.4 5809.9 5827.4 5845.3 4148.6 4555.8 4585.9 4814.1 5253.3 2729.2 2852.9 2939.4 2963.7 2974.6 4868.7 5293.6 6022.8 6023.6 6046.5 5583.9 5667.8 5768.5 5958.3 5973.5 5058.3 5276.2 5488.5 5767.8 6008.3 5185.4 5202.4 5575.9 5709.3 5852.4 4758.5 5321.9 5707.5 5718.8 5791.3 5353.4 5367.5 5615.6 6009.3 6016.4 3379.0 3606.1 3782.4 3855.3 3887.3 4991.7 5263.7 5821.4 5843.3 5925.6 4663.6 4753.3 5185.8 5723.5 5862.6 4956.9 5464.8 5488.3 5823.4 5865.9 5203.9 5361.6 5679.6 5689.5 5692.5 4707.0 4792.5 5514.6 5525.3 5791.2 4952.5 5027.4 5563.8 5579.9 5644.5 04:52:48 INFO - PROCESS | 1785 | 04:52:48 INFO - PROCESS | 1785 | [#5] yui.html Cycles:180 Average:19984.68 Median:4349.12 stddev:28085.64 (645.8%) stddev-sans-first:28127.09 04:52:48 INFO - PROCESS | 1785 | Values: 697.1 721.2 728.7 733.8 741.7 14909.3 14943.0 15966.0 16024.7 16042.6 14630.4 14719.6 14729.3 14761.6 14788.3 666.9 691.4 840.3 865.2 874.9 864.8 868.9 875.5 875.6 878.6 922.3 925.6 926.3 927.6 928.6 905.2 916.5 919.6 920.2 920.3 672.8 685.8 686.2 686.7 688.7 15627.2 15907.3 16046.6 16095.0 16200.2 14784.9 14798.6 14907.5 14937.8 15428.2 11749.7 11925.9 11987.8 12022.2 12561.7 3791.7 3800.9 3822.7 3844.5 3961.8 107268.0 108283.0 109701.8 110113.0 110233.5 9994.4 10463.4 11266.9 11527.0 11725.3 22353.0 23203.6 24380.6 24451.3 24589.9 7991.9 8048.5 8067.1 8195.9 8339.8 4245.3 4304.1 4339.5 4358.8 4437.8 3676.6 3724.6 3724.7 3763.7 3765.5 672.4 673.3 678.4 680.0 689.7 606.3 674.2 690.4 698.9 711.2 9341.4 9873.6 10245.2 10335.9 10351.8 666.0 690.1 698.7 704.9 711.4 4775.4 4981.4 4996.4 5006.7 5012.6 73368.6 89070.6 91619.0 99351.0 99526.0 79437.2 84561.0 85658.3 86343.6 89537.0 57158.0 58214.1 69522.3 76118.6 77091.6 9532.6 9889.3 10465.2 10885.8 10919.3 41450.0 50502.7 50642.7 51278.4 53243.0 68127.7 68534.7 68635.0 70008.6 71159.3 12795.6 12866.5 12933.9 13294.7 13553.5 11369.7 14575.3 14640.5 14898.5 14953.5 11356.6 13445.3 13519.4 13628.2 13709.7 13227.4 13481.9 13497.9 13625.4 14001.0 13260.5 13379.6 13983.8 13990.8 14084.1 10431.7 10522.5 10603.8 10919.1 10962.2 8121.4 8446.5 9945.7 10659.5 10727.5 04:52:48 INFO - PROCESS | 1785 | -------- Summary: end -------- 04:52:48 INFO - PROCESS | 1785 | 04:52:49 INFO - TEST-INFO | 1785: exit 0 04:52:49 INFO - TEST-OK | dromaeo_css | took 1114797ms 04:52:49 INFO - TEST-START | kraken 04:52:49 INFO - operating with platform_type : mac_ 04:52:49 INFO - Initialising browser for kraken test... 04:52:49 INFO - TEST-INFO | started process 1791 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpePWt1O/profile http://localhost:49235/getInfo.html) 04:52:51 INFO - PROCESS | 1791 | 2017-01-28 04:52:51.840 plugin-container[1793:22421] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:52:51 INFO - PROCESS | 1791 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:51 INFO - PROCESS | 1791 | 2017-01-28 04:52:51.841 plugin-container[1793:22421] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:52:51 INFO - PROCESS | 1791 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:51 INFO - PROCESS | 1791 | 2017-01-28 04:52:51.841 plugin-container[1793:22421] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:52:51 INFO - PROCESS | 1791 | __metrics Screen width/height:1600/1200 04:52:51 INFO - PROCESS | 1791 | colorDepth:24 04:52:51 INFO - PROCESS | 1791 | Browser inner width/height: 1024/689 04:52:51 INFO - PROCESS | 1791 | __metrics 04:52:52 ERROR - PROCESS | 1791 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 04:52:52 INFO - TEST-INFO | 1791: exit 0 04:52:52 INFO - Browser initialized. 04:52:52 INFO - Running cycle 1/1 for kraken test... 04:52:52 INFO - TEST-INFO | started process 1794 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpePWt1O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:55 INFO - PROCESS | 1794 | 2017-01-28 04:52:55.258 plugin-container[1795:22541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 04:52:55 INFO - PROCESS | 1794 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:55 INFO - PROCESS | 1794 | 2017-01-28 04:52:55.259 plugin-container[1795:22541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 04:52:55 INFO - PROCESS | 1794 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:55 INFO - PROCESS | 1794 | 2017-01-28 04:52:55.259 plugin-container[1795:22541] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:04 INFO - PROCESS | 1794 | RSS: Main: 233291776 04:53:04 INFO - PROCESS | 1794 | 04:53:08 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:09 INFO - PROCESS | 1794 | RSS: Main: 246980608 04:53:09 INFO - PROCESS | 1794 | 04:53:11 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 04:53:12 INFO - PROCESS | 1794 | RSS: Main: 255762432 04:53:12 INFO - PROCESS | 1794 | 04:53:15 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 04:53:16 INFO - PROCESS | 1794 | RSS: Main: 257990656 04:53:16 INFO - PROCESS | 1794 | 04:53:18 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 04:53:18 INFO - PROCESS | 1794 | RSS: Main: 260108288 04:53:18 INFO - PROCESS | 1794 | 04:53:20 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:21 INFO - PROCESS | 1794 | RSS: Main: 260472832 04:53:21 INFO - PROCESS | 1794 | 04:53:24 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:24 INFO - PROCESS | 1794 | RSS: Main: 265998336 04:53:24 INFO - PROCESS | 1794 | 04:53:27 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:28 INFO - PROCESS | 1794 | RSS: Main: 265433088 04:53:28 INFO - PROCESS | 1794 | 04:53:31 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 04:53:32 INFO - PROCESS | 1794 | RSS: Main: 265502720 04:53:32 INFO - PROCESS | 1794 | 04:53:33 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:34 INFO - PROCESS | 1794 | RSS: Main: 264810496 04:53:34 INFO - PROCESS | 1794 | 04:53:36 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:37 INFO - PROCESS | 1794 | RSS: Main: 265068544 04:53:37 INFO - PROCESS | 1794 | 04:53:39 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:39 INFO - PROCESS | 1794 | RSS: Main: 264970240 04:53:39 INFO - PROCESS | 1794 | 04:53:42 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:43 INFO - PROCESS | 1794 | RSS: Main: 265433088 04:53:43 INFO - PROCESS | 1794 | 04:53:46 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:47 INFO - PROCESS | 1794 | RSS: Main: 265273344 04:53:47 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 04:53:49 INFO - PROCESS | 1794 | RSS: Main: 267227136 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | __start_tp_report 04:53:49 INFO - PROCESS | 1794 | _x_x_mozilla_page_load 04:53:49 INFO - PROCESS | 1794 | _x_x_mozilla_page_load_details 04:53:49 INFO - PROCESS | 1794 | |i|pagename|runs| 04:53:49 INFO - PROCESS | 1794 | |0;ai-astar;106;117;119;117;117;120;123;170;118;118 04:53:49 INFO - PROCESS | 1794 | |1;audio-beat-detection;142;111;112;148;145;143;117;113;133;117 04:53:49 INFO - PROCESS | 1794 | |2;audio-dft;202;218;200;201;196;197;192;194;245;270 04:53:49 INFO - PROCESS | 1794 | |3;audio-fft;84;60;59;84;59;79;84;73;64;87 04:53:49 INFO - PROCESS | 1794 | |4;audio-oscillator;90;71;83;72;74;97;98;71;71;82 04:53:49 INFO - PROCESS | 1794 | |5;imaging-gaussian-blur;93;89;90;89;97;100;93;88;91;88 04:53:49 INFO - PROCESS | 1794 | |6;imaging-darkroom;116;101;101;102;105;103;99;102;105;102 04:53:49 INFO - PROCESS | 1794 | |7;imaging-desaturate;151;146;93;95;92;95;91;91;77;146 04:53:49 INFO - PROCESS | 1794 | |8;json-parse-financial;62;61;61;60;62;66;75;62;50;48 04:53:49 INFO - PROCESS | 1794 | |9;json-stringify-tinderbox;69;77;75;81;76;77;87;92;73;72 04:53:49 INFO - PROCESS | 1794 | |10;stanford-crypto-aes;97;91;92;91;108;111;110;106;88;94 04:53:49 INFO - PROCESS | 1794 | |11;stanford-crypto-ccm;139;138;183;149;148;166;155;158;200;155 04:53:49 INFO - PROCESS | 1794 | |12;stanford-crypto-pbkdf2;174;181;179;186;244;184;180;180;180;183 04:53:49 INFO - PROCESS | 1794 | |13;stanford-crypto-sha256-iterative;67;66;69;70;70;67;66;69;73;85 04:53:49 INFO - PROCESS | 1794 | __end_tp_report 04:53:49 INFO - PROCESS | 1794 | __start_cc_report 04:53:49 INFO - PROCESS | 1794 | _x_x_mozilla_cycle_collect,918 04:53:49 INFO - PROCESS | 1794 | __end_cc_report 04:53:49 INFO - PROCESS | 1794 | __startTimestamp1485608029460__endTimestamp 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | ------- Summary: start ------- 04:53:49 INFO - PROCESS | 1794 | Number of tests: 14 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#0] ai-astar Cycles:10 Average:122.50 Median:118.50 stddev:17.25 (14.6%) stddev-sans-first:17.23 04:53:49 INFO - PROCESS | 1794 | Values: 106.0 117.0 119.0 117.0 117.0 120.0 123.0 170.0 118.0 118.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:137.50 stddev:15.44 (11.2%) stddev-sans-first:15.54 04:53:49 INFO - PROCESS | 1794 | Values: 142.0 111.0 112.0 148.0 145.0 143.0 117.0 113.0 133.0 117.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#2] audio-dft Cycles:10 Average:211.50 Median:201.50 stddev:25.94 (12.9%) stddev-sans-first:27.29 04:53:49 INFO - PROCESS | 1794 | Values: 202.0 218.0 200.0 201.0 196.0 197.0 192.0 194.0 245.0 270.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#3] audio-fft Cycles:10 Average:73.30 Median:81.50 stddev:11.72 (14.4%) stddev-sans-first:11.77 04:53:49 INFO - PROCESS | 1794 | Values: 84.0 60.0 59.0 84.0 59.0 79.0 84.0 73.0 64.0 87.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:82.50 stddev:10.86 (13.2%) stddev-sans-first:11.01 04:53:49 INFO - PROCESS | 1794 | Values: 90.0 71.0 83.0 72.0 74.0 97.0 98.0 71.0 71.0 82.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:90.50 stddev:4.02 (4.4%) stddev-sans-first:4.24 04:53:49 INFO - PROCESS | 1794 | Values: 93.0 89.0 90.0 89.0 97.0 100.0 93.0 88.0 91.0 88.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:104.00 stddev:4.72 (4.5%) stddev-sans-first:1.92 04:53:49 INFO - PROCESS | 1794 | Values: 116.0 101.0 101.0 102.0 105.0 103.0 99.0 102.0 105.0 102.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:91.50 stddev:28.08 (30.7%) stddev-sans-first:25.03 04:53:49 INFO - PROCESS | 1794 | Values: 151.0 146.0 93.0 95.0 92.0 95.0 91.0 91.0 77.0 146.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:62.00 stddev:7.56 (12.2%) stddev-sans-first:8.00 04:53:49 INFO - PROCESS | 1794 | Values: 62.0 61.0 61.0 60.0 62.0 66.0 75.0 62.0 50.0 48.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:77.00 stddev:7.02 (9.1%) stddev-sans-first:6.66 04:53:49 INFO - PROCESS | 1794 | Values: 69.0 77.0 75.0 81.0 76.0 77.0 87.0 92.0 73.0 72.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#10] stanford-crypto-aes Cycles:10 Average:98.80 Median:91.00 stddev:8.95 (9.8%) stddev-sans-first:9.47 04:53:49 INFO - PROCESS | 1794 | Values: 97.0 91.0 92.0 91.0 108.0 111.0 110.0 106.0 88.0 94.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#11] stanford-crypto-ccm Cycles:10 Average:159.10 Median:156.50 stddev:19.44 (12.4%) stddev-sans-first:19.21 04:53:49 INFO - PROCESS | 1794 | Values: 139.0 138.0 183.0 149.0 148.0 166.0 155.0 158.0 200.0 155.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.10 Median:182.00 stddev:20.25 (11.1%) stddev-sans-first:20.92 04:53:49 INFO - PROCESS | 1794 | Values: 174.0 181.0 179.0 186.0 244.0 184.0 180.0 180.0 180.0 183.0 04:53:49 INFO - PROCESS | 1794 | 04:53:49 INFO - PROCESS | 1794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:5.63 (8.1%) stddev-sans-first:5.85 04:53:49 INFO - PROCESS | 1794 | Values: 67.0 66.0 69.0 70.0 70.0 67.0 66.0 69.0 73.0 85.0 04:53:49 INFO - PROCESS | 1794 | -------- Summary: end -------- 04:53:49 INFO - PROCESS | 1794 | 04:53:50 INFO - TEST-INFO | 1794: exit 0 04:53:50 INFO - TEST-OK | kraken | took 61340ms 04:53:50 INFO - SUITE-END | took 1176s 04:53:50 INFO - Completed test suite (00:19:36) 04:53:50 INFO - javascript benchmark 04:53:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7305.654936945595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2965.8072225305355, 3302.8678852845887, 3327.8336083195836, 3337.682920122589, 3338.966610333896, 5518.061929471989, 5533.861653458665, 5535.975844468776, 5544.1960915667205, 5627.887442251153, 4927.408710954682, 5523.143912693529, 5611.8316450506445, 5634.0703783875715, 5692.089265717486, 5094.032133894567, 5104.3619547556555, 5193.844184674465, 5220.556252718505, 5225.137852254374, 5065.924011139836, 5234.345706786652, 5276.234945932837, 5282.5245727884485, 5288.867778305554, 5067.037262920034, 5085.95737873735, 5125.359330083739, 5179.7410129493755, 5191.532762051395, 5121.487851214886, 5158.974205128988, 5163.612729045299, 5207.739613019334, 5246.685198888079, 5075.746212689351, 5096.337476128079, 5117.437081920985, 5129.7435128243815, 5141.126008578551, 5540.058190107691, 5559.999200143972, 5614.719264036782, 5615.298087739033, 5670.489655930986, 6145.078238264251, 6160.5687601867885, 6201.596896201732, 6253.093301471261, 6267.59260648061, 6230.971889638205, 6233.968830155865, 6241.531885108589, 6245.56281060326, 6268.686565671744, 5671.262735844314, 5861.384554621789, 5864.882702345929, 5866.560007999417, 5893.0, 6168.876622467616, 6177.722002509898, 6187.907181392283, 6191.349908259658, 6210.534209934273, 6058.757649693963, 6094.370893987578, 6122.020476723792, 6136.693165341715, 6137.3862613738265, 6114.48026917717, 6213.433941255743, 6223.937760622426, 6245.5628106033055, 6276.843078922972, 6002.579819412686, 6106.582013105394, 6122.245686735438, 6129.570930034944, 6166.0, 6146.692665366714, 6205.565610407228, 6213.96893015532, 6214.378562143749, 6234.438900498977, 4891.388576427947, 4921.114199444134, 4927.778249978688, 4927.802887884516, 4945.258211268267, 4318.114786468766, 4352.086061927031, 4376.015396535754, 4390.912181756347, 4414.646828253732, 5660.122680984454, 5718.828435146952, 5722.456366645162, 5726.997775389374, 5741.45456181662, 6168.537359697951, 6204.689765511706, 6233.594816336924, 6257.624542527463, 6260.436560709558, 5608.96234196675, 5647.548196144298, 5704.1443783432815, 5719.399463056402, 5758.596898217084, 5432.049391356497, 5442.6462279951675, 5452.563794896399, 5479.835604931779, 5481.314835645544, 5595.972020139955, 6077.361877002851, 6207.596506227081, 6209.223847019122, 6218.06728990655, 6104.610739188311, 6117.857853872152, 6173.166622505904, 6227.844303892439, 6238.282597501164, 6105.09585775316, 6170.876582468415, 6196.597221180609, 6209.565330426827, 6231.5637905348, 5298.788048478018, 5328.920066199088, 6171.0, 6191.040388739752, 6204.13142160089, 6127.019676851683, 6127.708789264132, 6141.938580614136, 6258.311585725475, 6264.780732674334, 5951.137085122719, 6053.424924632153, 6063.484603808725, 6100.962836317748, 6120.60216085953, 6029.427204415573, 6060.181875446935, 6063.0, 6089.421504957022, 6117.510599152146, 5121.385433747825, 5651.208830763779, 5661.2923384576925, 5887.646741195542, 5921.940780592139, 6109.43503133753, 6112.1387513176505, 6115.571909966259, 6119.837693858789, 6124.686092398567, 5316.803719163312, 5671.234383358194, 5909.645421274738, 5957.314908785545, 5963.493103086286], "value": 5632.910736049886, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.2087773856529, 496.6970148209594, 507.65986788851467, 513.5378159656309, 525.2987262005223, 29937.0, 41092.7672169835, 41137.17725645485, 42994.570054299445, 43057.35413968793, 42959.0, 43025.35461968073, 43383.34924976128, 43455.0, 43473.565264347344, 9477.099675530813, 9683.176929960926, 9694.079062489052, 9713.07725766051, 11128.888711112866, 11160.665180044612, 11402.030827379682, 11419.657410277705, 11422.771544569103, 11430.542778288858, 11428.942855285753, 11474.942625286862, 11475.254108482965, 11483.59807406741, 11495.367754773526, 11330.943345283262, 11358.772824543505, 11379.260348077349, 11391.715207119805, 11420.257683250562, 10691.78616427675, 11264.324140551593, 11330.923562261572, 11338.206325557214, 11350.659480215607, 33892.0, 36087.27825443503, 37761.244775104344, 37984.81007594944, 38084.0, 3886.630770076838, 3914.373700207953, 3931.960680393188, 3956.6834653227675, 4058.7361821481804, 28837.0, 29003.709962900313, 29082.12753617395, 29144.562831557545, 29165.56251656227, 3142.0, 3236.1100697308193, 3239.449293620067, 3296.3736889990823, 3298.472244440878, 465459.0, 473529.0, 479122.9999999965, 479478.0, 480102.9999999965, 56980.0, 57142.0, 57320.71339643275, 57379.42620573741, 57426.13860792091, 60046.69976650089, 60407.0, 60529.09206361908, 60569.0, 60763.0, 15128.0, 15535.611609709847, 15651.98262112959, 15716.842831571537, 15718.13550254747, 10112.747181320527, 11038.944805275922, 11293.830592541119, 11984.58053968107, 12167.087468439902, 14568.41726330956, 15618.141002244758, 17094.91452542729, 17641.911790441223, 18224.271029158685, 6247.781327653601, 6743.460523158234, 7725.690972361155, 8050.0, 8058.315043221274, 859.2095272349453, 868.3400615532241, 871.2492718845431, 876.8991565969867, 884.0717246890739, 25432.74567254341, 30208.84895575552, 30275.10610666864, 30507.237319066757, 30786.0, 1054.5096530113533, 1058.9788204235872, 1097.961571345015, 1098.1434481104752, 1215.1129675337054, 12192.963598094084, 15742.0, 15869.920650396674, 15913.761293580606, 16287.51137465878, 245646.0, 246132.0, 247088.0, 247274.0, 247363.76318118293, 51494.485055148965, 61545.692271538355, 62178.0, 62223.688881556205, 62387.37612623816, 1382.7096309774859, 1407.3526177958254, 1433.1401159304542, 1434.3258668425824, 1434.8206474190727, 26969.73030269672, 29912.85043574768, 29951.80192792264, 29975.400491990473, 30507.38985220239, 52268.0, 52543.474565253855, 52728.0, 52766.0, 52905.20642190447, 535066.0, 537579.0, 539530.0, 541384.0, 541865.0, 24521.754782451946, 24613.0, 24815.255542333758, 25355.985760569372, 27190.72809271961, 43182.0, 43426.78286608673, 44162.779186103864, 44508.10983780371, 44690.776546117064, 36462.0, 36611.63388366082, 37297.81351093336, 37318.440223397214, 37583.06042348963, 36186.0, 36323.45514817227, 36961.89114326575, 37236.81381593075, 37311.0, 35265.64734352624, 35373.82313088418, 35476.0, 35535.93392198238, 36225.91322260336, 28776.712232878243, 31338.529922050733, 32908.34183316368, 32988.50517242195, 33205.0, 23856.284311470685, 24060.87969560141, 24173.505392183528, 24578.754212457647, 24701.38246543779], "value": 19376.036641813884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.55237700455984, 395.6696158707481, 407.7145997801538, 409.2694540245662, 423.8516519218274, 18047.368342108028, 18956.810431895676, 21182.0, 21403.892980535114, 21457.785422145793, 21680.674789878165, 21828.45428864279, 22067.227647032356, 22072.668909966324, 22121.77878221217, 5690.857728556778, 5956.255468066492, 5981.371955944628, 5987.341392446828, 6022.849428764294, 5786.978050255075, 5789.652620842763, 5810.796622118227, 5860.765569377219, 5931.911021334683, 5843.123531470271, 5861.531077513789, 5871.471567558919, 5881.794137205198, 5902.557308201881, 5680.289963754531, 5762.683052432136, 5798.478136967651, 5818.0981947798155, 5895.0, 5159.097157997336, 5160.354955630546, 5165.225216217597, 5171.7672704728, 5188.974055129738, 26968.86515567429, 27198.864005679847, 27228.59157112645, 27259.45481090387, 27545.173644790688, 2689.6906855711454, 2763.0, 2764.903228387017, 2766.5573508238585, 2788.832670039784, 15423.768643470357, 15694.76457853133, 15699.37202511898, 15914.010748656417, 16256.918715406466, 1864.4686264414713, 1871.5414723392719, 1883.1431698577114, 1898.506388339028, 1901.439075472725, 131430.68569314375, 134781.978270326, 135357.0, 135428.32285838606, 136088.0, 10434.895651043544, 10833.945830270955, 11629.0, 11753.529858805552, 11950.760984780256, 13309.267990260629, 13894.861051389356, 15238.771418428732, 15267.160306183267, 15279.541613751606, 8542.914570854213, 8673.869891951626, 8934.0, 8989.190972812477, 9075.319351048565, 8785.472871627595, 8821.779455513664, 8833.425827321204, 8977.832881725333, 8991.640334386682, 7593.886091708629, 7677.9232207677205, 7716.42126840478, 7773.3004029637605, 7776.416768742367, 1798.5593529585335, 1937.302571074412, 2036.1041141897517, 2039.3066357438543, 2039.5716899450986, 977.7555611097225, 1003.5032658833778, 1040.2510192661273, 1048.5910494906993, 1060.692399204222, 21709.56580868374, 21747.0, 22298.442538936655, 22545.43636409103, 22569.548609028057, 1044.738815296176, 1053.710229686827, 1058.0583280880023, 1091.6452153050132, 1095.649392194506, 11169.888301117047, 11763.000144987773, 11829.763404731857, 11838.644840654793, 11933.04535637147, 625672.8447219887, 708394.0, 719614.0, 727024.0, 735170.0, 134725.0, 135601.0, 135689.0, 136178.0, 136683.0, 851.5231470376609, 980.1374790184734, 1025.825609646362, 1026.7843752811993, 1049.7847941172042, 15686.529404117895, 20435.773853568833, 20649.896750516153, 20906.47733806667, 21017.0, 48851.77870553265, 56185.0, 57382.51510894853, 60293.0, 64527.032094519556, 67369.66315168393, 94051.0, 95529.04470955202, 96151.51924240334, 96847.51576242073, 5550.611457197957, 7397.704091836266, 7583.393328533814, 7732.806679833049, 8500.574971251537, 11559.942200288944, 13491.86508134906, 13542.526011589547, 13867.959903007113, 14011.299435028004, 9568.569414376509, 11021.614243501439, 11773.0, 11842.407879606157, 11995.340256285988, 11048.613298534512, 11084.944575277072, 11593.942030289794, 11771.0, 11902.880971190178, 9814.362066465657, 11517.596884109016, 11726.413679315829, 12028.578999734968, 12059.939700301442, 7512.361449276873, 7914.6834126636595, 8555.101714319906, 8724.825503490021, 8860.911390886009, 11330.37682927447, 11543.307401555934, 11791.705207369885, 11813.704657383634, 11924.821127683264], "value": 10257.13087476035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.5806337130552, 1444.306732768271, 1446.284089375759, 1446.8263808342997, 1452.2811208451817, 6152.692365381736, 7619.466637335388, 7940.0, 8342.833143337137, 8382.287505562026, 7796.96101519493, 8139.186081391873, 8151.266386025257, 8162.591870406485, 8174.877376839338, 2193.1775584155944, 2222.6666000099954, 2243.9439014024615, 2250.9437264068447, 2264.7961683448484, 2036.226234031066, 2112.2712664130927, 2268.0587556164173, 2305.896234669444, 2318.9768102319013, 2207.2605677098113, 2284.246198754407, 2286.0969916882823, 2294.357579877637, 2295.9426014349606, 2272.749997500274, 2274.124462082094, 2283.897224624896, 2291.1522736587403, 2296.517731276434, 2267.9206227781947, 2292.56441276157, 2302.1482051640833, 2328.3247858121126, 2333.404981729648, 8150.470219435718, 8170.10128885828, 8234.0, 8253.546054966975, 8268.669253229864, 5046.798128074873, 5138.743062846843, 5161.793528258865, 5177.637565370425, 5182.222666600002, 2966.7033296670375, 3140.7487401007866, 3186.2512309607223, 3195.472746996743, 3197.2006998250436, 1069.48664640972, 1099.5272033025797, 1125.1224045244721, 1136.0797753819434, 1139.128566646516, 10423.895761042444, 10457.163426925828, 10505.894941050568, 10547.314424562379, 10553.261271710984, 3908.6677632400997, 4360.0, 4655.394798676218, 4659.603933665609, 4663.626909847272, 9300.72097837066, 9301.488418137067, 9349.859752103588, 9352.672656457127, 9401.10689484498, 4468.0, 5214.7914083436235, 5215.035218484592, 5216.947830521646, 5222.791088356499, 4502.739233014696, 4526.207913615104, 4639.141758774637, 4686.74222917736, 4694.741789201558, 3766.642168993941, 3846.4038074098557, 3900.687944964396, 3927.6465118139504, 3929.842806287774, 1100.741325788439, 1188.8395066666062, 1223.9938800305943, 1284.0818814547642, 1310.5151094095245, 759.8176437655034, 762.79785856748, 792.0, 817.235884448043, 846.0059430169526, 5459.590530710133, 5488.643238189505, 5602.411746766612, 5637.126245431965, 5771.7114144293455, 945.1965829045256, 995.6963126246419, 997.9051990060933, 1012.9493525323704, 1048.5124417145912, 3688.9262214755554, 3710.9609309393413, 3770.1140232045445, 3829.7127715421457, 3865.903352416156, 9288.953555232181, 9586.712398628053, 9632.0, 9639.325247232626, 9732.296848051563, 8423.578821058922, 9281.535923203814, 9536.189423898908, 9580.856287155699, 9602.567884445216, 7271.963640181765, 7447.702091916262, 7592.8481430372185, 7634.8091297718, 7722.918791369213, 4805.567498925114, 5551.611387202857, 5607.8878422432135, 5608.0, 5639.661620302795, 8725.432846864933, 8780.25367843715, 8797.648094076165, 8903.020667726416, 9091.272698183997, 8857.51283679378, 9006.684766033157, 9040.773980650536, 9076.0, 9150.679726209817, 6921.515493915377, 7063.364297213276, 7105.964470177616, 7118.145822501333, 7151.2848715128075, 7608.01095857535, 7608.201138880338, 7688.077430708351, 7690.154083050972, 7708.997830282027, 5916.319623243382, 6757.898631520629, 6887.414569761426, 6972.1284839395075, 7109.2179860216365, 6864.38220560152, 6880.518363714492, 6916.515843890879, 6961.095057642474, 6973.6164510952385, 5420.241166236651, 6129.969350153221, 6317.399847014526, 6369.840753981188, 6390.616563006234, 4414.55854414556, 4944.678595891256, 4969.552740253394, 5001.624878134082, 5025.949740502694, 4923.08922849274, 4966.304717339648, 4987.2046063417865, 5049.747512624281, 5058.064258112261], "value": 4310.377685047746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.20364329253084, 358.23874267182237, 370.8739028730232, 373.54054512949057, 377.09309111586646, 4369.300911854108, 4654.882028676952, 5480.287562616864, 5533.584981126412, 5683.545316374685, 4040.888755592214, 4619.653525985547, 5485.040117979358, 5496.45478666261, 5515.31782806244, 3634.7092232621458, 4308.655307575402, 4323.329883867989, 4345.152695224432, 4351.586599273064, 3270.5119170777357, 4180.602842729951, 4328.458942632171, 4351.543087975749, 4377.802998865059, 3767.491388662537, 4225.485835927618, 4266.765327906964, 4306.5262821089655, 4311.82752689892, 3591.3356029134693, 3790.355639541257, 4055.371417430303, 4282.978585107086, 4343.413639158736, 3354.832258387071, 3664.76179048361, 3821.312163810513, 3829.8468061277517, 3837.4627552142724, 5150.742462876841, 5325.387580428262, 5362.88166174359, 5369.704666243355, 5418.485243901823, 4216.2199993001395, 4951.579115775164, 4997.825076122318, 5018.372703412074, 5022.468147215098, 4832.44426890905, 5330.9733451332495, 5404.486573775485, 5408.457460363468, 5987.221661184061, 4092.9795351023354, 4109.486314210723, 4154.881010684542, 4211.968067823403, 4215.840643822942, 5588.804391846306, 5902.439268269508, 5950.940490595125, 6110.2056732624915, 6205.441510264098, 4320.675949303814, 4334.934975975363, 4340.414044104005, 4344.695871288979, 4354.804033818486, 4218.388333691598, 4308.289132293136, 4343.4353534041, 4348.021695118637, 4360.215161271001, 4605.286180641939, 4996.7501624918605, 5008.724520151427, 5035.194368901031, 5037.448598737881, 5884.175286064093, 5958.880822383528, 5972.492338151219, 5988.3113441953865, 6029.457348838626, 1096.6764804382726, 1111.7220694826294, 1318.8328329428334, 1323.6889331007205, 1334.3261652865242, 801.5190885468672, 827.4290739389802, 842.2798507276314, 870.3211495033884, 904.5522466379184, 5250.789968401297, 5284.682919024871, 5302.144249512639, 5321.5476684482255, 5356.678599284055, 5035.84892453227, 5799.39106393831, 5809.854753631109, 5827.388124246978, 5845.298564172326, 4148.610215577815, 4555.817767289338, 4585.922308257557, 4814.133455977958, 5253.264542963988, 2729.249456399506, 2852.914412567626, 2939.4415061138316, 2963.688812674638, 2974.6168031865286, 4868.732219727878, 5293.57651387888, 6022.849428764228, 6023.608465449732, 6046.455818976313, 5583.916241256385, 5667.753094319243, 5768.451997060272, 5958.267158111306, 5973.522118230531, 5058.31712718793, 5276.208568714724, 5488.5334746545395, 5767.769289228384, 6008.279006519246, 5185.444366689902, 5202.375714914235, 5575.944240557543, 5709.343425505954, 5852.4440178183, 4758.547937945889, 5321.882404694902, 5707.4577915098, 5718.79984200551, 5791.305043394651, 5353.437889021597, 5367.463253674601, 5615.606907516598, 6009.338972712911, 6016.42843929826, 3378.9790149721753, 3606.1165014570547, 3782.3759079751535, 3855.3445914194094, 3887.2614203302414, 4991.675541089818, 5263.710390954241, 5821.359650438364, 5843.2695913010875, 5925.614835035882, 4663.626909847272, 4753.336332283673, 5185.844424667266, 5723.484886360247, 5862.589618726648, 4956.8760780980765, 5464.808731694372, 5488.313960754906, 5823.4467725566, 5865.882682346244, 5203.869903252449, 5361.597880158925, 5679.6024278301775, 5689.459501347365, 5692.459216374438, 4707.023050318943, 4792.544708252711, 5514.61397702157, 5525.281713377235, 5791.218185545066, 4952.479989601185, 5027.366106015486, 5563.833085007456, 5579.916301255404, 5644.463775941279], "value": 4180.935645338988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.0972590495314, 721.1706537481898, 728.7303697631877, 733.8092096055024, 741.6588369350101, 14909.32908019139, 14943.0, 15966.042037477744, 16024.679506409864, 16042.59893502663, 14630.414783408678, 14719.55841324762, 14729.263536823142, 14761.630959226024, 14788.260586970662, 666.9399754022137, 691.3673988300699, 840.2689659995813, 865.2299453486402, 874.8731433942074, 864.8486514859906, 868.8522951098329, 875.5140896802272, 875.5665945357057, 878.6221924572432, 922.280621115531, 925.5557332480413, 926.2589928057561, 927.6335847340297, 928.5542939389063, 905.248643625789, 916.4776077635751, 919.5540163020929, 920.1902325953151, 920.2775820980531, 672.8486090629618, 685.7839780469136, 686.193722376206, 686.6944209826629, 688.683205725367, 15627.218639068114, 15907.284172212278, 16046.5988350291, 16095.034297942044, 16200.189990500545, 14784.852151478455, 14798.556043318718, 14907.478238261609, 14937.775933361008, 15428.228588570639, 11749.706257343549, 11925.880741192565, 11987.760244795056, 12022.218555793845, 12561.685957851036, 3791.696664266852, 3800.8669696560764, 3822.694184465236, 3844.519435070616, 3961.841526338943, 107268.0, 108283.0, 109701.80596388107, 110113.0, 110233.52781485746, 9994.350367226107, 10463.372197668165, 11266.94366528162, 11527.020203282815, 11725.296482211095, 22353.0, 23203.591317649592, 24380.634290485657, 24451.26646200617, 24589.87705061499, 7991.880121798177, 8048.5170889746805, 8067.072286686989, 8195.918040819635, 8339.83320333602, 4245.341971994346, 4304.133485020867, 4339.457567804025, 4358.782060896942, 4437.755923424178, 3676.5771936227675, 3724.6089160637744, 3724.7206459515646, 3763.736538442283, 3765.491658626105, 672.3814091036259, 673.3367632881608, 678.372505432473, 680.0377465885716, 689.675852349395, 606.2512796696077, 674.2347435660561, 690.4476418864888, 698.9266127056687, 711.2141084101993, 9341.392809467363, 9873.555689993967, 10245.231607629457, 10335.948320258502, 10351.792964140675, 665.9598930880611, 690.1338819781242, 698.6925752668911, 704.8907419350008, 711.3775446484326, 4775.355327030876, 4981.37732783402, 4996.425411077773, 5006.699598024057, 5012.649114561946, 73368.63315683388, 89070.55464722635, 91619.0, 99351.0, 99526.00473995312, 79437.20562794298, 84561.0, 85658.28683426297, 86343.56828215819, 89537.0, 57158.0, 58214.12678809821, 69522.30477695158, 76118.61940690261, 77091.61454192693, 9532.61869525239, 9889.307748457539, 10465.215108866712, 10885.782284354427, 10919.290246133976, 41449.96375090647, 50502.747486262335, 50642.74678626583, 51278.43607819669, 53243.0, 68127.65936170287, 68534.65732671304, 68635.0, 70008.64995675193, 71159.28840711527, 12795.552155674506, 12866.549670761478, 12933.870661293267, 13294.734105318033, 13553.525626603021, 11369.715757106138, 14575.271236438348, 14640.487582934546, 14898.478553250585, 14953.476628317956, 11356.602518911799, 13445.327733613085, 13519.391627376988, 13628.182309061489, 13709.725805484033, 13227.40476678571, 13481.865181348061, 13497.932510337385, 13625.437881975598, 14001.0, 13260.53588124411, 13379.598612041655, 13983.790243146565, 13990.790138148139, 14084.084534505224, 10431.68704938853, 10522.547606026013, 10603.787924241318, 10919.12646988223, 10962.232643714864, 8121.431499794958, 8446.493210407149, 9945.701628951143, 10659.467026648792, 10727.517261723397], "value": 7535.2034576854, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 119.0, 117.0, 117.0, 120.0, 123.0, 170.0, 118.0, 118.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 112.0, 148.0, 145.0, 143.0, 117.0, 113.0, 133.0, 117.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 218.0, 200.0, 201.0, 196.0, 197.0, 192.0, 194.0, 245.0, 270.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 59.0, 84.0, 59.0, 79.0, 84.0, 73.0, 64.0, 87.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 83.0, 72.0, 74.0, 97.0, 98.0, 71.0, 71.0, 82.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 90.0, 89.0, 97.0, 100.0, 93.0, 88.0, 91.0, 88.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 101.0, 101.0, 102.0, 105.0, 103.0, 99.0, 102.0, 105.0, 102.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 146.0, 93.0, 95.0, 92.0, 95.0, 91.0, 91.0, 77.0, 146.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 62.0, 66.0, 75.0, 62.0, 50.0, 48.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 75.0, 81.0, 76.0, 77.0, 87.0, 92.0, 73.0, 72.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 91.0, 92.0, 91.0, 108.0, 111.0, 110.0, 106.0, 88.0, 94.0], "value": 98.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 183.0, 149.0, 148.0, 166.0, 155.0, 158.0, 200.0, 155.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 179.0, 186.0, 244.0, 184.0, 180.0, 180.0, 180.0, 183.0], "value": 187.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 70.0, 70.0, 67.0, 66.0, 69.0, 73.0, 85.0], "value": 70.2, "unit": "score"}]}]} 04:53:50 INFO - Return code: 0 04:53:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:53:50 ERROR - # TBPL SUCCESS # 04:53:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:50 INFO - 2017-01-28 04:53:50.789 screenresolution[1799:22924] starting screenresolution argv=screenresolution get 04:53:50 INFO - 2017-01-28 04:53:50.792 screenresolution[1799:22924] Display 0: 1600x1200x32@60 04:53:50 INFO - 2017-01-28 04:53:50.798 screenresolution[1800:22927] starting screenresolution argv=screenresolution list 04:53:50 INFO - Available Modes on Display 0 04:53:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:51 INFO - Intel Iris: 04:53:51 INFO - Chipset Model: Intel Iris 04:53:51 INFO - Type: GPU 04:53:51 INFO - Bus: Built-In 04:53:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:51 INFO - Vendor: Intel (0x8086) 04:53:51 INFO - Device ID: 0x0a2e 04:53:51 INFO - Revision ID: 0x0009 04:53:51 INFO - Displays: 04:53:51 INFO - Display: 04:53:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:51 INFO - Display Serial Number: 1600x1200 60 04:53:51 INFO - Main Display: Yes 04:53:51 INFO - Mirror: Off 04:53:51 INFO - Online: Yes 04:53:51 INFO - Rotation: Supported 04:53:51 INFO - Return code: 0 04:53:51 INFO - Running post-action listener: _resource_record_post_action 04:53:51 INFO - [mozharness: 2017-01-28 12:53:51.035231Z] Finished run-tests step (success) 04:53:51 INFO - Running post-run listener: _resource_record_post_run 04:53:51 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 34570240; Write bytes: 558601728; Read time: 315; Write time: 1947 04:53:51 INFO - TinderboxPrint: CPU usage
54.5% 04:53:51 INFO - TinderboxPrint: I/O read bytes / time
34,570,240 / 315 04:53:51 INFO - TinderboxPrint: I/O write bytes / time
558,601,728 / 1,947 04:53:51 INFO - TinderboxPrint: CPU idle
2,181.0 (45.5%) 04:53:51 INFO - TinderboxPrint: CPU system
965.3 (20.1%) 04:53:51 INFO - TinderboxPrint: CPU user
1,651.4 (34.4%) 04:53:51 INFO - TinderboxPrint: Swap in / out
282,234,880 / 0 04:53:51 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 242158080; Write bytes: 237544960; Read time: 17828; Write time: 535 04:53:51 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 32653312; Write bytes: 301789184; Read time: 296; Write time: 1361 04:53:51 INFO - Running post-run listener: _upload_blobber_files 04:53:51 INFO - Blob upload gear active. 04:53:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:51 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 04:53:51 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'] 04:53:51 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 04:53:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:53:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:53:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:53 INFO - (blobuploader) - INFO - Done attempting. 04:53:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:53:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:54 INFO - (blobuploader) - INFO - Done attempting. 04:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:55 INFO - (blobuploader) - INFO - Done attempting. 04:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:57 INFO - (blobuploader) - INFO - Done attempting. 04:53:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:57 INFO - Return code: 0 04:53:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7398d0eb59abab0efae2a4a0a5887fcfbc89089b147c9634cbb1b269597467453d26a071eb0b21f6318154d9e30e18ee2c40584e9f572db39be970dbc13c0675", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97ce85e72b8ea54020f35646c6a6d3f3e0a1c32b5d3d4f8b5839847f718d185c9e37ff28146842cbec9465ea4fd27a55051d298b9397afb595daa508f7295a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64c86f96736f22dface50f836d6a23db8e0d0e49d0e5f21dad615342ec1311d813494cff03bf40574520015e6679ab93188e88c645c2a7ebd17b6a6224c853d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11f8d98b3fde253d006cfc1bed16445569a43832a388488b4a2d632524f85e68804e99fcc39a5a0bdea1c0b2fdae27ca5fbe8c70e5b439329fa623b460c7c7ba"} 04:53:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:57 INFO - Contents: 04:53:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7398d0eb59abab0efae2a4a0a5887fcfbc89089b147c9634cbb1b269597467453d26a071eb0b21f6318154d9e30e18ee2c40584e9f572db39be970dbc13c0675", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97ce85e72b8ea54020f35646c6a6d3f3e0a1c32b5d3d4f8b5839847f718d185c9e37ff28146842cbec9465ea4fd27a55051d298b9397afb595daa508f7295a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64c86f96736f22dface50f836d6a23db8e0d0e49d0e5f21dad615342ec1311d813494cff03bf40574520015e6679ab93188e88c645c2a7ebd17b6a6224c853d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11f8d98b3fde253d006cfc1bed16445569a43832a388488b4a2d632524f85e68804e99fcc39a5a0bdea1c0b2fdae27ca5fbe8c70e5b439329fa623b460c7c7ba"} 04:53:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:57 INFO - Copying logs to upload dir... 04:53:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.638414 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-28 04:53:57.394903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-28 04:53:57.398844) ========= 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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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/7398d0eb59abab0efae2a4a0a5887fcfbc89089b147c9634cbb1b269597467453d26a071eb0b21f6318154d9e30e18ee2c40584e9f572db39be970dbc13c0675", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97ce85e72b8ea54020f35646c6a6d3f3e0a1c32b5d3d4f8b5839847f718d185c9e37ff28146842cbec9465ea4fd27a55051d298b9397afb595daa508f7295a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64c86f96736f22dface50f836d6a23db8e0d0e49d0e5f21dad615342ec1311d813494cff03bf40574520015e6679ab93188e88c645c2a7ebd17b6a6224c853d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11f8d98b3fde253d006cfc1bed16445569a43832a388488b4a2d632524f85e68804e99fcc39a5a0bdea1c0b2fdae27ca5fbe8c70e5b439329fa623b460c7c7ba"} build_url:https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/GQ1bF_TIQSOeB3-EvlmsFQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7398d0eb59abab0efae2a4a0a5887fcfbc89089b147c9634cbb1b269597467453d26a071eb0b21f6318154d9e30e18ee2c40584e9f572db39be970dbc13c0675", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97ce85e72b8ea54020f35646c6a6d3f3e0a1c32b5d3d4f8b5839847f718d185c9e37ff28146842cbec9465ea4fd27a55051d298b9397afb595daa508f7295a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64c86f96736f22dface50f836d6a23db8e0d0e49d0e5f21dad615342ec1311d813494cff03bf40574520015e6679ab93188e88c645c2a7ebd17b6a6224c853d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11f8d98b3fde253d006cfc1bed16445569a43832a388488b4a2d632524f85e68804e99fcc39a5a0bdea1c0b2fdae27ca5fbe8c70e5b439329fa623b460c7c7ba"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-28 04:53:57.438531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 04:53:57.439384) ========= 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.Gf3ARSGMp1/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.euDeqyT2Ss/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005052 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 04:53:57.489263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-28 04:53:57.489604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-28 04:53:57.489970) ========= ========= Total master_lag: 0.32 =========