builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0081 starttime: 1484649207.92 results: success (0) buildid: 20170117004014 builduid: 3bb2baae90e441e6a5ac9e51669a917b revision: d306f88dfd3a8701053073ae78d435d06e907d9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:27.918749) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:27.919196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:27.919474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:27.948800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:27.949181) ========= 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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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-17 02:33:27-- 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% 16.0M=0.001s 2017-01-17 02:33:28 (16.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127077 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:28.102940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:28.103293) ========= 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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.028808 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:28.156680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-17 02:33:28.157046) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d306f88dfd3a8701053073ae78d435d06e907d9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d306f88dfd3a8701053073ae78d435d06e907d9c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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-17 02:33:28,252 truncating revision to first 12 chars 2017-01-17 02:33:28,252 Setting DEBUG logging. 2017-01-17 02:33:28,252 attempt 1/10 2017-01-17 02:33:28,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d306f88dfd3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 02:33:30,382 unpacking tar archive at: mozilla-aurora-d306f88dfd3a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.403774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-17 02:33:30.585021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:30.585340) ========= script_repo_revision: d306f88dfd3a8701053073ae78d435d06e907d9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:30.585740) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:30.586020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 02:33:30.605828) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-17 02:33:30.606208) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:33:30 INFO - MultiFileLogger online at 20170117 02:33:30 in /builds/slave/test 02:33:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:33:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:30 INFO - {'append_to_log': False, 02:33:30 INFO - 'base_work_dir': '/builds/slave/test', 02:33:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:33:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:30 INFO - 'branch': 'Mozilla-Aurora', 02:33:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:30 INFO - 'config_files': ('talos/mac_config.py',), 02:33:30 INFO - 'default_actions': ('clobber', 02:33:30 INFO - 'read-buildbot-config', 02:33:30 INFO - 'download-and-extract', 02:33:30 INFO - 'populate-webroot', 02:33:30 INFO - 'create-virtualenv', 02:33:30 INFO - 'install', 02:33:30 INFO - 'run-tests'), 02:33:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:30 INFO - 'download_minidump_stackwalk': True, 02:33:30 INFO - 'download_symbols': 'ondemand', 02:33:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:30 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:30 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:30 INFO - 'installer_path': 'installer.exe', 02:33:30 INFO - 'log_level': 'info', 02:33:30 INFO - 'log_name': 'talos', 02:33:30 INFO - 'log_to_console': True, 02:33:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:33:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:33:30 INFO - 'opt_config_files': (), 02:33:30 INFO - 'pip_index': False, 02:33:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:30 INFO - 'cmd': ('bash', 02:33:30 INFO - '-c', 02:33:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:30 INFO - 'enabled': True, 02:33:30 INFO - 'halt_on_failure': False, 02:33:30 INFO - 'name': 'check_screen_resolution'},), 02:33:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:30 INFO - 'cmd': ('bash', 02:33:30 INFO - '-c', 02:33:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:30 INFO - 'enabled': True, 02:33:30 INFO - 'halt_on_failure': False, 02:33:30 INFO - 'name': 'check_screen_resolution'},), 02:33:30 INFO - 'run_cmd_checks_enabled': True, 02:33:30 INFO - 'sps_profile': False, 02:33:30 INFO - 'sps_profile_interval': 0, 02:33:30 INFO - 'suite': 'dromaeojs-e10s', 02:33:30 INFO - 'system_bits': '32', 02:33:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:30 INFO - 'title': 't-yosemite-r7-0081', 02:33:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:30 INFO - 'use_talos_json': True, 02:33:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:30 INFO - 'work_dir': 'build'} 02:33:30 INFO - [mozharness: 2017-01-17 10:33:30.812748Z] Running clobber step. 02:33:30 INFO - Running pre-action listener: _resource_record_pre_action 02:33:30 INFO - Running main action method: clobber 02:33:30 INFO - rmtree: /builds/slave/test/build 02:33:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:33 INFO - Running post-action listener: _resource_record_post_action 02:33:33 INFO - [mozharness: 2017-01-17 10:33:33.311247Z] Finished clobber step (success) 02:33:33 INFO - [mozharness: 2017-01-17 10:33:33.311399Z] Running read-buildbot-config step. 02:33:33 INFO - Running pre-action listener: _resource_record_pre_action 02:33:33 INFO - Running main action method: read_buildbot_config 02:33:33 INFO - Using buildbot properties: 02:33:33 INFO - { 02:33:33 INFO - "project": "", 02:33:33 INFO - "product": "firefox", 02:33:33 INFO - "script_repo_revision": "production", 02:33:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:33:33 INFO - "repository": "", 02:33:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:33:33 INFO - "buildid": "20170117004014", 02:33:33 INFO - "stage_platform": "macosx64", 02:33:33 INFO - "basedir": "/builds/slave/test", 02:33:33 INFO - "nightly_build": "True", 02:33:33 INFO - "buildnumber": 17, 02:33:33 INFO - "slavename": "t-yosemite-r7-0081", 02:33:33 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:33:33 INFO - "platform": "yosemite_r7", 02:33:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:33:33 INFO - "branch": "mozilla-aurora", 02:33:33 INFO - "repo_path": "releases/mozilla-aurora", 02:33:33 INFO - "revision": "d306f88dfd3a8701053073ae78d435d06e907d9c", 02:33:33 INFO - "pgo_build": "False", 02:33:33 INFO - "builduid": "3bb2baae90e441e6a5ac9e51669a917b", 02:33:33 INFO - "slavebuilddir": "test" 02:33:33 INFO - } 02:33:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:33:33 INFO - Running post-action listener: _resource_record_post_action 02:33:33 INFO - [mozharness: 2017-01-17 10:33:33.314711Z] Finished read-buildbot-config step (success) 02:33:33 INFO - [mozharness: 2017-01-17 10:33:33.314807Z] Running download-and-extract step. 02:33:33 INFO - Running pre-action listener: _resource_record_pre_action 02:33:33 INFO - Running main action method: download_and_extract 02:33:33 INFO - mkdir: /builds/slave/test/build/tests 02:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:33 INFO - trying https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:33:33 INFO - Downloading https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:33:34 INFO - Downloaded 1199 bytes. 02:33:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:33:34 INFO - Using the following test package requirements: 02:33:34 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:33:34 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:33:34 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:33:34 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'jsshell-mac.zip'], 02:33:34 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:33:34 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:33:34 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:33:34 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:33:34 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:33:34 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:33:34 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:33:34 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:33:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:33:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:34 INFO - Fetch https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:33:34 INFO - Http code: 200 02:33:34 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 02:33:34 INFO - x-amz-cf-id: T9nEe2vXko_qekAm5xIchZxZFG-t1e-S2QA-y5XPSAE7uikXY1isOQ== 02:33:34 INFO - x-amz-version-id: ElGmDoasOVCFwrG5waYHPr.psTfoh1YH 02:33:35 INFO - Expected file size: 16275917 02:33:35 INFO - Obtained file size: 16275917 02:33:41 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:33:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:33:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:41 INFO - Fetch https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:33:42 INFO - Http code: 200 02:33:42 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 02:33:42 INFO - x-amz-cf-id: SrJaNL26imEcxb406ZKKGq8LpeBeGb0OicHKtxglJyIbJ3awxufzyQ== 02:33:42 INFO - x-amz-version-id: ElGmDoasOVCFwrG5waYHPr.psTfoh1YH 02:33:42 INFO - Expected file size: 16275917 02:33:42 INFO - Obtained file size: 16275917 02:33:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:33:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:33:48 INFO - Fetch https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:33:49 INFO - Http code: 200 02:33:49 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 02:33:49 INFO - x-amz-cf-id: tq9f5uIleze4WKPgzOVOfbt1zPpzbmV3B7OqFvJgAI_Il0iqT_bTaQ== 02:33:49 INFO - x-amz-version-id: L2E2LUEgG0IYf1Vq_X39yL4pnchzHb7q 02:33:50 INFO - Expected file size: 14409038 02:33:50 INFO - Obtained file size: 14409038 02: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')]} 02:33:50 INFO - trying https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:33:54 INFO - Downloaded 110049864 bytes. 02:33:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:54 INFO - mkdir: /builds/slave/test/properties 02:33:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:54 INFO - Contents: 02:33:54 INFO - build_url:https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:55 INFO - Running post-action listener: _resource_record_post_action 02:33:55 INFO - Running post-action listener: set_extra_try_arguments 02:33:55 INFO - [mozharness: 2017-01-17 10:33:55.370629Z] Finished download-and-extract step (success) 02:33:55 INFO - [mozharness: 2017-01-17 10:33:55.370747Z] Running populate-webroot step. 02:33:55 INFO - Running pre-action listener: _resource_record_pre_action 02:33:55 INFO - Running main action method: populate_webroot 02:33:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:55 INFO - '--tppagecycles', 02:33:55 INFO - '7'], 02:33:55 INFO - 'tests': ['tsvgm']}}, 02:33:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['damp', 'tps']}, 02:33:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'tests': ['damp', 'tps']}, 02:33:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['dromaeo_dom']}, 02:33:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['basic_compositor_video']}, 02:33:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:33:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['a11yr', 02:33:55 INFO - 'ts_paint', 02:33:55 INFO - 'tpaint', 02:33:55 INFO - 'sessionrestore', 02:33:55 INFO - 'sessionrestore_no_auto_restore', 02:33:55 INFO - 'tabpaint']}, 02:33:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:55 INFO - 'ts_paint', 02:33:55 INFO - 'tpaint', 02:33:55 INFO - 'sessionrestore', 02:33:55 INFO - 'sessionrestore_no_auto_restore', 02:33:55 INFO - 'tabpaint']}, 02:33:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:55 INFO - 'ts_paint', 02:33:55 INFO - 'tpaint', 02:33:55 INFO - 'sessionrestore', 02:33:55 INFO - 'sessionrestore_no_auto_restore', 02:33:55 INFO - 'tabpaint']}, 02:33:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:55 INFO - 'ts_paint', 02:33:55 INFO - 'tpaint', 02:33:55 INFO - 'sessionrestore', 02:33:55 INFO - 'sessionrestore_no_auto_restore', 02:33:55 INFO - 'tabpaint']}, 02:33:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['a11yr', 02:33:55 INFO - 'ts_paint', 02:33:55 INFO - 'tpaint', 02:33:55 INFO - 'sessionrestore', 02:33:55 INFO - 'sessionrestore_no_auto_restore', 02:33:55 INFO - 'tabpaint']}, 02:33:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['a11yr', 02:33:55 INFO - 'ts_paint', 02:33:55 INFO - 'tpaint', 02:33:55 INFO - 'sessionrestore', 02:33:55 INFO - 'sessionrestore_no_auto_restore', 02:33:55 INFO - 'tabpaint']}, 02:33:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['tsvgx', 02:33:55 INFO - 'tsvgr_opacity', 02:33:55 INFO - 'tart', 02:33:55 INFO - 'tscrollx', 02:33:55 INFO - 'cart']}, 02:33:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:55 INFO - 'tsvgr_opacity', 02:33:55 INFO - 'tart', 02:33:55 INFO - 'tscrollx', 02:33:55 INFO - 'cart']}, 02:33:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'talos_options': ['--disable-e10s'], 02:33:55 INFO - 'tests': ['tp5o']}, 02:33:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'tests': ['tp5o']}, 02:33:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'talos_options': ['--disable-e10s', 02:33:55 INFO - '--xperf_path', 02:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:55 INFO - 'tests': ['tp5n']}, 02:33:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:55 INFO - 'talos_options': ['--xperf_path', 02:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:55 INFO - 'tests': ['tp5n']}}, 02:33:55 INFO - 'talos.zip': {'path': '', 02:33:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:55 INFO - Running post-action listener: _resource_record_post_action 02:33:55 INFO - [mozharness: 2017-01-17 10:33:55.389303Z] Finished populate-webroot step (success) 02:33:55 INFO - [mozharness: 2017-01-17 10:33:55.389420Z] Running create-virtualenv step. 02:33:55 INFO - Running pre-action listener: _resource_record_pre_action 02:33:55 INFO - Running main action method: create_virtualenv 02:33:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:55 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 02:33:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:55 INFO - Using real prefix '/tools/python27' 02:33:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:59 INFO - Installing pip.................done. 02:33:59 INFO - Return code: 0 02:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:33:59 INFO - Reading from file tmpfile_stdout 02:33:59 INFO - Output received: 02:33:59 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) 02:33:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:33:59 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 02:33:59 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 02:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:59 INFO - 'HOME': '/Users/cltbld', 02:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:59 INFO - 'LOGNAME': 'cltbld', 02:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:59 INFO - 'MOZ_NO_REMOTE': '1', 02:33:59 INFO - 'NO_EM_RESTART': '1', 02:33:59 INFO - 'PAGER': '/bin/cat', 02:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:59 INFO - 'PWD': '/builds/slave/test', 02:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:59 INFO - 'SHELL': '/bin/bash', 02:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:33:59 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:59 INFO - 'USER': 'cltbld', 02:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:59 INFO - 'XPC_FLAGS': '0x0', 02:33:59 INFO - 'XPC_SERVICE_NAME': '0', 02:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:59 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 02:33:59 INFO - Cleaning up... 02:33:59 INFO - Return code: 0 02:33:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:33:59 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 02:33:59 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 02:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:59 INFO - 'HOME': '/Users/cltbld', 02:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:59 INFO - 'LOGNAME': 'cltbld', 02:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:59 INFO - 'MOZ_NO_REMOTE': '1', 02:33:59 INFO - 'NO_EM_RESTART': '1', 02:33:59 INFO - 'PAGER': '/bin/cat', 02:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:59 INFO - 'PWD': '/builds/slave/test', 02:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:59 INFO - 'SHELL': '/bin/bash', 02:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:33:59 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:59 INFO - 'USER': 'cltbld', 02:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:59 INFO - 'XPC_FLAGS': '0x0', 02:33:59 INFO - 'XPC_SERVICE_NAME': '0', 02:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:59 INFO - Downloading/unpacking psutil>=3.1.1 02:33:59 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 02:33:59 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 02:33:59 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 02:33:59 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 02:33:59 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 02:33:59 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 02:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:03 INFO - Installing collected packages: psutil 02:34:03 INFO - Running setup.py install for psutil 02:34:03 INFO - building 'psutil._psutil_osx' extension 02:34:03 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 02:34:03 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 02:34:03 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 02:34:04 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 02:34:04 INFO - building 'psutil._psutil_posix' extension 02:34:04 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 02:34:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:34:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:34:04 INFO - ^ 02:34:04 INFO - 1 warning generated. 02:34:04 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 02:34:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:04 INFO - Successfully installed psutil 02:34:04 INFO - Cleaning up... 02:34:04 INFO - Return code: 0 02:34:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:04 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:04 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 02:34:04 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 02:34:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:04 INFO - 'HOME': '/Users/cltbld', 02:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:04 INFO - 'LOGNAME': 'cltbld', 02:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:04 INFO - 'MOZ_NO_REMOTE': '1', 02:34:04 INFO - 'NO_EM_RESTART': '1', 02:34:04 INFO - 'PAGER': '/bin/cat', 02:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:04 INFO - 'PWD': '/builds/slave/test', 02:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:04 INFO - 'SHELL': '/bin/bash', 02:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:04 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:04 INFO - 'USER': 'cltbld', 02:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:04 INFO - 'XPC_FLAGS': '0x0', 02:34:04 INFO - 'XPC_SERVICE_NAME': '0', 02:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34:04 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 02:34:04 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 02:34:04 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 02:34:04 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 02:34:04 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 02:34:04 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 02:34:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:07 INFO - Installing collected packages: mozsystemmonitor 02:34:07 INFO - Running setup.py install for mozsystemmonitor 02:34:07 INFO - Successfully installed mozsystemmonitor 02:34:07 INFO - Cleaning up... 02:34:07 INFO - Return code: 0 02:34:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34:07 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')]} 02:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:07 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')]} 02:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:07 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:07 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 02:34:07 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 02:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:07 INFO - 'HOME': '/Users/cltbld', 02:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:07 INFO - 'LOGNAME': 'cltbld', 02:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:07 INFO - 'MOZ_NO_REMOTE': '1', 02:34:07 INFO - 'NO_EM_RESTART': '1', 02:34:07 INFO - 'PAGER': '/bin/cat', 02:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:07 INFO - 'PWD': '/builds/slave/test', 02:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:07 INFO - 'SHELL': '/bin/bash', 02:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:07 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:07 INFO - 'USER': 'cltbld', 02:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:07 INFO - 'XPC_FLAGS': '0x0', 02:34:07 INFO - 'XPC_SERVICE_NAME': '0', 02:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:07 INFO - Downloading/unpacking jsonschema==2.5.1 02:34:07 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 02:34:07 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 02:34:07 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 02:34:07 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 02:34:07 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 02:34:07 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 02:34:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34:10 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 02:34:10 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 02:34:10 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 02:34:10 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 02:34:10 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 02:34:10 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 02:34:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:34:11 INFO - warning: no files found matching '*.txt' 02:34:11 INFO - no previously-included directories found matching 'build' 02:34:11 INFO - no previously-included directories found matching 'dist' 02:34:11 INFO - no previously-included directories found matching '.git*' 02:34:11 INFO - Installing collected packages: jsonschema, functools32 02:34:11 INFO - Running setup.py install for functools32 02:34:11 INFO - warning: no files found matching '*.txt' 02:34:11 INFO - no previously-included directories found matching 'build' 02:34:11 INFO - no previously-included directories found matching 'dist' 02:34:11 INFO - no previously-included directories found matching '.git*' 02:34:11 INFO - Successfully installed jsonschema functools32 02:34:11 INFO - Cleaning up... 02:34:11 INFO - Return code: 0 02:34:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:34:11 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')]} 02:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:11 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')]} 02:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:11 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:11 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 02:34:11 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 02:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:11 INFO - 'HOME': '/Users/cltbld', 02:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:11 INFO - 'LOGNAME': 'cltbld', 02:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:11 INFO - 'MOZ_NO_REMOTE': '1', 02:34:11 INFO - 'NO_EM_RESTART': '1', 02:34:11 INFO - 'PAGER': '/bin/cat', 02:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:11 INFO - 'PWD': '/builds/slave/test', 02:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:11 INFO - 'SHELL': '/bin/bash', 02:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:11 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:11 INFO - 'USER': 'cltbld', 02:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:11 INFO - 'XPC_FLAGS': '0x0', 02:34:11 INFO - 'XPC_SERVICE_NAME': '0', 02:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:34:11 INFO - Cleaning up... 02:34:11 INFO - Return code: 0 02:34:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:34:11 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')]} 02:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:11 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')]} 02:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:11 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:11 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 02:34:11 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 02:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:11 INFO - 'HOME': '/Users/cltbld', 02:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:11 INFO - 'LOGNAME': 'cltbld', 02:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:11 INFO - 'MOZ_NO_REMOTE': '1', 02:34:11 INFO - 'NO_EM_RESTART': '1', 02:34:11 INFO - 'PAGER': '/bin/cat', 02:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:11 INFO - 'PWD': '/builds/slave/test', 02:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:11 INFO - 'SHELL': '/bin/bash', 02:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:11 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:11 INFO - 'USER': 'cltbld', 02:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:11 INFO - 'XPC_FLAGS': '0x0', 02:34:11 INFO - 'XPC_SERVICE_NAME': '0', 02:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:34:11 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 02:34:11 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 02:34:11 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 02:34:11 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 02:34:11 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 02:34:11 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 02:34:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:34:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:34:14 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 02:34:14 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 02:34:14 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 02:34:14 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 02:34:14 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 02:34:14 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 02:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:34:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:34:15 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 02:34:15 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 02:34:15 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 02:34:15 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 02:34:15 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 02:34:15 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 02:34:15 INFO - Downloading docopt-0.6.1.tar.gz 02:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:34:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:34:15 INFO - Running setup.py install for blobuploader 02:34:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:34:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:34:15 INFO - Running setup.py install for requests 02:34:16 INFO - Running setup.py install for docopt 02:34:16 INFO - Successfully installed blobuploader requests docopt 02:34:16 INFO - Cleaning up... 02:34:16 INFO - Return code: 0 02:34:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:16 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')]} 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:16 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')]} 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:16 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:16 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 02:34:16 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 02:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:16 INFO - 'HOME': '/Users/cltbld', 02:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:16 INFO - 'LOGNAME': 'cltbld', 02:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:16 INFO - 'MOZ_NO_REMOTE': '1', 02:34:16 INFO - 'NO_EM_RESTART': '1', 02:34:16 INFO - 'PAGER': '/bin/cat', 02:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:16 INFO - 'PWD': '/builds/slave/test', 02:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:16 INFO - 'SHELL': '/bin/bash', 02:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:16 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:16 INFO - 'USER': 'cltbld', 02:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:16 INFO - 'XPC_FLAGS': '0x0', 02:34:16 INFO - 'XPC_SERVICE_NAME': '0', 02:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:16 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-0UuJYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-fL9End-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-phopvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-kwUbn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-TXkou6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-y2c0En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-_BERUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-WzzX_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-pPdtXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-D7cSE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:17 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-3BKwMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:18 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-cg9yeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:18 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ih2oNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:18 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-K3wjkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:18 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-CQUyoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:18 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-IR_MEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:18 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-kiPdcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:18 INFO - Running setup.py install for manifestparser 02:34:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:18 INFO - Running setup.py install for mozcrash 02:34:18 INFO - Running setup.py install for mozdebug 02:34:19 INFO - Running setup.py install for mozdevice 02:34:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozfile 02:34:19 INFO - Running setup.py install for mozhttpd 02:34:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozinfo 02:34:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozInstall 02:34:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:19 INFO - Running setup.py install for mozleak 02:34:19 INFO - Running setup.py install for mozlog 02:34:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for moznetwork 02:34:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozprocess 02:34:20 INFO - Running setup.py install for mozprofile 02:34:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozrunner 02:34:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozscreenshot 02:34:20 INFO - Running setup.py install for moztest 02:34:21 INFO - Running setup.py install for mozversion 02:34:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:21 INFO - Cleaning up... 02:34:21 INFO - Return code: 0 02:34:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:21 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:21 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 02:34:21 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 02:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:21 INFO - 'HOME': '/Users/cltbld', 02:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:21 INFO - 'LOGNAME': 'cltbld', 02:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:21 INFO - 'MOZ_NO_REMOTE': '1', 02:34:21 INFO - 'NO_EM_RESTART': '1', 02:34:21 INFO - 'PAGER': '/bin/cat', 02:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:21 INFO - 'PWD': '/builds/slave/test', 02:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:21 INFO - 'SHELL': '/bin/bash', 02:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:21 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:21 INFO - 'USER': 'cltbld', 02:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:21 INFO - 'XPC_FLAGS': '0x0', 02:34:21 INFO - 'XPC_SERVICE_NAME': '0', 02:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:21 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-F3xH6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:21 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-OqzEIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:21 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-cZghhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:21 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)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:21 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-MRyDF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:21 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ze4Hn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-RJrpdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-7WGPbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-KgCgLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-fagGrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-AOskfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-OW2Z8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-0u1Enc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-yLjUwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:22 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-1oFvMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:23 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-oFLYDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:23 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-_Ps16I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:23 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-9m6EMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:23 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)) 02:34:23 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)) 02:34:23 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)) 02:34:23 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)) 02:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:34:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34:23 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 02:34:23 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 02:34:23 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 02:34:23 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 02:34:23 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 02:34:23 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 02:34:26 INFO - Downloading blessings-1.6.tar.gz 02:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:34:26 INFO - Installing collected packages: blessings 02:34:26 INFO - Running setup.py install for blessings 02:34:26 INFO - Successfully installed blessings 02:34:26 INFO - Cleaning up... 02:34:26 INFO - Return code: 0 02:34:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:26 INFO - Reading from file tmpfile_stdout 02:34:26 INFO - Current package versions: 02:34:26 INFO - blessings == 1.6 02:34:26 INFO - blobuploader == 1.2.4 02:34:26 INFO - docopt == 0.6.1 02:34:26 INFO - functools32 == 3.2.3-2 02:34:26 INFO - jsonschema == 2.5.1 02:34:26 INFO - manifestparser == 1.1 02:34:26 INFO - mozInstall == 1.12 02:34:26 INFO - mozcrash == 1.0 02:34:26 INFO - mozdebug == 0.1 02:34:26 INFO - mozdevice == 0.48 02:34:26 INFO - mozfile == 1.2 02:34:26 INFO - mozhttpd == 0.7 02:34:26 INFO - mozinfo == 0.9 02:34:26 INFO - mozleak == 0.1 02:34:26 INFO - mozlog == 3.4 02:34:26 INFO - moznetwork == 0.27 02:34:26 INFO - mozprocess == 0.23 02:34:26 INFO - mozprofile == 0.28 02:34:26 INFO - mozrunner == 6.13 02:34:26 INFO - mozscreenshot == 0.1 02:34:26 INFO - mozsystemmonitor == 0.3 02:34:26 INFO - moztest == 0.8 02:34:26 INFO - mozversion == 1.4 02:34:26 INFO - psutil == 3.1.1 02:34:26 INFO - requests == 1.2.3 02:34:26 INFO - wsgiref == 0.1.2 02:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:26 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')]} 02:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:26 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')]} 02:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:26 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:26 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 02:34:26 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 02:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:26 INFO - 'HOME': '/Users/cltbld', 02:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:26 INFO - 'LOGNAME': 'cltbld', 02:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:26 INFO - 'MOZ_NO_REMOTE': '1', 02:34:26 INFO - 'NO_EM_RESTART': '1', 02:34:26 INFO - 'PAGER': '/bin/cat', 02:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:26 INFO - 'PWD': '/builds/slave/test', 02:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:26 INFO - 'SHELL': '/bin/bash', 02:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:26 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:26 INFO - 'USER': 'cltbld', 02:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:26 INFO - 'XPC_FLAGS': '0x0', 02:34:26 INFO - 'XPC_SERVICE_NAME': '0', 02:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 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)) 02:34:27 INFO - Cleaning up... 02:34:27 INFO - Return code: 0 02:34:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:34:27 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')]} 02:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:27 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')]} 02:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:27 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 0x105b57490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105acd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb179dcf1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, '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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 02:34:27 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 02:34:27 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 02:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:27 INFO - 'HOME': '/Users/cltbld', 02:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:27 INFO - 'LOGNAME': 'cltbld', 02:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:27 INFO - 'MOZ_NO_REMOTE': '1', 02:34:27 INFO - 'NO_EM_RESTART': '1', 02:34:27 INFO - 'PAGER': '/bin/cat', 02:34:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:27 INFO - 'PWD': '/builds/slave/test', 02:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:27 INFO - 'SHELL': '/bin/bash', 02:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:27 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:27 INFO - 'USER': 'cltbld', 02:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:27 INFO - 'XPC_FLAGS': '0x0', 02:34:27 INFO - 'XPC_SERVICE_NAME': '0', 02:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:34:27 INFO - Cleaning up... 02:34:27 INFO - Return code: 0 02:34:27 INFO - Running post-action listener: _resource_record_post_action 02:34:27 INFO - Running post-action listener: _start_resource_monitoring 02:34:27 INFO - Starting resource monitoring. 02:34:27 INFO - [mozharness: 2017-01-17 10:34:27.533175Z] Finished create-virtualenv step (success) 02:34:27 INFO - [mozharness: 2017-01-17 10:34:27.534195Z] Running install step. 02:34:27 INFO - Running pre-action listener: _resource_record_pre_action 02:34:27 INFO - Running main action method: install 02:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:27 INFO - Reading from file tmpfile_stdout 02:34:27 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:27 INFO - Reading from file tmpfile_stdout 02:34:27 INFO - Output received: 02:34:27 INFO - Usage: mozinstall [options] installer 02:34:27 INFO - Options: 02:34:27 INFO - -h, --help show this help message and exit 02:34:27 INFO - -d DEST, --destination=DEST 02:34:27 INFO - Directory to install application into. [default: 02:34:27 INFO - "/builds/slave/test"] 02:34:27 INFO - --app=APP Application being installed. [default: firefox] 02:34:27 INFO - mkdir: /builds/slave/test/build/application 02:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:34:59 INFO - Reading from file tmpfile_stdout 02:34:59 INFO - Output received: 02:34:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:34:59 INFO - Running post-action listener: _resource_record_post_action 02:34:59 INFO - [mozharness: 2017-01-17 10:34:59.465200Z] Finished install step (success) 02:34:59 INFO - [mozharness: 2017-01-17 10:34:59.465322Z] Running run-tests step. 02:34:59 INFO - Running pre-action listener: _resource_record_pre_action 02:34:59 INFO - Running main action method: run_tests 02:34:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:59 INFO - 2017-01-17 02:34:59.479 screenresolution[1626:7645] starting screenresolution argv=screenresolution get 02:34:59 INFO - 2017-01-17 02:34:59.482 screenresolution[1626:7645] Display 0: 1600x1200x32@60 02:34:59 INFO - 2017-01-17 02:34:59.488 screenresolution[1627:7647] starting screenresolution argv=screenresolution list 02:34:59 INFO - Available Modes on Display 0 02:34:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:59 INFO - Intel Iris: 02:34:59 INFO - Chipset Model: Intel Iris 02:34:59 INFO - Type: GPU 02:34:59 INFO - Bus: Built-In 02:34:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:59 INFO - Vendor: Intel (0x8086) 02:34:59 INFO - Device ID: 0x0a2e 02:34:59 INFO - Revision ID: 0x0009 02:34:59 INFO - Displays: 02:34:59 INFO - Display: 02:34:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:59 INFO - Display Serial Number: 1600x1200 60 02:34:59 INFO - Main Display: Yes 02:34:59 INFO - Mirror: Off 02:34:59 INFO - Online: Yes 02:34:59 INFO - Rotation: Supported 02:34:59 INFO - Return code: 0 02:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:59 INFO - Python 2.7.3 02:34:59 INFO - Return code: 0 02:34:59 INFO - grabbing minidump binary from tooltool 02:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:59 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 0x10596bd30>, '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 0x1057d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105963b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:59 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 02:34:59 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 02:34:59 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 02:34:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:59 INFO - Return code: 0 02:34:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 02:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0081 --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 02:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ20Rf7gNT/Render', 02:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:59 INFO - 'HOME': '/Users/cltbld', 02:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:59 INFO - 'LOGNAME': 'cltbld', 02:34:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:59 INFO - 'MOZ_NO_REMOTE': '1', 02:34:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:59 INFO - 'NO_EM_RESTART': '1', 02:34:59 INFO - 'PAGER': '/bin/cat', 02:34:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:59 INFO - 'PWD': '/builds/slave/test', 02:34:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:59 INFO - 'SHELL': '/bin/bash', 02:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a4ljGDwd8o/Listeners', 02:34:59 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 02:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:59 INFO - 'USER': 'cltbld', 02:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:59 INFO - 'XPC_FLAGS': '0x0', 02:34:59 INFO - 'XPC_SERVICE_NAME': '0', 02:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 02:35:00 INFO - mozversion application_buildid: 20170117004014 02:35:00 INFO - mozversion application_changeset: d306f88dfd3a8701053073ae78d435d06e907d9c 02:35:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:35:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:35:00 INFO - mozversion application_name: Firefox 02:35:00 INFO - mozversion application_remotingname: firefox-dev 02:35:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:35:00 INFO - mozversion application_vendor: Mozilla 02:35:00 INFO - mozversion application_version: 52.0a2 02:35:00 INFO - mozversion platform_buildid: 20170117004014 02:35:00 INFO - mozversion platform_changeset: d306f88dfd3a8701053073ae78d435d06e907d9c 02:35:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:35:00 INFO - mozversion platform_version: 52.0a2 02:35:00 INFO - using testdate: 1484649300 02:35:00 INFO - actual date: 1484649300 02:35:00 INFO - starting webserver on 'localhost:49241' 02:35:00 INFO - SUITE-START | Running 2 tests 02:35:00 INFO - TEST-START | dromaeo_css 02:35:00 INFO - operating with platform_type : mac_ 02:35:00 INFO - Initialising browser for dromaeo_css test... 02:35:00 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpdTzhel/profile http://localhost:49241/getInfo.html) 02:35:03 INFO - PROCESS | 1637 | 2017-01-17 02:35:03.335 plugin-container[1640:7810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 02:35:03 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:35:03 INFO - PROCESS | 1637 | 2017-01-17 02:35:03.335 plugin-container[1640:7810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d23, name = 'com.apple.CFPasteboardClient' 02:35:03 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:35:03 INFO - PROCESS | 1637 | 2017-01-17 02:35:03.336 plugin-container[1640:7810] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:35:03 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 02:35:03 INFO - PROCESS | 1637 | colorDepth:24 02:35:03 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 02:35:03 INFO - PROCESS | 1637 | __metrics 02:35:03 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 02:35:04 INFO - TEST-INFO | 1637: exit 0 02:35:04 INFO - Browser initialized. 02:35:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:04 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpdTzhel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:06 INFO - PROCESS | 1641 | 2017-01-17 02:35:06.966 plugin-container[1642:7940] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x423b, name = 'com.apple.tsm.portname' 02:35:06 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:35:06 INFO - PROCESS | 1641 | 2017-01-17 02:35:06.967 plugin-container[1642:7940] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 02:35:06 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:35:06 INFO - PROCESS | 1641 | 2017-01-17 02:35:06.967 plugin-container[1642:7940] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:35:16 INFO - PROCESS | 1641 | RSS: Main: 228958208 02:35:16 INFO - PROCESS | 1641 | 02:38:19 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:38:21 INFO - PROCESS | 1641 | RSS: Main: 234172416 02:38:21 INFO - PROCESS | 1641 | 02:41:23 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:41:24 INFO - PROCESS | 1641 | RSS: Main: 243453952 02:41:24 INFO - PROCESS | 1641 | 02:44:26 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:44:26 INFO - PROCESS | 1641 | RSS: Main: 246231040 02:44:26 INFO - PROCESS | 1641 | 02:47:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:47:29 INFO - PROCESS | 1641 | RSS: Main: 245800960 02:47:29 INFO - PROCESS | 1641 | 02:50:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:50:32 INFO - PROCESS | 1641 | RSS: Main: 249118720 02:50:32 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:53:35 INFO - PROCESS | 1641 | RSS: Main: 250380288 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | __start_tp_report 02:53:35 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 02:53:35 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 02:53:35 INFO - PROCESS | 1641 | |i|pagename|runs| 02:53:35 INFO - PROCESS | 1641 | |0;dojo.html;3051.191434269919;3372.258103217291;3377.3751855906644;3383.526306317116;3411.641777613351;5619.971900140498;5645.266115404992;5710.086386178213;5718.970585294651;5739.368669446368;4632.4441067072;5702.857428564288;5704.857378565527;5735.483806457418;5756.654600723959;5153.278541004272;5190.11767999441;5196.2465442511;5253.238280449333;5254.185601231796;4308.870733877973;5216.2958000669805;5268.367795864501;5269.394019687747;5270;5129.769160387773;5133.1786914093755;5226.320578324812;5259.421463639016;5273.129933560977;5139.8458046258675;5211.42674305826;5226.477352264781;5226.843194704146;5241.816536421207;5079.085764562377;5123.513266239701;5144.356955380577;5158.148905430599;5165.044466773659;5703.800366987177;5753.683547404891;5804.738786754606;5824.854378640525;5846.736896839652;6044.486218671418;6107.765388666932;6113.052476866048;6123.908141377883;6243.843903902439;6167;6195.473384762301;6204.937950620481;6221.688915554204;6240.063990401476;4911.410630724265;5816.47651711348;5819.887186788992;5823.184754134425;5880.088586269135;5960.791372301948;6149.96925015372;6151.292601350812;6180.845478862974;6220.564560480813;6040.184575082396;6113.99119145345;6117.327094019654;6124.418180272867;6128.417800308964;5158.845234642967;6162.075688646649;6198.783042593487;6244.219472565929;6259.530535209878;6053.848653783691;6106.755729770848;6120.693965301717;6138.07928810682;6162.506999440034;5134.255532947702;5135.306733590917;6163.445289923929;6204.565680402418;6232;4850.854474365775;4893.584045356113;4895.926561101586;4911.631627627942;4950.6782059166035;4354.760488173181;4383.3863259143745;4409.426774519292;4410.691251612357;4434.179676759745;5595.832125036255;5605.5515558755205;5704.771809127671;5720.11338242573;5790.015697331463;6262.937370626236;6281.089242059876;6284.340144284784;6303.495720342362;6308.936910630927;5592.077307244259;5610.691411972299;5663.801766938137;5717.914231286534;5730.828075157752;5379.327584051994;5391.29913111293;5399.83800485986;5425.511703946664;5437.891242175135;6278.372162783777;6289.182406287154;6306.936930630818;6307.211598550181;6308.747650094128;6068.848278792889;6117.218487018656;6142.7136481981925;6277.780277690259;6292.433680968735;6210.472109870531;6223.222097237845;6269.96865015672;6281.7173227203975;6299.496040316672;6158.261008678987;6170.660613666291;6172.351903050295;6180.134781130735;6190.319064902767;6134.14122022926;6171.753129874754;6233.096201050913;6237.844053898689;6260.7495700171485;5905.940940590711;5991;6026.427489388501;6079.452849243589;6137.171481849893;5978.4021597839865;6073.119397687399;6077.665728384981;6094.603850749687;6118.051701986199;5087.262346959744;5777.884442311214;5870;5910.881782364415;5913.231279933581;5897.882042359214;5922.289325280994;5949.2266005419015;6019.819405417845;6028.758849645965;5899.410058994066;5900.43945825146;5928.318243402064;5938.881222375615;5955.315138759098 02:53:35 INFO - PROCESS | 1641 | |1;ext.html;466.1492775684376;474.77685487820713;477.58927322502643;480.3611197107846;507.08977385592857;33886;40791.59208407919;41175.97060073496;43195.784021079926;43303.13393732123;41151.38272925909;41224;41497;41605;41616;9376.999999999984;9554.044595540425;9569.425834449956;9585.472798996052;9591.424514529115;9544.52277386128;9618.27862910281;9630.855537166948;9634.373765705242;9641.035896410338;9583.66457173999;9613.423194608346;9626.566804493814;9638.37350572214;9647.565859536338;9556.569954352037;9578.042195780436;9619.326647134703;9620.663276785279;9630.518474076269;9375.15623593873;9430.622775088988;9432.952835235848;9439.056094390575;9457.574409151604;39704.20591588181;40133;40176;40216.59783402158;40238.597614023776;3201.823899685516;3478.6521347865264;3664.743467957244;3679.3929001714687;3936.1734035852505;30287.394252115053;30429;30447.847760761277;30717.385652287052;31003.689963100533;3104.2704964333366;3166.5566820645126;3169.9841500792577;3228.725558327545;3251.252211991255;505759;506570;508868;511939;525449;60524.092138617954;60638;60714;60717;60836.783264335354;60516.789664206466;61721.69139154276;62371.688141559;62389.37610623836;62490.375096248456;16128.919355403148;16251.837481625269;16286;16334.428295009619;16338.836611633731;12544.498220071095;12605.810912836314;12671.746565068646;12681;12698.238105713686;14974.577415145544;15489.84510154884;15931.601709957113;16613.667726645643;16723.832761672227;3203.4073696366245;5951.345352011275;6032.849178770566;6841.110655614738;7000.859982800315;880.238593616517;962.6486332488731;1032.210359075293;1095.6548687163677;1103.9834402483968;30485.795496971004;30712.53931191034;30887.918922838042;31228.375432491677;31250.53124203139;989.7773001074701;1028.2391030637275;1035.6168217759478;1087.782443511285;1092.9016388525072;15852.286647100907;15873.52379428619;15891.205439728199;15939.760903586455;16108.75836862448;660334;660931;665252;667670;668787;58555;58921.52696182544;58957.705211474524;59017.704911475164;59209.70395147997;1341.1416693316285;1365.6722386627139;1371.2526672963259;1376.5388594820647;1377.3388773388829;27131.457370852866;29594.55608165836;30125.548116778704;30493.54259686062;30541.694583054774;41424.37863432111;51665.48334516607;52193.478065218864;52203.47796521986;52335;600201;604782;607499.9625001847;608887;609758;26859.865700671373;26921.326966825985;27130.72869271282;27189.456210876066;27273.72726272712;45366.31950520679;46811.76594117007;47056.58830235098;48019.51980480151;48262.75868620775;38740.80629596834;38997.83006509809;39085.2182956345;40000.3999940007;40693.79653101716;33994;36889.26221475609;37896;38224;39158.41262381124;35840.82079589585;35845.1038724034;38469.23061538809;38600.613993859704;38967.2206555873;31243.687563124986;33575.824846130265;34221.82889085539;34753;34812.65187348094;23180.304590862303;24292.54244745321;24401.63397549074;26262.868685657213;26371 02:53:35 INFO - PROCESS | 1641 | |2;jquery.html;366.4887481962662;371.5801144706483;376.2456275168288;384.4636731759198;400.105763618313;18779.62440751184;20031.298904538307;20141.992900355;20474.795252047494;20719.585608287824;15928.920355398206;19512.21951121957;19680.803191968076;19802.405927822154;20270.29053983111;4965.081459929925;5245.44922783108;5494.890102197954;5729.226554415163;5745.540356771448;5523.889522209553;5750.453706897859;5755.4244575542525;5755.68343741094;5783.306003279612;5557.249771280886;5562.193481945115;5680.204771332017;5717.714114294289;5722.713864306789;5603.859903502404;5608.887822243552;5632.464915832989;5694.601377903569;5701.828945131652;4769.213079841857;4906.803727850882;4967.304577359173;4982.078315511642;5015.924761128586;23142.76857231423;23817.809109544454;24342.02631894722;24912.501749965082;24976.250712478653;2171.9782802171935;2185.191479152708;2196.242296407737;2199.3292045925987;2317.9652305215436;9524.95237523808;9929.602815887356;9951.004899510064;10239.795204095877;10263.948680256552;1818.399928023749;1823.9361622343154;1837.0814592703648;1854.88870667759;1866.7479890214784;123514.38242808818;124016.37991809983;124363.75636243612;127104;128602;9343.579538920765;9897.703068907944;10055.597776088875;10160.898391015995;11626.651200463999;12380.752384952251;12451.626451206479;12495.25028498293;12515.186512876633;12529.31088790107;7949.64226609804;8048.275655190944;8098.676052957816;8150.7147249845975;8176.795580110426;8438.240558349778;8469.449485783405;8474.872876906851;8607.26838218746;8644.740657780276;3818.6181381862148;3882.9223415531533;3883.203943191639;3885.55316138642;3941.1132495188926;1898.924043038263;1941.6213838301396;1944.125143685319;1953.579980304213;1958.7257783910263;825.6830355582836;848.499385362639;879.2722300679196;929.693201243588;951.9857202141974;17406.520445762;18405.81594184068;20122.597548048958;20784.1686332545;20901.268455603982;780.3601047141403;911.1207684584408;911.8313112074287;912.977175570616;929.5816882402811;10349.068583827491;10928.289661171999;10959.726006849893;10961.945190273998;10972.835407468894;504533;604109;605953;618896;623550;108044.45977770061;118424;121671.78328216604;129244.35377823238;139143.60856391306;916.6379280184423;931.7204838548408;957.7078990907701;964.7829238421299;1001.2940876682068;18681.06594670234;18782.906085469484;19391.90304048527;19402.8059719401;19448.4165475036;45318.54681453143;49472.01055978932;52683.73658131685;58642.82714345604;59277;76397.0900727464;82463;83769.58115209384;86962;88975.11024889669;7932.405069619917;8093.716719914774;8279.461834980708;8331.583420829056;8517.531535765593;12416.627501174979;12747.872521274669;12802.103852730219;13021.283829389475;13229.272390018257;10992.835107473235;11054.392008439292;11103.944480277547;11282.43587820622;11310.60412885545;11020.889791101987;11153.851910613756;11201.775964480828;11235;11467.713307167387;11174.161937854531;11353.772924541297;11402;11423.771524569629;11835;8028.6351320274525;8126.959365203136;8227.588620568828;8421;8484;10258.948705256425;11038.503267352828;11355.432228388383;11418.771624567627;11597.710057248636 02:53:35 INFO - PROCESS | 1641 | |3;mootools.html;1231.8174552429666;1348.3056226043586;1401.5024666243482;1418.7091646212527;1425.1449130521682;7536.171021187665;7762.611869406535;8103.513789172646;8594.054653988056;8606.827863442735;8017.358611311096;8328.583570821465;8356.456830306026;8396.244338009577;8483.151684831513;2310.953780924385;2345.4019225097663;2347.7417484076736;2353.7646235376496;2356.1046802215133;1686.9156542172905;2319.8376113672048;2352.329586067971;2357.54027964547;2362.870042147681;1882.4729075858713;2293.7935585797277;2329.24299602629;2330.2659662206433;2344.0506594829035;2105.7788932162057;2114.6616541353387;2128.9893550532224;2135.519508110678;2136.038782547852;2093.706881036656;2226.087304205268;2321.9883900580558;2346.425125844179;2353.9176128835406;8360.996680398392;8395.496270223744;8461.53461559614;8462.915370846275;8463.365247606454;5070.847874563769;5073.974630126862;5212.765425555859;5214.426413094557;5241.8165364212455;3364.327134573095;3488.6511348865165;3605.06268370223;3605.927881442383;3614.710823134143;1046.8063408269495;1081.6160263106563;1084.810158222308;1091.879893211746;1099.5162128663442;10597.73505662357;10898.128149748001;10990.285631433931;10997.61508347204;11199.664010079792;3713.885834249714;3723.9627603724157;4147.81334839933;4386.8903277417685;4448.621867141264;7335.523190992675;8415.495070295801;8712;8748.606312715943;8772.736817895473;4293.677974151951;5153.072446959583;5160.7419629018395;5162.432132465426;5175.275461435402;4148.79256037197;4290.957090429056;4492.483364413069;4587.738371947741;4808.903821923612;3705.370087085202;3713.6843368313457;3766.2844059629133;3799.6200379962333;3805.543334799842;1151.9827202591969;1164.249059356727;1166.650004998497;1169.8947094761343;1171.6953592066125;776.5767656627039;850.2772643253186;878.2096113497903;887.8357503861806;908.4413085952224;5610.410906854803;5635.380108188096;5810.5061069809535;5880.707083828829;5913.379095195029;924.9630014799467;925.2135684668112;929.4376901974343;929.4469790474657;931.5202670624634;3604.5314109166166;3767.4913886625504;3790.241951609634;3874.8643797467516;3920;9877.851832222523;10203.38779673222;10207.948960255151;10219.591216351262;10229.28395012342;9591.520423978773;10098.394096354243;10111.7472063199;10113.898861011296;10196.796064078677;7809.297163255334;8016.7194148204535;8017.198280171936;8045.195480452025;8106.310963568045;5165.018646457161;5597.608167428241;5713.114467257582;5761.452661997104;5865.589408741347;6617;9321.813563728823;9476.910155332225;9483.620655173716;9503;9133.40632858862;9433.386829856037;9453.480058596842;9544.761380965532;9704.417734935927;6646.534742567974;6867.2102708189195;7002.929970700432;7183.5330703504105;7338.119425668954;7837.294643482114;8062.516249025077;8066.717664881701;8122.634481448467;8124.431289809657;6067.969660151671;6207.937920620917;7160.713571457083;7257.165425976081;7404.925950740424;7082.5396349237135;7127.82180445493;7162.997180394645;7210.9278907210255;7225.421966242793;5793.246877905845;6726.966365168143;6734.764283250062;6804.795856124324;6833.726650933907;4867.123917694707;4895.632827537877;4913.754312284443;4951.950480495149;4959.9008019838675;3920.333543297589;4321.58944900234;4817.229243321192;4857.149998750134;5011.398632164163 02:53:35 INFO - PROCESS | 1641 | |4;prototype.html;302.5809254182956;305.60271646859087;311.14435302916974;311.9454095533284;316.8415792103948;5301;5319.616460247699;5419.590906364349;5522.502974732273;5563.860903477415;4217.683673724475;4585.88535286618;4625.49119596845;4732.645051621125;5057.710283877615;4129.834806607732;4146.688998325122;4158.397032430295;4181.780029377378;4195.328747400416;4093.8362465501345;4191.76342978822;4193.685473589478;4201.747895126302;4226.63308547213;3398.3882901077795;4079.8368065277355;4123.567025462328;4142.544320124799;4147.979260103695;3509.824508774551;3694.2057457646465;4094.549599544048;4116.403121547389;4137.2552940470705;3295.340931813647;3354.4129777288877;3588.2105936693883;3627.891163265106;3638.745287829853;5118.385793704742;5271.762770675329;5284.418713941502;5307.991481618519;5413.404525502192;4734.573888350031;4734.692245004098;4741.502142275081;4750.71495710255;4806.75966201692;5058.747062646853;5492.725363731797;5738.446391355848;5759.424057594249;5805.722740996974;3414.7438942079443;3514.9648503514895;3893.435451859493;3948.0457173698915;3983.223271462066;4635.860924172246;4745.620350371962;6047.909281360783;6058.96970515149;6096.079734883542;3919.568847426781;4035.1929614077303;4050.7569545827346;4056.7160298778804;4061.5126184858004;3245.659205783406;3935.685145188378;4048.291548978917;4106.7125301228625;4123.773192474443;4139.379093135994;4185.330347144442;4343.001109744777;4711.74085425298;4762.928556071662;5693.943060569424;5753.482186603226;5796.82609521715;5798.739056742456;5806.2451881255165;1259.0368368198153;1282.0064450051284;1303.3483258370813;1311.7179806341492;1331.5539294336313;747.2602123897302;830.4933990265932;911.6307895302413;915.6566287642135;921.3780698028937;4606.516315786794;4715.646326525524;5058.622447449693;5163.277141200235;5184;4610.561996610317;4662.860114196579;5409.161579955114;5705.657660540381;5705.771769129188;4515.503294637587;4788.7014233168275;4850.932794785142;4855.203574677392;5165.405978312467;2658.580691570661;2671.3188137024936;2757.3244555084134;2990.177701132206;2995.8352290624225;5427.375851777097;5852.887951289242;5858.502027327725;5896.705164741746;5898.026825573732;5607.355154157324;5702.806428400109;5751.504608801742;5804.970975145097;5906.021482803223;6113.449789518964;6221.751129954841;6259.374062593704;6270.843228919313;6271.843203919939;4579.16833266696;5497.560195184456;5756.697321071438;5825.242718446575;6090.299615544269;4387.6489880810095;4663.743494107721;5912.497437717842;5930.703464826655;5968.552358573038;4897.8285759998225;6134.006447904359;6221.253449586078;6226.844328891814;6236.314005459305;3448.2413968875553;4064.3090674585983;4084.9183016340103;4112.835486580503;4169.4162817206225;5193.013327467769;5736.021072729902;5886.970565147147;5928.436798504135;5952.553558483218;5476.644018138808;5576.498115169654;5822.970885145547;5830.679312637845;5856.355800861987;5820.679862607428;5825.854353641193;5829.067349224104;5830.5044071254415;5832.358440571449;5521.503064724194;5625.737072497859;5677.700531284836;5691.556608251948;5710.886971820453;5315.973420132875;5581.469760372758;5829.970850145722;5880.088586269135;5886.440788125121;5376.677399356051;5690.402507736793;5708.942910570841;5738.48353648157;5760.617451811619 02:53:35 INFO - PROCESS | 1641 | |5;yui.html;643.2249139786558;703.1175874277781;716.9318914703101;753.5554023126355;794.9085855126658;13752.862471375283;14307.284635768196;14483.782743258846;14488.927555362208;14501.564953051398;11477.483513241903;11523.920745828467;13072.281024543647;13194.802077968838;14864.10815351077;642.62406492202;667.1227336053074;815.7226542975387;837.539353355655;853.4793775796759;807.5598798654747;837.8031162676766;838.5932822581043;842.1241908415271;843.7553109598209;890.1810334492251;892.1970226795871;892.5492626223748;893.8167675626481;896.7668406214399;881.0968757024037;885.3625389719424;887.201518633232;888.2627419242014;889.5507768576828;648.8929326661142;661.1306132435832;662.6786008785783;663.4195079305607;663.6847497438678;13641.658958526017;13800.309984500735;14044.85955140456;14046.719065618732;14390.424383024667;13721.45114195431;13746.381412836447;13955.092918960236;14159.504417345344;14190;10542.051215390651;10608.62869799561;10637.095846853026;10961.342319460859;10999.120070394429;3565.8217089145696;3635.1275693833554;3652.3425783358985;3662.487251784752;3773.151041015777;84299;84339.5783021081;85209.14790852074;86326.56836715776;87348.99999999936;10517;10697.358158510515;10764.515596798163;10825.621103261348;10855.240133190759;21178.78821211799;21271.0428030739;21300.680489792667;21596.352109436742;21640.242591509537;7597.506162099557;7600.695972161052;7617.00978872743;7668.693252269847;7691.000169977867;3927.0771368728324;4215.178040282177;4217.662586993033;4354.433923589976;4397.516273209944;3077.923051923675;3452.188735647121;3463.9653603463644;3487.302539492112;3489.267253876714;534.4495169974932;592.1916583863082;614.9944840186328;623.3953065526432;623.4762799248653;480.6347176146084;501.4455188914409;553.5765139668157;670.0652589637428;672.5661948043485;8249.752507424666;8845.911540884508;8881.289496840238;9027.277817774562;9177.632894684271;596.6449962272441;646.2793984707112;657.3229573539262;657.7533424965637;667.7329068372593;4357.956420435755;4452.198604251201;4507.2788353863225;4522.3442600823355;4523.660725445605;97084;103505.48247258716;110659.34010989842;120762;123960.38019809843;94372.52813735888;97107.02892971122;100250.4987475058;100960;101516;77491;77880.22119778843;81952;84747.5762621183;86246.56876715702;7896.921030789848;8669.956650216709;8817.294616430798;9549.379290346105;9781.75545611337;52682.73658631682;53378;54313.45686543084;56050.43949560615;58507;54889.72555137199;69428.6528567354;71683.28316716765;74823.62588187025;79340.60329698314;10228;12102.51589936428;12202.267863928193;12224.633261002184;12251.142420030512;13361.53234636783;13620.114692544952;13853.79219311691;13891.930540347234;13949.860501394856;10428.791424171626;12497.437615307515;12513.93743031279;12603.243805371707;12967.897728693168;12550.058745593935;12902.741945161231;13144.356955380577;13257;13707;12745.872541274839;12903.967682585559;13147.408366623333;13229.867701322864;13447.462101516221;10154;10762.569497220024;11151.386673733023;11388.772224555296;11696.649100526998;9888.307818452638;11264.94367528157;11327.660170194908;11358.432078395881;11406.372649504357 02:53:35 INFO - PROCESS | 1641 | __end_tp_report 02:53:35 INFO - PROCESS | 1641 | __start_cc_report 02:53:35 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,363 02:53:35 INFO - PROCESS | 1641 | __end_cc_report 02:53:35 INFO - PROCESS | 1641 | __startTimestamp1484650415846__endTimestamp 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | ------- Summary: start ------- 02:53:35 INFO - PROCESS | 1641 | Number of tests: 6 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5678.52 Median:5899.41 stddev:649.24 (11.0%) stddev-sans-first:617.65 02:53:35 INFO - PROCESS | 1641 | Values: 3051.2 3372.3 3377.4 3383.5 3411.6 5620.0 5645.3 5710.1 5719.0 5739.4 4632.4 5702.9 5704.9 5735.5 5756.7 5153.3 5190.1 5196.2 5253.2 5254.2 4308.9 5216.3 5268.4 5269.4 5270.0 5129.8 5133.2 5226.3 5259.4 5273.1 5139.8 5211.4 5226.5 5226.8 5241.8 5079.1 5123.5 5144.4 5158.1 5165.0 5703.8 5753.7 5804.7 5824.9 5846.7 6044.5 6107.8 6113.1 6123.9 6243.8 6167.0 6195.5 6204.9 6221.7 6240.1 4911.4 5816.5 5819.9 5823.2 5880.1 5960.8 6150.0 6151.3 6180.8 6220.6 6040.2 6114.0 6117.3 6124.4 6128.4 5158.8 6162.1 6198.8 6244.2 6259.5 6053.8 6106.8 6120.7 6138.1 6162.5 5134.3 5135.3 6163.4 6204.6 6232.0 4850.9 4893.6 4895.9 4911.6 4950.7 4354.8 4383.4 4409.4 4410.7 4434.2 5595.8 5605.6 5704.8 5720.1 5790.0 6262.9 6281.1 6284.3 6303.5 6308.9 5592.1 5610.7 5663.8 5717.9 5730.8 5379.3 5391.3 5399.8 5425.5 5437.9 6278.4 6289.2 6306.9 6307.2 6308.7 6068.8 6117.2 6142.7 6277.8 6292.4 6210.5 6223.2 6270.0 6281.7 6299.5 6158.3 6170.7 6172.4 6180.1 6190.3 6134.1 6171.8 6233.1 6237.8 6260.7 5905.9 5991.0 6026.4 6079.5 6137.2 5978.4 6073.1 6077.7 6094.6 6118.1 5087.3 5777.9 5870.0 5910.9 5913.2 5897.9 5922.3 5949.2 6019.8 6028.8 5899.4 5900.4 5928.3 5938.9 5955.3 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:72200.82 Median:40196.30 stddev:159890.83 (397.8%) stddev-sans-first:160248.65 02:53:35 INFO - PROCESS | 1641 | Values: 466.1 474.8 477.6 480.4 507.1 33886.0 40791.6 41176.0 43195.8 43303.1 41151.4 41224.0 41497.0 41605.0 41616.0 9377.0 9554.0 9569.4 9585.5 9591.4 9544.5 9618.3 9630.9 9634.4 9641.0 9583.7 9613.4 9626.6 9638.4 9647.6 9556.6 9578.0 9619.3 9620.7 9630.5 9375.2 9430.6 9433.0 9439.1 9457.6 39704.2 40133.0 40176.0 40216.6 40238.6 3201.8 3478.7 3664.7 3679.4 3936.2 30287.4 30429.0 30447.8 30717.4 31003.7 3104.3 3166.6 3170.0 3228.7 3251.3 505759.0 506570.0 508868.0 511939.0 525449.0 60524.1 60638.0 60714.0 60717.0 60836.8 60516.8 61721.7 62371.7 62389.4 62490.4 16128.9 16251.8 16286.0 16334.4 16338.8 12544.5 12605.8 12671.7 12681.0 12698.2 14974.6 15489.8 15931.6 16613.7 16723.8 3203.4 5951.3 6032.8 6841.1 7000.9 880.2 962.6 1032.2 1095.7 1104.0 30485.8 30712.5 30887.9 31228.4 31250.5 989.8 1028.2 1035.6 1087.8 1092.9 15852.3 15873.5 15891.2 15939.8 16108.8 660334.0 660931.0 665252.0 667670.0 668787.0 58555.0 58921.5 58957.7 59017.7 59209.7 1341.1 1365.7 1371.3 1376.5 1377.3 27131.5 29594.6 30125.5 30493.5 30541.7 41424.4 51665.5 52193.5 52203.5 52335.0 600201.0 604782.0 607500.0 608887.0 609758.0 26859.9 26921.3 27130.7 27189.5 27273.7 45366.3 46811.8 47056.6 48019.5 48262.8 38740.8 38997.8 39085.2 40000.4 40693.8 33994.0 36889.3 37896.0 38224.0 39158.4 35840.8 35845.1 38469.2 38600.6 38967.2 31243.7 33575.8 34221.8 34753.0 34812.7 23180.3 24292.5 24401.6 26262.9 26371.0 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34826.30 Median:12671.37 stddev:99256.11 (783.3%) stddev-sans-first:99500.82 02:53:35 INFO - PROCESS | 1641 | Values: 366.5 371.6 376.2 384.5 400.1 18779.6 20031.3 20142.0 20474.8 20719.6 15928.9 19512.2 19680.8 19802.4 20270.3 4965.1 5245.4 5494.9 5729.2 5745.5 5523.9 5750.5 5755.4 5755.7 5783.3 5557.2 5562.2 5680.2 5717.7 5722.7 5603.9 5608.9 5632.5 5694.6 5701.8 4769.2 4906.8 4967.3 4982.1 5015.9 23142.8 23817.8 24342.0 24912.5 24976.3 2172.0 2185.2 2196.2 2199.3 2318.0 9525.0 9929.6 9951.0 10239.8 10263.9 1818.4 1823.9 1837.1 1854.9 1866.7 123514.4 124016.4 124363.8 127104.0 128602.0 9343.6 9897.7 10055.6 10160.9 11626.7 12380.8 12451.6 12495.3 12515.2 12529.3 7949.6 8048.3 8098.7 8150.7 8176.8 8438.2 8469.4 8474.9 8607.3 8644.7 3818.6 3882.9 3883.2 3885.6 3941.1 1898.9 1941.6 1944.1 1953.6 1958.7 825.7 848.5 879.3 929.7 952.0 17406.5 18405.8 20122.6 20784.2 20901.3 780.4 911.1 911.8 913.0 929.6 10349.1 10928.3 10959.7 10961.9 10972.8 504533.0 604109.0 605953.0 618896.0 623550.0 108044.5 118424.0 121671.8 129244.4 139143.6 916.6 931.7 957.7 964.8 1001.3 18681.1 18782.9 19391.9 19402.8 19448.4 45318.5 49472.0 52683.7 58642.8 59277.0 76397.1 82463.0 83769.6 86962.0 88975.1 7932.4 8093.7 8279.5 8331.6 8517.5 12416.6 12747.9 12802.1 13021.3 13229.3 10992.8 11054.4 11103.9 11282.4 11310.6 11020.9 11153.9 11201.8 11235.0 11467.7 11174.2 11353.8 11402.0 11423.8 11835.0 8028.6 8127.0 8227.6 8421.0 8484.0 10258.9 11038.5 11355.4 11418.8 11597.7 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5377.25 Median:5113.52 stddev:2986.56 (58.4%) stddev-sans-first:2978.69 02:53:35 INFO - PROCESS | 1641 | Values: 1231.8 1348.3 1401.5 1418.7 1425.1 7536.2 7762.6 8103.5 8594.1 8606.8 8017.4 8328.6 8356.5 8396.2 8483.2 2311.0 2345.4 2347.7 2353.8 2356.1 1686.9 2319.8 2352.3 2357.5 2362.9 1882.5 2293.8 2329.2 2330.3 2344.1 2105.8 2114.7 2129.0 2135.5 2136.0 2093.7 2226.1 2322.0 2346.4 2353.9 8361.0 8395.5 8461.5 8462.9 8463.4 5070.8 5074.0 5212.8 5214.4 5241.8 3364.3 3488.7 3605.1 3605.9 3614.7 1046.8 1081.6 1084.8 1091.9 1099.5 10597.7 10898.1 10990.3 10997.6 11199.7 3713.9 3724.0 4147.8 4386.9 4448.6 7335.5 8415.5 8712.0 8748.6 8772.7 4293.7 5153.1 5160.7 5162.4 5175.3 4148.8 4291.0 4492.5 4587.7 4808.9 3705.4 3713.7 3766.3 3799.6 3805.5 1152.0 1164.2 1166.7 1169.9 1171.7 776.6 850.3 878.2 887.8 908.4 5610.4 5635.4 5810.5 5880.7 5913.4 925.0 925.2 929.4 929.4 931.5 3604.5 3767.5 3790.2 3874.9 3920.0 9877.9 10203.4 10207.9 10219.6 10229.3 9591.5 10098.4 10111.7 10113.9 10196.8 7809.3 8016.7 8017.2 8045.2 8106.3 5165.0 5597.6 5713.1 5761.5 5865.6 6617.0 9321.8 9476.9 9483.6 9503.0 9133.4 9433.4 9453.5 9544.8 9704.4 6646.5 6867.2 7002.9 7183.5 7338.1 7837.3 8062.5 8066.7 8122.6 8124.4 6068.0 6207.9 7160.7 7257.2 7404.9 7082.5 7127.8 7163.0 7210.9 7225.4 5793.2 6727.0 6734.8 6804.8 6833.7 4867.1 4895.6 4913.8 4952.0 4959.9 3920.3 4321.6 4817.2 4857.1 5011.4 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4610.16 Median:5088.57 stddev:1443.69 (28.4%) stddev-sans-first:1411.07 02:53:35 INFO - PROCESS | 1641 | Values: 302.6 305.6 311.1 311.9 316.8 5301.0 5319.6 5419.6 5522.5 5563.9 4217.7 4585.9 4625.5 4732.6 5057.7 4129.8 4146.7 4158.4 4181.8 4195.3 4093.8 4191.8 4193.7 4201.7 4226.6 3398.4 4079.8 4123.6 4142.5 4148.0 3509.8 3694.2 4094.5 4116.4 4137.3 3295.3 3354.4 3588.2 3627.9 3638.7 5118.4 5271.8 5284.4 5308.0 5413.4 4734.6 4734.7 4741.5 4750.7 4806.8 5058.7 5492.7 5738.4 5759.4 5805.7 3414.7 3515.0 3893.4 3948.0 3983.2 4635.9 4745.6 6047.9 6059.0 6096.1 3919.6 4035.2 4050.8 4056.7 4061.5 3245.7 3935.7 4048.3 4106.7 4123.8 4139.4 4185.3 4343.0 4711.7 4762.9 5693.9 5753.5 5796.8 5798.7 5806.2 1259.0 1282.0 1303.3 1311.7 1331.6 747.3 830.5 911.6 915.7 921.4 4606.5 4715.6 5058.6 5163.3 5184.0 4610.6 4662.9 5409.2 5705.7 5705.8 4515.5 4788.7 4850.9 4855.2 5165.4 2658.6 2671.3 2757.3 2990.2 2995.8 5427.4 5852.9 5858.5 5896.7 5898.0 5607.4 5702.8 5751.5 5805.0 5906.0 6113.4 6221.8 6259.4 6270.8 6271.8 4579.2 5497.6 5756.7 5825.2 6090.3 4387.6 4663.7 5912.5 5930.7 5968.6 4897.8 6134.0 6221.3 6226.8 6236.3 3448.2 4064.3 4084.9 4112.8 4169.4 5193.0 5736.0 5887.0 5928.4 5952.6 5476.6 5576.5 5823.0 5830.7 5856.4 5820.7 5825.9 5829.1 5830.5 5832.4 5521.5 5625.7 5677.7 5691.6 5710.9 5316.0 5581.5 5830.0 5880.1 5886.4 5376.7 5690.4 5708.9 5738.5 5760.6 02:53:35 INFO - PROCESS | 1641 | 02:53:35 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20387.22 Median:4377.74 stddev:29933.03 (683.8%) stddev-sans-first:29980.29 02:53:35 INFO - PROCESS | 1641 | Values: 643.2 703.1 716.9 753.6 794.9 13752.9 14307.3 14483.8 14488.9 14501.6 11477.5 11523.9 13072.3 13194.8 14864.1 642.6 667.1 815.7 837.5 853.5 807.6 837.8 838.6 842.1 843.8 890.2 892.2 892.5 893.8 896.8 881.1 885.4 887.2 888.3 889.6 648.9 661.1 662.7 663.4 663.7 13641.7 13800.3 14044.9 14046.7 14390.4 13721.5 13746.4 13955.1 14159.5 14190.0 10542.1 10608.6 10637.1 10961.3 10999.1 3565.8 3635.1 3652.3 3662.5 3773.2 84299.0 84339.6 85209.1 86326.6 87349.0 10517.0 10697.4 10764.5 10825.6 10855.2 21178.8 21271.0 21300.7 21596.4 21640.2 7597.5 7600.7 7617.0 7668.7 7691.0 3927.1 4215.2 4217.7 4354.4 4397.5 3077.9 3452.2 3464.0 3487.3 3489.3 534.4 592.2 615.0 623.4 623.5 480.6 501.4 553.6 670.1 672.6 8249.8 8845.9 8881.3 9027.3 9177.6 596.6 646.3 657.3 657.8 667.7 4358.0 4452.2 4507.3 4522.3 4523.7 97084.0 103505.5 110659.3 120762.0 123960.4 94372.5 97107.0 100250.5 100960.0 101516.0 77491.0 77880.2 81952.0 84747.6 86246.6 7896.9 8670.0 8817.3 9549.4 9781.8 52682.7 53378.0 54313.5 56050.4 58507.0 54889.7 69428.7 71683.3 74823.6 79340.6 10228.0 12102.5 12202.3 12224.6 12251.1 13361.5 13620.1 13853.8 13891.9 13949.9 10428.8 12497.4 12513.9 12603.2 12967.9 12550.1 12902.7 13144.4 13257.0 13707.0 12745.9 12904.0 13147.4 13229.9 13447.5 10154.0 10762.6 11151.4 11388.8 11696.6 9888.3 11264.9 11327.7 11358.4 11406.4 02:53:35 INFO - PROCESS | 1641 | -------- Summary: end -------- 02:53:35 INFO - PROCESS | 1641 | 02:53:36 INFO - TEST-INFO | 1641: exit 0 02:53:36 INFO - TEST-OK | dromaeo_css | took 1116495ms 02:53:36 INFO - TEST-START | kraken 02:53:36 INFO - operating with platform_type : mac_ 02:53:36 INFO - Initialising browser for kraken test... 02:53:36 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpxiuMD_/profile http://localhost:49241/getInfo.html) 02:53:39 INFO - PROCESS | 1649 | 2017-01-17 02:53:39.543 plugin-container[1651:10257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 02:53:39 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:39 INFO - PROCESS | 1649 | 2017-01-17 02:53:39.543 plugin-container[1651:10257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 02:53:39 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:39 INFO - PROCESS | 1649 | 2017-01-17 02:53:39.544 plugin-container[1651:10257] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:53:39 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 02:53:39 INFO - PROCESS | 1649 | colorDepth:24 02:53:39 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 02:53:39 INFO - PROCESS | 1649 | __metrics 02:53:39 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 02:53:40 INFO - TEST-INFO | 1649: exit 0 02:53:40 INFO - Browser initialized. 02:53:40 INFO - Running cycle 1/1 for kraken test... 02:53:40 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpxiuMD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:43 INFO - PROCESS | 1652 | 2017-01-17 02:53:43.084 plugin-container[1653:10380] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 02:53:43 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:43 INFO - PROCESS | 1652 | 2017-01-17 02:53:43.084 plugin-container[1653:10380] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 02:53:43 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:43 INFO - PROCESS | 1652 | 2017-01-17 02:53:43.084 plugin-container[1653:10380] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:53:52 INFO - PROCESS | 1652 | RSS: Main: 228950016 02:53:52 INFO - PROCESS | 1652 | 02:53:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:56 INFO - PROCESS | 1652 | RSS: Main: 241319936 02:53:56 INFO - PROCESS | 1652 | 02:53:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:54:00 INFO - PROCESS | 1652 | RSS: Main: 249364480 02:54:00 INFO - PROCESS | 1652 | 02:54:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:54:04 INFO - PROCESS | 1652 | RSS: Main: 251158528 02:54:04 INFO - PROCESS | 1652 | 02:54:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:54:06 INFO - PROCESS | 1652 | RSS: Main: 252747776 02:54:06 INFO - PROCESS | 1652 | 02:54:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:54:09 INFO - PROCESS | 1652 | RSS: Main: 253038592 02:54:09 INFO - PROCESS | 1652 | 02:54:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:54:13 INFO - PROCESS | 1652 | RSS: Main: 258260992 02:54:13 INFO - PROCESS | 1652 | 02:54:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:17 INFO - PROCESS | 1652 | RSS: Main: 258043904 02:54:17 INFO - PROCESS | 1652 | 02:54:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:54:20 INFO - PROCESS | 1652 | RSS: Main: 257830912 02:54:20 INFO - PROCESS | 1652 | 02:54:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:54:23 INFO - PROCESS | 1652 | RSS: Main: 256901120 02:54:23 INFO - PROCESS | 1652 | 02:54:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:25 INFO - PROCESS | 1652 | RSS: Main: 256929792 02:54:25 INFO - PROCESS | 1652 | 02:54:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:54:28 INFO - PROCESS | 1652 | RSS: Main: 257036288 02:54:28 INFO - PROCESS | 1652 | 02:54:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:54:32 INFO - PROCESS | 1652 | RSS: Main: 257314816 02:54:32 INFO - PROCESS | 1652 | 02:54:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:54:35 INFO - PROCESS | 1652 | RSS: Main: 257155072 02:54:35 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:54:37 INFO - PROCESS | 1652 | RSS: Main: 258875392 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | __start_tp_report 02:54:37 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 02:54:37 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 02:54:37 INFO - PROCESS | 1652 | |i|pagename|runs| 02:54:37 INFO - PROCESS | 1652 | |0;ai-astar;107;135;175;152;118;121;117;118;117;119 02:54:37 INFO - PROCESS | 1652 | |1;audio-beat-detection;163;141;106;179;147;147;113;115;191;143 02:54:37 INFO - PROCESS | 1652 | |2;audio-dft;200;204;199;231;230;282;250;196;198;197 02:54:37 INFO - PROCESS | 1652 | |3;audio-fft;78;67;52;81;87;86;87;51;96;76 02:54:37 INFO - PROCESS | 1652 | |4;audio-oscillator;103;66;97;107;70;100;121;57;88;111 02:54:37 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;102;130;88;89;89;85;78;132;137;87 02:54:37 INFO - PROCESS | 1652 | |6;imaging-darkroom;147;94;95;144;103;101;153;94;92;153 02:54:37 INFO - PROCESS | 1652 | |7;imaging-desaturate;88;77;136;134;88;126;86;144;135;118 02:54:37 INFO - PROCESS | 1652 | |8;json-parse-financial;58;57;57;61;60;60;59;61;60;60 02:54:37 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;72;78;81;85;77;71;72;75;94;62 02:54:37 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;84;85;86;83;85;106;105;107;91;88 02:54:37 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;139;142;139;141;144;153;162;166;196;154 02:54:37 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;170;170;166;176;233;175;166;168;164;169 02:54:37 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;66;75;70;67;71;69;67;72;86;77 02:54:37 INFO - PROCESS | 1652 | __end_tp_report 02:54:37 INFO - PROCESS | 1652 | __start_cc_report 02:54:37 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,956 02:54:37 INFO - PROCESS | 1652 | __end_cc_report 02:54:37 INFO - PROCESS | 1652 | __startTimestamp1484650477905__endTimestamp 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | ------- Summary: start ------- 02:54:37 INFO - PROCESS | 1652 | Number of tests: 14 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:127.90 Median:120.00 stddev:20.67 (17.2%) stddev-sans-first:20.50 02:54:37 INFO - PROCESS | 1652 | Values: 107.0 135.0 175.0 152.0 118.0 121.0 117.0 118.0 117.0 119.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:147.00 stddev:28.02 (19.1%) stddev-sans-first:28.91 02:54:37 INFO - PROCESS | 1652 | Values: 163.0 141.0 106.0 179.0 147.0 147.0 113.0 115.0 191.0 143.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:218.70 Median:217.00 stddev:29.12 (13.4%) stddev-sans-first:30.09 02:54:37 INFO - PROCESS | 1652 | Values: 200.0 204.0 199.0 231.0 230.0 282.0 250.0 196.0 198.0 197.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:76.10 Median:83.50 stddev:15.10 (18.1%) stddev-sans-first:16.00 02:54:37 INFO - PROCESS | 1652 | Values: 78.0 67.0 52.0 81.0 87.0 86.0 87.0 51.0 96.0 76.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:61.50 stddev:21.18 (34.4%) stddev-sans-first:22.09 02:54:37 INFO - PROCESS | 1652 | Values: 103.0 66.0 97.0 107.0 70.0 100.0 121.0 57.0 88.0 111.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:101.70 Median:86.00 stddev:22.44 (26.1%) stddev-sans-first:23.80 02:54:37 INFO - PROCESS | 1652 | Values: 102.0 130.0 88.0 89.0 89.0 85.0 78.0 132.0 137.0 87.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:117.60 Median:122.50 stddev:27.56 (22.5%) stddev-sans-first:27.10 02:54:37 INFO - PROCESS | 1652 | Values: 147.0 94.0 95.0 144.0 103.0 101.0 153.0 94.0 92.0 153.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:113.20 Median:110.50 stddev:25.57 (23.1%) stddev-sans-first:25.44 02:54:37 INFO - PROCESS | 1652 | Values: 88.0 77.0 136.0 134.0 88.0 126.0 86.0 144.0 135.0 118.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:60.00 stddev:1.49 (2.5%) stddev-sans-first:1.51 02:54:37 INFO - PROCESS | 1652 | Values: 58.0 57.0 57.0 61.0 60.0 60.0 59.0 61.0 60.0 60.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:77.50 stddev:8.72 (11.2%) stddev-sans-first:9.08 02:54:37 INFO - PROCESS | 1652 | Values: 72.0 78.0 81.0 85.0 77.0 71.0 72.0 75.0 94.0 62.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:85.00 stddev:9.92 (11.7%) stddev-sans-first:10.09 02:54:37 INFO - PROCESS | 1652 | Values: 84.0 85.0 86.0 83.0 85.0 106.0 105.0 107.0 91.0 88.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:153.50 stddev:17.75 (11.6%) stddev-sans-first:18.02 02:54:37 INFO - PROCESS | 1652 | Values: 139.0 142.0 139.0 141.0 144.0 153.0 162.0 166.0 196.0 154.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:170.00 stddev:20.49 (12.1%) stddev-sans-first:21.63 02:54:37 INFO - PROCESS | 1652 | Values: 170.0 170.0 166.0 176.0 233.0 175.0 166.0 168.0 164.0 169.0 02:54:37 INFO - PROCESS | 1652 | 02:54:37 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.50 stddev:6.06 (8.5%) stddev-sans-first:6.02 02:54:37 INFO - PROCESS | 1652 | Values: 66.0 75.0 70.0 67.0 71.0 69.0 67.0 72.0 86.0 77.0 02:54:37 INFO - PROCESS | 1652 | -------- Summary: end -------- 02:54:37 INFO - PROCESS | 1652 | 02:54:38 INFO - TEST-INFO | 1652: exit 0 02:54:38 INFO - TEST-OK | kraken | took 62368ms 02:54:38 INFO - SUITE-END | took 1178s 02:54:39 INFO - Completed test suite (00:19:38) 02:54:39 INFO - javascript benchmark 02:54:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7164.858063503716, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3051.191434269919, 3372.258103217291, 3377.3751855906644, 3383.526306317116, 3411.641777613351, 5619.971900140498, 5645.266115404992, 5710.086386178213, 5718.970585294651, 5739.368669446368, 4632.4441067072, 5702.857428564288, 5704.857378565527, 5735.483806457418, 5756.654600723959, 5153.278541004272, 5190.11767999441, 5196.2465442511, 5253.238280449333, 5254.185601231796, 4308.870733877973, 5216.2958000669805, 5268.367795864501, 5269.394019687747, 5270.0, 5129.769160387773, 5133.1786914093755, 5226.320578324812, 5259.421463639016, 5273.129933560977, 5139.8458046258675, 5211.42674305826, 5226.477352264781, 5226.843194704146, 5241.816536421207, 5079.085764562377, 5123.513266239701, 5144.356955380577, 5158.148905430599, 5165.044466773659, 5703.800366987177, 5753.683547404891, 5804.738786754606, 5824.854378640525, 5846.736896839652, 6044.486218671418, 6107.765388666932, 6113.052476866048, 6123.908141377883, 6243.843903902439, 6167.0, 6195.473384762301, 6204.937950620481, 6221.688915554204, 6240.063990401476, 4911.410630724265, 5816.47651711348, 5819.887186788992, 5823.184754134425, 5880.088586269135, 5960.791372301948, 6149.96925015372, 6151.292601350812, 6180.845478862974, 6220.564560480813, 6040.184575082396, 6113.99119145345, 6117.327094019654, 6124.418180272867, 6128.417800308964, 5158.845234642967, 6162.075688646649, 6198.783042593487, 6244.219472565929, 6259.530535209878, 6053.848653783691, 6106.755729770848, 6120.693965301717, 6138.07928810682, 6162.506999440034, 5134.255532947702, 5135.306733590917, 6163.445289923929, 6204.565680402418, 6232.0, 4850.854474365775, 4893.584045356113, 4895.926561101586, 4911.631627627942, 4950.6782059166035, 4354.760488173181, 4383.3863259143745, 4409.426774519292, 4410.691251612357, 4434.179676759745, 5595.832125036255, 5605.5515558755205, 5704.771809127671, 5720.11338242573, 5790.015697331463, 6262.937370626236, 6281.089242059876, 6284.340144284784, 6303.495720342362, 6308.936910630927, 5592.077307244259, 5610.691411972299, 5663.801766938137, 5717.914231286534, 5730.828075157752, 5379.327584051994, 5391.29913111293, 5399.83800485986, 5425.511703946664, 5437.891242175135, 6278.372162783777, 6289.182406287154, 6306.936930630818, 6307.211598550181, 6308.747650094128, 6068.848278792889, 6117.218487018656, 6142.7136481981925, 6277.780277690259, 6292.433680968735, 6210.472109870531, 6223.222097237845, 6269.96865015672, 6281.7173227203975, 6299.496040316672, 6158.261008678987, 6170.660613666291, 6172.351903050295, 6180.134781130735, 6190.319064902767, 6134.14122022926, 6171.753129874754, 6233.096201050913, 6237.844053898689, 6260.7495700171485, 5905.940940590711, 5991.0, 6026.427489388501, 6079.452849243589, 6137.171481849893, 5978.4021597839865, 6073.119397687399, 6077.665728384981, 6094.603850749687, 6118.051701986199, 5087.262346959744, 5777.884442311214, 5870.0, 5910.881782364415, 5913.231279933581, 5897.882042359214, 5922.289325280994, 5949.2266005419015, 6019.819405417845, 6028.758849645965, 5899.410058994066, 5900.43945825146, 5928.318243402064, 5938.881222375615, 5955.315138759098], "value": 5637.9877336820255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.1492775684376, 474.77685487820713, 477.58927322502643, 480.3611197107846, 507.08977385592857, 33886.0, 40791.59208407919, 41175.97060073496, 43195.784021079926, 43303.13393732123, 41151.38272925909, 41224.0, 41497.0, 41605.0, 41616.0, 9376.999999999984, 9554.044595540425, 9569.425834449956, 9585.472798996052, 9591.424514529115, 9544.52277386128, 9618.27862910281, 9630.855537166948, 9634.373765705242, 9641.035896410338, 9583.66457173999, 9613.423194608346, 9626.566804493814, 9638.37350572214, 9647.565859536338, 9556.569954352037, 9578.042195780436, 9619.326647134703, 9620.663276785279, 9630.518474076269, 9375.15623593873, 9430.622775088988, 9432.952835235848, 9439.056094390575, 9457.574409151604, 39704.20591588181, 40133.0, 40176.0, 40216.59783402158, 40238.597614023776, 3201.823899685516, 3478.6521347865264, 3664.743467957244, 3679.3929001714687, 3936.1734035852505, 30287.394252115053, 30429.0, 30447.847760761277, 30717.385652287052, 31003.689963100533, 3104.2704964333366, 3166.5566820645126, 3169.9841500792577, 3228.725558327545, 3251.252211991255, 505759.0, 506570.0, 508868.0, 511939.0, 525449.0, 60524.092138617954, 60638.0, 60714.0, 60717.0, 60836.783264335354, 60516.789664206466, 61721.69139154276, 62371.688141559, 62389.37610623836, 62490.375096248456, 16128.919355403148, 16251.837481625269, 16286.0, 16334.428295009619, 16338.836611633731, 12544.498220071095, 12605.810912836314, 12671.746565068646, 12681.0, 12698.238105713686, 14974.577415145544, 15489.84510154884, 15931.601709957113, 16613.667726645643, 16723.832761672227, 3203.4073696366245, 5951.345352011275, 6032.849178770566, 6841.110655614738, 7000.859982800315, 880.238593616517, 962.6486332488731, 1032.210359075293, 1095.6548687163677, 1103.9834402483968, 30485.795496971004, 30712.53931191034, 30887.918922838042, 31228.375432491677, 31250.53124203139, 989.7773001074701, 1028.2391030637275, 1035.6168217759478, 1087.782443511285, 1092.9016388525072, 15852.286647100907, 15873.52379428619, 15891.205439728199, 15939.760903586455, 16108.75836862448, 660334.0, 660931.0, 665252.0, 667670.0, 668787.0, 58555.0, 58921.52696182544, 58957.705211474524, 59017.704911475164, 59209.70395147997, 1341.1416693316285, 1365.6722386627139, 1371.2526672963259, 1376.5388594820647, 1377.3388773388829, 27131.457370852866, 29594.55608165836, 30125.548116778704, 30493.54259686062, 30541.694583054774, 41424.37863432111, 51665.48334516607, 52193.478065218864, 52203.47796521986, 52335.0, 600201.0, 604782.0, 607499.9625001847, 608887.0, 609758.0, 26859.865700671373, 26921.326966825985, 27130.72869271282, 27189.456210876066, 27273.72726272712, 45366.31950520679, 46811.76594117007, 47056.58830235098, 48019.51980480151, 48262.75868620775, 38740.80629596834, 38997.83006509809, 39085.2182956345, 40000.3999940007, 40693.79653101716, 33994.0, 36889.26221475609, 37896.0, 38224.0, 39158.41262381124, 35840.82079589585, 35845.1038724034, 38469.23061538809, 38600.613993859704, 38967.2206555873, 31243.687563124986, 33575.824846130265, 34221.82889085539, 34753.0, 34812.65187348094, 23180.304590862303, 24292.54244745321, 24401.63397549074, 26262.868685657213, 26371.0], "value": 19816.04988075009, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4887481962662, 371.5801144706483, 376.2456275168288, 384.4636731759198, 400.105763618313, 18779.62440751184, 20031.298904538307, 20141.992900355, 20474.795252047494, 20719.585608287824, 15928.920355398206, 19512.21951121957, 19680.803191968076, 19802.405927822154, 20270.29053983111, 4965.081459929925, 5245.44922783108, 5494.890102197954, 5729.226554415163, 5745.540356771448, 5523.889522209553, 5750.453706897859, 5755.4244575542525, 5755.68343741094, 5783.306003279612, 5557.249771280886, 5562.193481945115, 5680.204771332017, 5717.714114294289, 5722.713864306789, 5603.859903502404, 5608.887822243552, 5632.464915832989, 5694.601377903569, 5701.828945131652, 4769.213079841857, 4906.803727850882, 4967.304577359173, 4982.078315511642, 5015.924761128586, 23142.76857231423, 23817.809109544454, 24342.02631894722, 24912.501749965082, 24976.250712478653, 2171.9782802171935, 2185.191479152708, 2196.242296407737, 2199.3292045925987, 2317.9652305215436, 9524.95237523808, 9929.602815887356, 9951.004899510064, 10239.795204095877, 10263.948680256552, 1818.399928023749, 1823.9361622343154, 1837.0814592703648, 1854.88870667759, 1866.7479890214784, 123514.38242808818, 124016.37991809983, 124363.75636243612, 127104.0, 128602.0, 9343.579538920765, 9897.703068907944, 10055.597776088875, 10160.898391015995, 11626.651200463999, 12380.752384952251, 12451.626451206479, 12495.25028498293, 12515.186512876633, 12529.31088790107, 7949.64226609804, 8048.275655190944, 8098.676052957816, 8150.7147249845975, 8176.795580110426, 8438.240558349778, 8469.449485783405, 8474.872876906851, 8607.26838218746, 8644.740657780276, 3818.6181381862148, 3882.9223415531533, 3883.203943191639, 3885.55316138642, 3941.1132495188926, 1898.924043038263, 1941.6213838301396, 1944.125143685319, 1953.579980304213, 1958.7257783910263, 825.6830355582836, 848.499385362639, 879.2722300679196, 929.693201243588, 951.9857202141974, 17406.520445762, 18405.81594184068, 20122.597548048958, 20784.1686332545, 20901.268455603982, 780.3601047141403, 911.1207684584408, 911.8313112074287, 912.977175570616, 929.5816882402811, 10349.068583827491, 10928.289661171999, 10959.726006849893, 10961.945190273998, 10972.835407468894, 504533.0, 604109.0, 605953.0, 618896.0, 623550.0, 108044.45977770061, 118424.0, 121671.78328216604, 129244.35377823238, 139143.60856391306, 916.6379280184423, 931.7204838548408, 957.7078990907701, 964.7829238421299, 1001.2940876682068, 18681.06594670234, 18782.906085469484, 19391.90304048527, 19402.8059719401, 19448.4165475036, 45318.54681453143, 49472.01055978932, 52683.73658131685, 58642.82714345604, 59277.0, 76397.0900727464, 82463.0, 83769.58115209384, 86962.0, 88975.11024889669, 7932.405069619917, 8093.716719914774, 8279.461834980708, 8331.583420829056, 8517.531535765593, 12416.627501174979, 12747.872521274669, 12802.103852730219, 13021.283829389475, 13229.272390018257, 10992.835107473235, 11054.392008439292, 11103.944480277547, 11282.43587820622, 11310.60412885545, 11020.889791101987, 11153.851910613756, 11201.775964480828, 11235.0, 11467.713307167387, 11174.161937854531, 11353.772924541297, 11402.0, 11423.771524569629, 11835.0, 8028.6351320274525, 8126.959365203136, 8227.588620568828, 8421.0, 8484.0, 10258.948705256425, 11038.503267352828, 11355.432228388383, 11418.771624567627, 11597.710057248636], "value": 9322.39795517251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.8174552429666, 1348.3056226043586, 1401.5024666243482, 1418.7091646212527, 1425.1449130521682, 7536.171021187665, 7762.611869406535, 8103.513789172646, 8594.054653988056, 8606.827863442735, 8017.358611311096, 8328.583570821465, 8356.456830306026, 8396.244338009577, 8483.151684831513, 2310.953780924385, 2345.4019225097663, 2347.7417484076736, 2353.7646235376496, 2356.1046802215133, 1686.9156542172905, 2319.8376113672048, 2352.329586067971, 2357.54027964547, 2362.870042147681, 1882.4729075858713, 2293.7935585797277, 2329.24299602629, 2330.2659662206433, 2344.0506594829035, 2105.7788932162057, 2114.6616541353387, 2128.9893550532224, 2135.519508110678, 2136.038782547852, 2093.706881036656, 2226.087304205268, 2321.9883900580558, 2346.425125844179, 2353.9176128835406, 8360.996680398392, 8395.496270223744, 8461.53461559614, 8462.915370846275, 8463.365247606454, 5070.847874563769, 5073.974630126862, 5212.765425555859, 5214.426413094557, 5241.8165364212455, 3364.327134573095, 3488.6511348865165, 3605.06268370223, 3605.927881442383, 3614.710823134143, 1046.8063408269495, 1081.6160263106563, 1084.810158222308, 1091.879893211746, 1099.5162128663442, 10597.73505662357, 10898.128149748001, 10990.285631433931, 10997.61508347204, 11199.664010079792, 3713.885834249714, 3723.9627603724157, 4147.81334839933, 4386.8903277417685, 4448.621867141264, 7335.523190992675, 8415.495070295801, 8712.0, 8748.606312715943, 8772.736817895473, 4293.677974151951, 5153.072446959583, 5160.7419629018395, 5162.432132465426, 5175.275461435402, 4148.79256037197, 4290.957090429056, 4492.483364413069, 4587.738371947741, 4808.903821923612, 3705.370087085202, 3713.6843368313457, 3766.2844059629133, 3799.6200379962333, 3805.543334799842, 1151.9827202591969, 1164.249059356727, 1166.650004998497, 1169.8947094761343, 1171.6953592066125, 776.5767656627039, 850.2772643253186, 878.2096113497903, 887.8357503861806, 908.4413085952224, 5610.410906854803, 5635.380108188096, 5810.5061069809535, 5880.707083828829, 5913.379095195029, 924.9630014799467, 925.2135684668112, 929.4376901974343, 929.4469790474657, 931.5202670624634, 3604.5314109166166, 3767.4913886625504, 3790.241951609634, 3874.8643797467516, 3920.0, 9877.851832222523, 10203.38779673222, 10207.948960255151, 10219.591216351262, 10229.28395012342, 9591.520423978773, 10098.394096354243, 10111.7472063199, 10113.898861011296, 10196.796064078677, 7809.297163255334, 8016.7194148204535, 8017.198280171936, 8045.195480452025, 8106.310963568045, 5165.018646457161, 5597.608167428241, 5713.114467257582, 5761.452661997104, 5865.589408741347, 6617.0, 9321.813563728823, 9476.910155332225, 9483.620655173716, 9503.0, 9133.40632858862, 9433.386829856037, 9453.480058596842, 9544.761380965532, 9704.417734935927, 6646.534742567974, 6867.2102708189195, 7002.929970700432, 7183.5330703504105, 7338.119425668954, 7837.294643482114, 8062.516249025077, 8066.717664881701, 8122.634481448467, 8124.431289809657, 6067.969660151671, 6207.937920620917, 7160.713571457083, 7257.165425976081, 7404.925950740424, 7082.5396349237135, 7127.82180445493, 7162.997180394645, 7210.9278907210255, 7225.421966242793, 5793.246877905845, 6726.966365168143, 6734.764283250062, 6804.795856124324, 6833.726650933907, 4867.123917694707, 4895.632827537877, 4913.754312284443, 4951.950480495149, 4959.9008019838675, 3920.333543297589, 4321.58944900234, 4817.229243321192, 4857.149998750134, 5011.398632164163], "value": 4336.032498655535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5809254182956, 305.60271646859087, 311.14435302916974, 311.9454095533284, 316.8415792103948, 5301.0, 5319.616460247699, 5419.590906364349, 5522.502974732273, 5563.860903477415, 4217.683673724475, 4585.88535286618, 4625.49119596845, 4732.645051621125, 5057.710283877615, 4129.834806607732, 4146.688998325122, 4158.397032430295, 4181.780029377378, 4195.328747400416, 4093.8362465501345, 4191.76342978822, 4193.685473589478, 4201.747895126302, 4226.63308547213, 3398.3882901077795, 4079.8368065277355, 4123.567025462328, 4142.544320124799, 4147.979260103695, 3509.824508774551, 3694.2057457646465, 4094.549599544048, 4116.403121547389, 4137.2552940470705, 3295.340931813647, 3354.4129777288877, 3588.2105936693883, 3627.891163265106, 3638.745287829853, 5118.385793704742, 5271.762770675329, 5284.418713941502, 5307.991481618519, 5413.404525502192, 4734.573888350031, 4734.692245004098, 4741.502142275081, 4750.71495710255, 4806.75966201692, 5058.747062646853, 5492.725363731797, 5738.446391355848, 5759.424057594249, 5805.722740996974, 3414.7438942079443, 3514.9648503514895, 3893.435451859493, 3948.0457173698915, 3983.223271462066, 4635.860924172246, 4745.620350371962, 6047.909281360783, 6058.96970515149, 6096.079734883542, 3919.568847426781, 4035.1929614077303, 4050.7569545827346, 4056.7160298778804, 4061.5126184858004, 3245.659205783406, 3935.685145188378, 4048.291548978917, 4106.7125301228625, 4123.773192474443, 4139.379093135994, 4185.330347144442, 4343.001109744777, 4711.74085425298, 4762.928556071662, 5693.943060569424, 5753.482186603226, 5796.82609521715, 5798.739056742456, 5806.2451881255165, 1259.0368368198153, 1282.0064450051284, 1303.3483258370813, 1311.7179806341492, 1331.5539294336313, 747.2602123897302, 830.4933990265932, 911.6307895302413, 915.6566287642135, 921.3780698028937, 4606.516315786794, 4715.646326525524, 5058.622447449693, 5163.277141200235, 5184.0, 4610.561996610317, 4662.860114196579, 5409.161579955114, 5705.657660540381, 5705.771769129188, 4515.503294637587, 4788.7014233168275, 4850.932794785142, 4855.203574677392, 5165.405978312467, 2658.580691570661, 2671.3188137024936, 2757.3244555084134, 2990.177701132206, 2995.8352290624225, 5427.375851777097, 5852.887951289242, 5858.502027327725, 5896.705164741746, 5898.026825573732, 5607.355154157324, 5702.806428400109, 5751.504608801742, 5804.970975145097, 5906.021482803223, 6113.449789518964, 6221.751129954841, 6259.374062593704, 6270.843228919313, 6271.843203919939, 4579.16833266696, 5497.560195184456, 5756.697321071438, 5825.242718446575, 6090.299615544269, 4387.6489880810095, 4663.743494107721, 5912.497437717842, 5930.703464826655, 5968.552358573038, 4897.8285759998225, 6134.006447904359, 6221.253449586078, 6226.844328891814, 6236.314005459305, 3448.2413968875553, 4064.3090674585983, 4084.9183016340103, 4112.835486580503, 4169.4162817206225, 5193.013327467769, 5736.021072729902, 5886.970565147147, 5928.436798504135, 5952.553558483218, 5476.644018138808, 5576.498115169654, 5822.970885145547, 5830.679312637845, 5856.355800861987, 5820.679862607428, 5825.854353641193, 5829.067349224104, 5830.5044071254415, 5832.358440571449, 5521.503064724194, 5625.737072497859, 5677.700531284836, 5691.556608251948, 5710.886971820453, 5315.973420132875, 5581.469760372758, 5829.970850145722, 5880.088586269135, 5886.440788125121, 5376.677399356051, 5690.402507736793, 5708.942910570841, 5738.48353648157, 5760.617451811619], "value": 4146.302269459588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.2249139786558, 703.1175874277781, 716.9318914703101, 753.5554023126355, 794.9085855126658, 13752.862471375283, 14307.284635768196, 14483.782743258846, 14488.927555362208, 14501.564953051398, 11477.483513241903, 11523.920745828467, 13072.281024543647, 13194.802077968838, 14864.10815351077, 642.62406492202, 667.1227336053074, 815.7226542975387, 837.539353355655, 853.4793775796759, 807.5598798654747, 837.8031162676766, 838.5932822581043, 842.1241908415271, 843.7553109598209, 890.1810334492251, 892.1970226795871, 892.5492626223748, 893.8167675626481, 896.7668406214399, 881.0968757024037, 885.3625389719424, 887.201518633232, 888.2627419242014, 889.5507768576828, 648.8929326661142, 661.1306132435832, 662.6786008785783, 663.4195079305607, 663.6847497438678, 13641.658958526017, 13800.309984500735, 14044.85955140456, 14046.719065618732, 14390.424383024667, 13721.45114195431, 13746.381412836447, 13955.092918960236, 14159.504417345344, 14190.0, 10542.051215390651, 10608.62869799561, 10637.095846853026, 10961.342319460859, 10999.120070394429, 3565.8217089145696, 3635.1275693833554, 3652.3425783358985, 3662.487251784752, 3773.151041015777, 84299.0, 84339.5783021081, 85209.14790852074, 86326.56836715776, 87348.99999999936, 10517.0, 10697.358158510515, 10764.515596798163, 10825.621103261348, 10855.240133190759, 21178.78821211799, 21271.0428030739, 21300.680489792667, 21596.352109436742, 21640.242591509537, 7597.506162099557, 7600.695972161052, 7617.00978872743, 7668.693252269847, 7691.000169977867, 3927.0771368728324, 4215.178040282177, 4217.662586993033, 4354.433923589976, 4397.516273209944, 3077.923051923675, 3452.188735647121, 3463.9653603463644, 3487.302539492112, 3489.267253876714, 534.4495169974932, 592.1916583863082, 614.9944840186328, 623.3953065526432, 623.4762799248653, 480.6347176146084, 501.4455188914409, 553.5765139668157, 670.0652589637428, 672.5661948043485, 8249.752507424666, 8845.911540884508, 8881.289496840238, 9027.277817774562, 9177.632894684271, 596.6449962272441, 646.2793984707112, 657.3229573539262, 657.7533424965637, 667.7329068372593, 4357.956420435755, 4452.198604251201, 4507.2788353863225, 4522.3442600823355, 4523.660725445605, 97084.0, 103505.48247258716, 110659.34010989842, 120762.0, 123960.38019809843, 94372.52813735888, 97107.02892971122, 100250.4987475058, 100960.0, 101516.0, 77491.0, 77880.22119778843, 81952.0, 84747.5762621183, 86246.56876715702, 7896.921030789848, 8669.956650216709, 8817.294616430798, 9549.379290346105, 9781.75545611337, 52682.73658631682, 53378.0, 54313.45686543084, 56050.43949560615, 58507.0, 54889.72555137199, 69428.6528567354, 71683.28316716765, 74823.62588187025, 79340.60329698314, 10228.0, 12102.51589936428, 12202.267863928193, 12224.633261002184, 12251.142420030512, 13361.53234636783, 13620.114692544952, 13853.79219311691, 13891.930540347234, 13949.860501394856, 10428.791424171626, 12497.437615307515, 12513.93743031279, 12603.243805371707, 12967.897728693168, 12550.058745593935, 12902.741945161231, 13144.356955380577, 13257.0, 13707.0, 12745.872541274839, 12903.967682585559, 13147.408366623333, 13229.867701322864, 13447.462101516221, 10154.0, 10762.569497220024, 11151.386673733023, 11388.772224555296, 11696.649100526998, 9888.307818452638, 11264.94367528157, 11327.660170194908, 11358.432078395881, 11406.372649504357], "value": 7223.977020914611, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 135.0, 175.0, 152.0, 118.0, 121.0, 117.0, 118.0, 117.0, 119.0], "value": 127.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 141.0, 106.0, 179.0, 147.0, 147.0, 113.0, 115.0, 191.0, 143.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 204.0, 199.0, 231.0, 230.0, 282.0, 250.0, 196.0, 198.0, 197.0], "value": 218.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 67.0, 52.0, 81.0, 87.0, 86.0, 87.0, 51.0, 96.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 66.0, 97.0, 107.0, 70.0, 100.0, 121.0, 57.0, 88.0, 111.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 130.0, 88.0, 89.0, 89.0, 85.0, 78.0, 132.0, 137.0, 87.0], "value": 101.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 94.0, 95.0, 144.0, 103.0, 101.0, 153.0, 94.0, 92.0, 153.0], "value": 117.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 77.0, 136.0, 134.0, 88.0, 126.0, 86.0, 144.0, 135.0, 118.0], "value": 113.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 61.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 81.0, 85.0, 77.0, 71.0, 72.0, 75.0, 94.0, 62.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 83.0, 85.0, 106.0, 105.0, 107.0, 91.0, 88.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 139.0, 141.0, 144.0, 153.0, 162.0, 166.0, 196.0, 154.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 166.0, 176.0, 233.0, 175.0, 166.0, 168.0, 164.0, 169.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 70.0, 67.0, 71.0, 69.0, 67.0, 72.0, 86.0, 77.0], "value": 72.0, "unit": "score"}]}]} 02:54:39 INFO - Return code: 0 02:54:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:54:39 ERROR - # TBPL SUCCESS # 02:54:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:39 INFO - 2017-01-17 02:54:39.245 screenresolution[1657:10761] starting screenresolution argv=screenresolution get 02:54:39 INFO - 2017-01-17 02:54:39.248 screenresolution[1657:10761] Display 0: 1600x1200x32@60 02:54:39 INFO - 2017-01-17 02:54:39.254 screenresolution[1658:10764] starting screenresolution argv=screenresolution list 02:54:39 INFO - Available Modes on Display 0 02:54:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:39 INFO - Intel Iris: 02:54:39 INFO - Chipset Model: Intel Iris 02:54:39 INFO - Type: GPU 02:54:39 INFO - Bus: Built-In 02:54:39 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:39 INFO - Vendor: Intel (0x8086) 02:54:39 INFO - Device ID: 0x0a2e 02:54:39 INFO - Revision ID: 0x0009 02:54:39 INFO - Displays: 02:54:39 INFO - Display: 02:54:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:39 INFO - Display Serial Number: 1600x1200 60 02:54:39 INFO - Main Display: Yes 02:54:39 INFO - Mirror: Off 02:54:39 INFO - Online: Yes 02:54:39 INFO - Rotation: Supported 02:54:39 INFO - Return code: 0 02:54:39 INFO - Running post-action listener: _resource_record_post_action 02:54:39 INFO - [mozharness: 2017-01-17 10:54:39.497383Z] Finished run-tests step (success) 02:54:39 INFO - Running post-run listener: _resource_record_post_run 02:54:39 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 40433664; Write bytes: 664132608; Read time: 393; Write time: 1903 02:54:39 INFO - TinderboxPrint: CPU usage
54.2% 02:54:39 INFO - TinderboxPrint: I/O read bytes / time
40,433,664 / 393 02:54:39 INFO - TinderboxPrint: I/O write bytes / time
664,132,608 / 1,903 02:54:39 INFO - TinderboxPrint: CPU idle
2,217.1 (45.8%) 02:54:39 INFO - TinderboxPrint: CPU system
980.8 (20.2%) 02:54:39 INFO - TinderboxPrint: CPU user
1,647.9 (34.0%) 02:54:39 INFO - TinderboxPrint: Swap in / out
388,550,656 / 0 02:54:39 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 340050432; Write bytes: 334211072; Read time: 26761; Write time: 654 02:54:39 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34131968; Write bytes: 312198144; Read time: 311; Write time: 1196 02:54:39 INFO - Running post-run listener: _upload_blobber_files 02:54:39 INFO - Blob upload gear active. 02:54:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:54:39 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 02:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:54:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:54:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:54:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:54:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:41 INFO - (blobuploader) - INFO - Done attempting. 02:54:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:54:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:43 INFO - (blobuploader) - INFO - Done attempting. 02:54:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:54:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:54:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:45 INFO - (blobuploader) - INFO - Done attempting. 02:54:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:54:45 INFO - Return code: 0 02:54:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:54:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:54:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08cbb2fbbfa0494ad6780e7a584fd2db58250106a5621870efe57da1ef69c05a96df14e64f72c8ee710da05d64be7c55c5d5fa0de2cf11a5e7500852c98bead9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23cd6af7d6956beb7365a4cd753f95a400bc6eec7439241a50df2fae1f4b6d44f0fcfbb8ff901252b77b65a9f7d07957aef159cc611556339ab6f3f5cf0ef4a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5be711a34422fcf716659b85c8186d43edd3f435bdcbce82ca8090c0e573bbdb611c4636767639d115257887c881f7f6a41c0a979838d4597d8b68b4bb4fd33"} 02:54:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:54:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:54:45 INFO - Contents: 02:54:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08cbb2fbbfa0494ad6780e7a584fd2db58250106a5621870efe57da1ef69c05a96df14e64f72c8ee710da05d64be7c55c5d5fa0de2cf11a5e7500852c98bead9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23cd6af7d6956beb7365a4cd753f95a400bc6eec7439241a50df2fae1f4b6d44f0fcfbb8ff901252b77b65a9f7d07957aef159cc611556339ab6f3f5cf0ef4a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5be711a34422fcf716659b85c8186d43edd3f435bdcbce82ca8090c0e573bbdb611c4636767639d115257887c881f7f6a41c0a979838d4597d8b68b4bb4fd33"} 02:54:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:54:45 INFO - Copying logs to upload dir... 02:54:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:54:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.940554 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-17 02:54:45.586421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:45.590464) ========= 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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08cbb2fbbfa0494ad6780e7a584fd2db58250106a5621870efe57da1ef69c05a96df14e64f72c8ee710da05d64be7c55c5d5fa0de2cf11a5e7500852c98bead9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23cd6af7d6956beb7365a4cd753f95a400bc6eec7439241a50df2fae1f4b6d44f0fcfbb8ff901252b77b65a9f7d07957aef159cc611556339ab6f3f5cf0ef4a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5be711a34422fcf716659b85c8186d43edd3f435bdcbce82ca8090c0e573bbdb611c4636767639d115257887c881f7f6a41c0a979838d4597d8b68b4bb4fd33"} build_url:https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/EC_oPq6oSk27qOVP8qM8zA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08cbb2fbbfa0494ad6780e7a584fd2db58250106a5621870efe57da1ef69c05a96df14e64f72c8ee710da05d64be7c55c5d5fa0de2cf11a5e7500852c98bead9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23cd6af7d6956beb7365a4cd753f95a400bc6eec7439241a50df2fae1f4b6d44f0fcfbb8ff901252b77b65a9f7d07957aef159cc611556339ab6f3f5cf0ef4a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5be711a34422fcf716659b85c8186d43edd3f435bdcbce82ca8090c0e573bbdb611c4636767639d115257887c881f7f6a41c0a979838d4597d8b68b4bb4fd33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:45.625367) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:45.625715) ========= 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.aQ20Rf7gNT/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.a4ljGDwd8o/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005215 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 02:54:45.675055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 02:54:45.675379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 02:54:45.675725) ========= ========= Total master_lag: 0.18 =========