builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1477515287.71 results: success (0) buildid: 20161011025846 builduid: 5120a331d5884b248fd298482f4fffa2 revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.713622) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.714048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.714316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.736945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.737315) ========= 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.XpXecJYA7A/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.AyaOZyNr4O/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 --2016-10-26 13:54:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 124M=0s 2016-10-26 13:54:47 (124 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.848921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.849249) ========= 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.XpXecJYA7A/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.AyaOZyNr4O/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.019895 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:47.897886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:54:47.898264) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XpXecJYA7A/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.AyaOZyNr4O/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 2016-10-26 13:54:47,978 truncating revision to first 12 chars 2016-10-26 13:54:47,979 Setting DEBUG logging. 2016-10-26 13:54:47,979 attempt 1/10 2016-10-26 13:54:47,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45052ddb03a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:54:49,663 unpacking tar archive at: mozilla-central-45052ddb03a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.941496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:54:49.860779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:49.861146) ========= script_repo_revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:49.861531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:49.861793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:49.879759) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-10-26 13:54:49.880106) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XpXecJYA7A/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.AyaOZyNr4O/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:54:50 INFO - MultiFileLogger online at 20161026 13:54:50 in /builds/slave/test 13:54:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:54:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:54:50 INFO - {'append_to_log': False, 13:54:50 INFO - 'base_work_dir': '/builds/slave/test', 13:54:50 INFO - 'blob_upload_branch': 'Firefox', 13:54:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:54:50 INFO - 'branch': 'Firefox', 13:54:50 INFO - 'buildbot_json_path': 'buildprops.json', 13:54:50 INFO - 'config_files': ('talos/mac_config.py',), 13:54:50 INFO - 'default_actions': ('clobber', 13:54:50 INFO - 'read-buildbot-config', 13:54:50 INFO - 'download-and-extract', 13:54:50 INFO - 'populate-webroot', 13:54:50 INFO - 'create-virtualenv', 13:54:50 INFO - 'install', 13:54:50 INFO - 'run-tests'), 13:54:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:54:50 INFO - 'download_minidump_stackwalk': True, 13:54:50 INFO - 'download_symbols': 'ondemand', 13:54:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:54:50 INFO - 'tooltool.py': '/tools/tooltool.py', 13:54:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:54:50 INFO - '/tools/misc-python/virtualenv.py')}, 13:54:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:54:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:54:50 INFO - 'installer_path': 'installer.exe', 13:54:50 INFO - 'log_level': 'info', 13:54:50 INFO - 'log_name': 'talos', 13:54:50 INFO - 'log_to_console': True, 13:54:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:54:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:54:50 INFO - 'opt_config_files': (), 13:54:50 INFO - 'pip_index': False, 13:54:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:54:50 INFO - 'cmd': ('bash', 13:54:50 INFO - '-c', 13:54:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:54:50 INFO - 'enabled': True, 13:54:50 INFO - 'halt_on_failure': False, 13:54:50 INFO - 'name': 'check_screen_resolution'},), 13:54:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:54:50 INFO - 'cmd': ('bash', 13:54:50 INFO - '-c', 13:54:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:54:50 INFO - 'enabled': True, 13:54:50 INFO - 'halt_on_failure': False, 13:54:50 INFO - 'name': 'check_screen_resolution'},), 13:54:50 INFO - 'run_cmd_checks_enabled': True, 13:54:50 INFO - 'sps_profile': False, 13:54:50 INFO - 'sps_profile_interval': 0, 13:54:50 INFO - 'suite': 'dromaeojs-e10s', 13:54:50 INFO - 'system_bits': '32', 13:54:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:54:50 INFO - 'title': 't-yosemite-r7-0220', 13:54:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:54:50 INFO - 'use_talos_json': True, 13:54:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:54:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:54:50 INFO - 'work_dir': 'build'} 13:54:50 INFO - [mozharness: 2016-10-26 20:54:50.081455Z] Running clobber step. 13:54:50 INFO - Running pre-action listener: _resource_record_pre_action 13:54:50 INFO - Running main action method: clobber 13:54:50 INFO - rmtree: /builds/slave/test/build 13:54:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:54:51 INFO - Running post-action listener: _resource_record_post_action 13:54:51 INFO - [mozharness: 2016-10-26 20:54:51.575180Z] Finished clobber step (success) 13:54:51 INFO - [mozharness: 2016-10-26 20:54:51.575343Z] Running read-buildbot-config step. 13:54:51 INFO - Running pre-action listener: _resource_record_pre_action 13:54:51 INFO - Running main action method: read_buildbot_config 13:54:51 INFO - Using buildbot properties: 13:54:51 INFO - { 13:54:51 INFO - "project": "", 13:54:51 INFO - "product": "firefox", 13:54:51 INFO - "script_repo_revision": "production", 13:54:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:54:51 INFO - "repository": "", 13:54:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:54:51 INFO - "buildid": "20161011025846", 13:54:51 INFO - "pgo_build": "False", 13:54:51 INFO - "basedir": "/builds/slave/test", 13:54:51 INFO - "buildnumber": 315, 13:54:51 INFO - "slavename": "t-yosemite-r7-0220", 13:54:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:54:51 INFO - "platform": "yosemite_r7", 13:54:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:54:51 INFO - "branch": "mozilla-central", 13:54:51 INFO - "repo_path": "mozilla-central", 13:54:51 INFO - "revision": "45052ddb03a448606ca6ce33f4893a559edebf72", 13:54:51 INFO - "stage_platform": "macosx64", 13:54:51 INFO - "builduid": "5120a331d5884b248fd298482f4fffa2", 13:54:51 INFO - "slavebuilddir": "test" 13:54:51 INFO - } 13:54:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:54:51 INFO - Running post-action listener: _resource_record_post_action 13:54:51 INFO - [mozharness: 2016-10-26 20:54:51.578722Z] Finished read-buildbot-config step (success) 13:54:51 INFO - [mozharness: 2016-10-26 20:54:51.578839Z] Running download-and-extract step. 13:54:51 INFO - Running pre-action listener: _resource_record_pre_action 13:54:51 INFO - Running main action method: download_and_extract 13:54:51 INFO - mkdir: /builds/slave/test/build/tests 13:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:51 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:54:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:54:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:54:57 INFO - Downloaded 1199 bytes. 13:54:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:54:57 INFO - Using the following test package requirements: 13:54:57 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:54:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:54:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:54:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'jsshell-mac.zip'], 13:54:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:54:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:54:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:54:57 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:54:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:54:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:54:57 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:54:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:54:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:54:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:54:57 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:55:03 INFO - Http code: 200 13:55:03 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 13:55:03 INFO - x-amz-cf-id: kkBikM2wLTLf7TbiyqM4NOLIlI5jXFIiRzF3Vgjl5m4-bI8Hill0SA== 13:55:03 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:03 INFO - Expected file size: 16508481 13:55:03 INFO - Obtained file size: 16508481 13:55:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:55:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:55:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:10 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:55:11 INFO - Http code: 200 13:55:11 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 13:55:11 INFO - x-amz-cf-id: yLlpUUNZZ1h-dcdht6wKZMpK9xM-0Qj8e5sP9vxGiYkIUyxiEkrGIQ== 13:55:11 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:11 INFO - Expected file size: 16508481 13:55:11 INFO - Obtained file size: 16508481 13:55:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:55:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:55:17 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:55:18 INFO - Http code: 200 13:55:18 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 13:55:18 INFO - x-amz-cf-id: Us8JNsGE8OPZKjBdLNe4DMwcl9RFj36569CGh9Q1KT0dY31h8brObw== 13:55:18 INFO - x-amz-version-id: h7oaKNhRQzyZtP5vdBlaq4n0FwksjilO 13:55:18 INFO - Expected file size: 14409006 13:55:18 INFO - Obtained file size: 14409006 13:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:19 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:55:22 INFO - Downloaded 111738529 bytes. 13:55:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:22 INFO - mkdir: /builds/slave/test/properties 13:55:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:22 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:22 INFO - Contents: 13:55:22 INFO - build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:23 INFO - Running post-action listener: _resource_record_post_action 13:55:23 INFO - Running post-action listener: set_extra_try_arguments 13:55:23 INFO - [mozharness: 2016-10-26 20:55:23.133967Z] Finished download-and-extract step (success) 13:55:23 INFO - [mozharness: 2016-10-26 20:55:23.134118Z] Running populate-webroot step. 13:55:23 INFO - Running pre-action listener: _resource_record_pre_action 13:55:23 INFO - Running main action method: populate_webroot 13:55:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:23 INFO - '--tppagecycles', 13:55:23 INFO - '7'], 13:55:23 INFO - 'tests': ['tsvgm']}}, 13:55:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['damp', 'tps']}, 13:55:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'tests': ['damp', 'tps']}, 13:55:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['dromaeo_dom']}, 13:55:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['basic_compositor_video']}, 13:55:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:55:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['a11yr', 13:55:23 INFO - 'ts_paint', 13:55:23 INFO - 'tpaint', 13:55:23 INFO - 'sessionrestore', 13:55:23 INFO - 'sessionrestore_no_auto_restore', 13:55:23 INFO - 'tabpaint']}, 13:55:23 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:23 INFO - 'ts_paint', 13:55:23 INFO - 'tpaint', 13:55:23 INFO - 'sessionrestore', 13:55:23 INFO - 'sessionrestore_no_auto_restore', 13:55:23 INFO - 'tabpaint']}, 13:55:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:23 INFO - 'ts_paint', 13:55:23 INFO - 'tpaint', 13:55:23 INFO - 'sessionrestore', 13:55:23 INFO - 'sessionrestore_no_auto_restore', 13:55:23 INFO - 'tabpaint']}, 13:55:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:23 INFO - 'ts_paint', 13:55:23 INFO - 'tpaint', 13:55:23 INFO - 'sessionrestore', 13:55:23 INFO - 'sessionrestore_no_auto_restore', 13:55:23 INFO - 'tabpaint']}, 13:55:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['a11yr', 13:55:23 INFO - 'ts_paint', 13:55:23 INFO - 'tpaint', 13:55:23 INFO - 'sessionrestore', 13:55:23 INFO - 'sessionrestore_no_auto_restore', 13:55:23 INFO - 'tabpaint']}, 13:55:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['a11yr', 13:55:23 INFO - 'ts_paint', 13:55:23 INFO - 'tpaint', 13:55:23 INFO - 'sessionrestore', 13:55:23 INFO - 'sessionrestore_no_auto_restore', 13:55:23 INFO - 'tabpaint']}, 13:55:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['tsvgx', 13:55:23 INFO - 'tsvgr_opacity', 13:55:23 INFO - 'tart', 13:55:23 INFO - 'tscrollx', 13:55:23 INFO - 'cart']}, 13:55:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:23 INFO - 'tsvgr_opacity', 13:55:23 INFO - 'tart', 13:55:23 INFO - 'tscrollx', 13:55:23 INFO - 'cart']}, 13:55:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'talos_options': ['--disable-e10s'], 13:55:23 INFO - 'tests': ['tp5o']}, 13:55:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'tests': ['tp5o']}, 13:55:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'talos_options': ['--disable-e10s', 13:55:23 INFO - '--xperf_path', 13:55:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:23 INFO - 'tests': ['tp5n']}, 13:55:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:23 INFO - 'talos_options': ['--xperf_path', 13:55:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:23 INFO - 'tests': ['tp5n']}}, 13:55:23 INFO - 'talos.zip': {'path': '', 13:55:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:23 INFO - Running post-action listener: _resource_record_post_action 13:55:23 INFO - [mozharness: 2016-10-26 20:55:23.153120Z] Finished populate-webroot step (success) 13:55:23 INFO - [mozharness: 2016-10-26 20:55:23.153266Z] Running create-virtualenv step. 13:55:23 INFO - Running pre-action listener: _resource_record_pre_action 13:55:23 INFO - Running main action method: create_virtualenv 13:55:23 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:55:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:23 INFO - Using real prefix '/tools/python27' 13:55:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:24 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:26 INFO - Installing pip.................done. 13:55:26 INFO - Return code: 0 13:55:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:55:27 INFO - Reading from file tmpfile_stdout 13:55:27 INFO - Output received: 13:55:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:55:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55: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', 'pip>=1.5'] in /builds/slave/test/build 13:55: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 pip>=1.5 13:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:27 INFO - 'HOME': '/Users/cltbld', 13:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:27 INFO - 'LOGNAME': 'cltbld', 13:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:27 INFO - 'MOZ_NO_REMOTE': '1', 13:55:27 INFO - 'NO_EM_RESTART': '1', 13:55:27 INFO - 'PAGER': '/bin/cat', 13:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:27 INFO - 'PWD': '/builds/slave/test', 13:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:27 INFO - 'SHELL': '/bin/bash', 13:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:27 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:27 INFO - 'USER': 'cltbld', 13:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:27 INFO - 'XPC_FLAGS': '0x0', 13:55:27 INFO - 'XPC_SERVICE_NAME': '0', 13:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:55:27 INFO - Cleaning up... 13:55:27 INFO - Return code: 0 13:55:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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', '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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:55: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 psutil>=3.1.1 13:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:27 INFO - 'HOME': '/Users/cltbld', 13:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:27 INFO - 'LOGNAME': 'cltbld', 13:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:27 INFO - 'MOZ_NO_REMOTE': '1', 13:55:27 INFO - 'NO_EM_RESTART': '1', 13:55:27 INFO - 'PAGER': '/bin/cat', 13:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:27 INFO - 'PWD': '/builds/slave/test', 13:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:27 INFO - 'SHELL': '/bin/bash', 13:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:27 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:27 INFO - 'USER': 'cltbld', 13:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:27 INFO - 'XPC_FLAGS': '0x0', 13:55:27 INFO - 'XPC_SERVICE_NAME': '0', 13:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:27 INFO - Downloading/unpacking psutil>=3.1.1 13:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:31 INFO - Installing collected packages: psutil 13:55:31 INFO - Running setup.py install for psutil 13:55:31 INFO - building 'psutil._psutil_osx' extension 13:55:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:55:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:55:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:55:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:55:31 INFO - building 'psutil._psutil_posix' extension 13:55:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:55:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:55:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:55:31 INFO - ^ 13:55:31 INFO - 1 warning generated. 13:55:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:55:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:31 INFO - Successfully installed psutil 13:55:31 INFO - Cleaning up... 13:55:32 INFO - Return code: 0 13:55:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:32 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:32 INFO - 'HOME': '/Users/cltbld', 13:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:32 INFO - 'LOGNAME': 'cltbld', 13:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:32 INFO - 'MOZ_NO_REMOTE': '1', 13:55:32 INFO - 'NO_EM_RESTART': '1', 13:55:32 INFO - 'PAGER': '/bin/cat', 13:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:32 INFO - 'PWD': '/builds/slave/test', 13:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:32 INFO - 'SHELL': '/bin/bash', 13:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:32 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:32 INFO - 'USER': 'cltbld', 13:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:32 INFO - 'XPC_FLAGS': '0x0', 13:55:32 INFO - 'XPC_SERVICE_NAME': '0', 13:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:55:34 INFO - Installing collected packages: mozsystemmonitor 13:55:34 INFO - Running setup.py install for mozsystemmonitor 13:55:35 INFO - Successfully installed mozsystemmonitor 13:55:35 INFO - Cleaning up... 13:55:35 INFO - Return code: 0 13:55:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:35 INFO - 'HOME': '/Users/cltbld', 13:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:35 INFO - 'LOGNAME': 'cltbld', 13:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:35 INFO - 'MOZ_NO_REMOTE': '1', 13:55:35 INFO - 'NO_EM_RESTART': '1', 13:55:35 INFO - 'PAGER': '/bin/cat', 13:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:35 INFO - 'PWD': '/builds/slave/test', 13:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:35 INFO - 'SHELL': '/bin/bash', 13:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:35 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:35 INFO - 'USER': 'cltbld', 13:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:35 INFO - 'XPC_FLAGS': '0x0', 13:55:35 INFO - 'XPC_SERVICE_NAME': '0', 13:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:35 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:38 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:38 INFO - warning: no files found matching '*.txt' 13:55:38 INFO - no previously-included directories found matching 'build' 13:55:38 INFO - no previously-included directories found matching 'dist' 13:55:38 INFO - no previously-included directories found matching '.git*' 13:55:38 INFO - Installing collected packages: jsonschema, functools32 13:55:38 INFO - Running setup.py install for functools32 13:55:38 INFO - warning: no files found matching '*.txt' 13:55:38 INFO - no previously-included directories found matching 'build' 13:55:38 INFO - no previously-included directories found matching 'dist' 13:55:38 INFO - no previously-included directories found matching '.git*' 13:55:38 INFO - Successfully installed jsonschema functools32 13:55:38 INFO - Cleaning up... 13:55:38 INFO - Return code: 0 13:55:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:38 INFO - 'HOME': '/Users/cltbld', 13:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:38 INFO - 'LOGNAME': 'cltbld', 13:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:38 INFO - 'MOZ_NO_REMOTE': '1', 13:55:38 INFO - 'NO_EM_RESTART': '1', 13:55:38 INFO - 'PAGER': '/bin/cat', 13:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:38 INFO - 'PWD': '/builds/slave/test', 13:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:38 INFO - 'SHELL': '/bin/bash', 13:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:38 INFO - 'USER': 'cltbld', 13:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:38 INFO - 'XPC_FLAGS': '0x0', 13:55:38 INFO - 'XPC_SERVICE_NAME': '0', 13:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:55:38 INFO - Cleaning up... 13:55:38 INFO - Return code: 0 13:55:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:38 INFO - 'HOME': '/Users/cltbld', 13:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:38 INFO - 'LOGNAME': 'cltbld', 13:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:38 INFO - 'MOZ_NO_REMOTE': '1', 13:55:38 INFO - 'NO_EM_RESTART': '1', 13:55:38 INFO - 'PAGER': '/bin/cat', 13:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:38 INFO - 'PWD': '/builds/slave/test', 13:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:38 INFO - 'SHELL': '/bin/bash', 13:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:38 INFO - 'USER': 'cltbld', 13:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:38 INFO - 'XPC_FLAGS': '0x0', 13:55:38 INFO - 'XPC_SERVICE_NAME': '0', 13:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:39 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:42 INFO - Downloading docopt-0.6.1.tar.gz 13:55:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:43 INFO - Running setup.py install for blobuploader 13:55:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:43 INFO - Running setup.py install for requests 13:55:43 INFO - Running setup.py install for docopt 13:55:43 INFO - Successfully installed blobuploader requests docopt 13:55:43 INFO - Cleaning up... 13:55:43 INFO - Return code: 0 13:55:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:43 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:43 INFO - 'HOME': '/Users/cltbld', 13:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:43 INFO - 'LOGNAME': 'cltbld', 13:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:43 INFO - 'MOZ_NO_REMOTE': '1', 13:55:43 INFO - 'NO_EM_RESTART': '1', 13:55:43 INFO - 'PAGER': '/bin/cat', 13:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:43 INFO - 'PWD': '/builds/slave/test', 13:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:43 INFO - 'SHELL': '/bin/bash', 13:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:43 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:43 INFO - 'USER': 'cltbld', 13:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:43 INFO - 'XPC_FLAGS': '0x0', 13:55:43 INFO - 'XPC_SERVICE_NAME': '0', 13:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-DK53EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HMbuXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-oXCoLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-bPmk0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-kH2nfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lkCYzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-aU5XmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-uMQ8So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-rwuKiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-2z4K6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HRvEoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-4iFAal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-678h6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-oyOCtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mNee4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-iQzm9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5MIXuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:45 INFO - Running setup.py install for manifestparser 13:55:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:46 INFO - Running setup.py install for mozcrash 13:55:46 INFO - Running setup.py install for mozdebug 13:55:46 INFO - Running setup.py install for mozdevice 13:55:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:46 INFO - Running setup.py install for mozfile 13:55:46 INFO - Running setup.py install for mozhttpd 13:55:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:46 INFO - Running setup.py install for mozinfo 13:55:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Running setup.py install for mozInstall 13:55:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Running setup.py install for mozleak 13:55:47 INFO - Running setup.py install for mozlog 13:55:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Running setup.py install for moznetwork 13:55:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Running setup.py install for mozprocess 13:55:47 INFO - Running setup.py install for mozprofile 13:55:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:47 INFO - Running setup.py install for mozrunner 13:55:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:48 INFO - Running setup.py install for mozscreenshot 13:55:48 INFO - Running setup.py install for moztest 13:55:48 INFO - Running setup.py install for mozversion 13:55:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:48 INFO - Cleaning up... 13:55:48 INFO - Return code: 0 13:55:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:49 INFO - 'HOME': '/Users/cltbld', 13:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:49 INFO - 'LOGNAME': 'cltbld', 13:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:49 INFO - 'MOZ_NO_REMOTE': '1', 13:55:49 INFO - 'NO_EM_RESTART': '1', 13:55:49 INFO - 'PAGER': '/bin/cat', 13:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:49 INFO - 'PWD': '/builds/slave/test', 13:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:49 INFO - 'SHELL': '/bin/bash', 13:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:49 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:49 INFO - 'USER': 'cltbld', 13:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:49 INFO - 'XPC_FLAGS': '0x0', 13:55:49 INFO - 'XPC_SERVICE_NAME': '0', 13:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-_ljwHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yjkk0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ByjS4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lgRUI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-LrdcTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-l6PWXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-QYgLYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Ur6IqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zNawQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BEQ34b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TL_FxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ULV_32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-XDoN79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-fYHW4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-8k0Gj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-h5Y7At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Ubpy0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:55:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:54 INFO - Downloading blessings-1.6.tar.gz 13:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:55:54 INFO - Installing collected packages: blessings 13:55:54 INFO - Running setup.py install for blessings 13:55:54 INFO - Successfully installed blessings 13:55:54 INFO - Cleaning up... 13:55:54 INFO - Return code: 0 13:55:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:55:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:55 INFO - Reading from file tmpfile_stdout 13:55:55 INFO - Current package versions: 13:55:55 INFO - blessings == 1.6 13:55:55 INFO - blobuploader == 1.2.4 13:55:55 INFO - docopt == 0.6.1 13:55:55 INFO - functools32 == 3.2.3-2 13:55:55 INFO - jsonschema == 2.5.1 13:55:55 INFO - manifestparser == 1.1 13:55:55 INFO - mozInstall == 1.12 13:55:55 INFO - mozcrash == 0.17 13:55:55 INFO - mozdebug == 0.1 13:55:55 INFO - mozdevice == 0.48 13:55:55 INFO - mozfile == 1.2 13:55:55 INFO - mozhttpd == 0.7 13:55:55 INFO - mozinfo == 0.9 13:55:55 INFO - mozleak == 0.1 13:55:55 INFO - mozlog == 3.4 13:55:55 INFO - moznetwork == 0.27 13:55:55 INFO - mozprocess == 0.23 13:55:55 INFO - mozprofile == 0.28 13:55:55 INFO - mozrunner == 6.12 13:55:55 INFO - mozscreenshot == 0.1 13:55:55 INFO - mozsystemmonitor == 0.3 13:55:55 INFO - moztest == 0.7 13:55:55 INFO - mozversion == 1.4 13:55:55 INFO - psutil == 3.1.1 13:55:55 INFO - requests == 1.2.3 13:55:55 INFO - wsgiref == 0.1.2 13:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:55 INFO - 'HOME': '/Users/cltbld', 13:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:55 INFO - 'LOGNAME': 'cltbld', 13:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:55 INFO - 'MOZ_NO_REMOTE': '1', 13:55:55 INFO - 'NO_EM_RESTART': '1', 13:55:55 INFO - 'PAGER': '/bin/cat', 13:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:55 INFO - 'PWD': '/builds/slave/test', 13:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:55 INFO - 'SHELL': '/bin/bash', 13:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:55 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:55 INFO - 'USER': 'cltbld', 13:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:55 INFO - 'XPC_FLAGS': '0x0', 13:55:55 INFO - 'XPC_SERVICE_NAME': '0', 13:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:55:55 INFO - Cleaning up... 13:55:55 INFO - Return code: 0 13:55:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 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 0x10e38a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e300570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad20d7fbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, '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.XpXecJYA7A/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.AyaOZyNr4O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:55 INFO - 'HOME': '/Users/cltbld', 13:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:55 INFO - 'LOGNAME': 'cltbld', 13:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:55 INFO - 'MOZ_NO_REMOTE': '1', 13:55:55 INFO - 'NO_EM_RESTART': '1', 13:55:55 INFO - 'PAGER': '/bin/cat', 13:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:55 INFO - 'PWD': '/builds/slave/test', 13:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:55 INFO - 'SHELL': '/bin/bash', 13:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:55:55 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:55 INFO - 'USER': 'cltbld', 13:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:55 INFO - 'XPC_FLAGS': '0x0', 13:55:55 INFO - 'XPC_SERVICE_NAME': '0', 13:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:55:55 INFO - Cleaning up... 13:55:55 INFO - Return code: 0 13:55:55 INFO - Running post-action listener: _resource_record_post_action 13:55:55 INFO - Running post-action listener: _start_resource_monitoring 13:55:55 INFO - Starting resource monitoring. 13:55:55 INFO - [mozharness: 2016-10-26 20:55:55.594296Z] Finished create-virtualenv step (success) 13:55:55 INFO - [mozharness: 2016-10-26 20:55:55.595286Z] Running install step. 13:55:55 INFO - Running pre-action listener: _resource_record_pre_action 13:55:55 INFO - Running main action method: install 13:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:55 INFO - Reading from file tmpfile_stdout 13:55:55 INFO - Detecting whether we're running mozinstall >=1.0... 13:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:55:55 INFO - Reading from file tmpfile_stdout 13:55:55 INFO - Output received: 13:55:55 INFO - Usage: mozinstall [options] installer 13:55:55 INFO - Options: 13:55:55 INFO - -h, --help show this help message and exit 13:55:55 INFO - -d DEST, --destination=DEST 13:55:55 INFO - Directory to install application into. [default: 13:55:55 INFO - "/builds/slave/test"] 13:55:55 INFO - --app=APP Application being installed. [default: firefox] 13:55:55 INFO - mkdir: /builds/slave/test/build/application 13:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:56:30 INFO - Reading from file tmpfile_stdout 13:56:30 INFO - Output received: 13:56:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:56:30 INFO - Running post-action listener: _resource_record_post_action 13:56:30 INFO - [mozharness: 2016-10-26 20:56:30.691641Z] Finished install step (success) 13:56:30 INFO - [mozharness: 2016-10-26 20:56:30.691771Z] Running run-tests step. 13:56:30 INFO - Running pre-action listener: _resource_record_pre_action 13:56:30 INFO - Running main action method: run_tests 13:56:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:56:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:56:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:56:30 INFO - 2016-10-26 13:56:30.706 screenresolution[1933:20516] starting screenresolution argv=screenresolution get 13:56:30 INFO - 2016-10-26 13:56:30.709 screenresolution[1933:20516] Display 0: 1600x1200x32@60 13:56:30 INFO - 2016-10-26 13:56:30.715 screenresolution[1934:20518] starting screenresolution argv=screenresolution list 13:56:30 INFO - Available Modes on Display 0 13:56:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:56:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:56:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:56:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:56:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:56:30 INFO - Intel Iris: 13:56:30 INFO - Chipset Model: Intel Iris 13:56:30 INFO - Type: GPU 13:56:30 INFO - Bus: Built-In 13:56:30 INFO - VRAM (Dynamic, Max): 1536 MB 13:56:30 INFO - Vendor: Intel (0x8086) 13:56:30 INFO - Device ID: 0x0a2e 13:56:30 INFO - Revision ID: 0x0009 13:56:30 INFO - Displays: 13:56:30 INFO - Display: 13:56:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:56:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:56:30 INFO - Display Serial Number: 1600x1200 60 13:56:30 INFO - Main Display: Yes 13:56:30 INFO - Mirror: Off 13:56:30 INFO - Online: Yes 13:56:30 INFO - Rotation: Supported 13:56:30 INFO - Return code: 0 13:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:30 INFO - Python 2.7.3 13:56:30 INFO - Return code: 0 13:56:30 INFO - grabbing minidump binary from tooltool 13:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19ed30>, '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 0x10dfc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e196b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:56:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:56:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:56:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:31 INFO - Return code: 0 13:56:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:56:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:56:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XpXecJYA7A/Render', 13:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:31 INFO - 'HOME': '/Users/cltbld', 13:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:31 INFO - 'LOGNAME': 'cltbld', 13:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:31 INFO - 'MOZ_NO_REMOTE': '1', 13:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:31 INFO - 'NO_EM_RESTART': '1', 13:56:31 INFO - 'PAGER': '/bin/cat', 13:56:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:31 INFO - 'PWD': '/builds/slave/test', 13:56:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:31 INFO - 'SHELL': '/bin/bash', 13:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AyaOZyNr4O/Listeners', 13:56:31 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:31 INFO - 'USER': 'cltbld', 13:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:31 INFO - 'XPC_FLAGS': '0x0', 13:56:31 INFO - 'XPC_SERVICE_NAME': '0', 13:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:56:31 INFO - mozversion application_buildid: 20161011025846 13:56:31 INFO - mozversion application_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:31 INFO - mozversion application_display_name: Nightly 13:56:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:31 INFO - mozversion application_name: Firefox 13:56:31 INFO - mozversion application_remotingname: firefox 13:56:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:56:31 INFO - mozversion application_vendor: Mozilla 13:56:31 INFO - mozversion application_version: 52.0a1 13:56:31 INFO - mozversion platform_buildid: 20161011025846 13:56:31 INFO - mozversion platform_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:56:31 INFO - mozversion platform_version: 52.0a1 13:56:31 INFO - using testdate: 1477515391 13:56:31 INFO - actual date: 1477515391 13:56:31 INFO - starting webserver on 'localhost:56166' 13:56:31 INFO - SUITE-START | Running 2 tests 13:56:31 INFO - TEST-START | dromaeo_css 13:56:31 INFO - operating with platform_type : mac_ 13:56:31 INFO - Initialising browser for dromaeo_css test... 13:56:31 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpOjEG8g/profile http://localhost:56166/getInfo.html) 13:56:33 INFO - PROCESS | 1944 | 2016-10-26 13:56:33.771 plugin-container[1946:20669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 13:56:33 INFO - PROCESS | 1944 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:33 INFO - PROCESS | 1944 | 2016-10-26 13:56:33.773 plugin-container[1946:20669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 13:56:33 INFO - PROCESS | 1944 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:33 INFO - PROCESS | 1944 | 2016-10-26 13:56:33.773 plugin-container[1946:20669] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:33 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 13:56:33 INFO - PROCESS | 1944 | colorDepth:24 13:56:33 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 13:56:33 INFO - PROCESS | 1944 | __metrics 13:56:33 ERROR - PROCESS | 1944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 13:56:34 INFO - TEST-INFO | 1944: exit 0 13:56:34 INFO - Browser initialized. 13:56:34 INFO - Running cycle 1/1 for dromaeo_css test... 13:56:34 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpOjEG8g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:37 INFO - PROCESS | 1947 | 2016-10-26 13:56:37.057 plugin-container[1948:20790] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 13:56:37 INFO - PROCESS | 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:37 INFO - PROCESS | 1947 | 2016-10-26 13:56:37.058 plugin-container[1948:20790] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 13:56:37 INFO - PROCESS | 1947 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:37 INFO - PROCESS | 1947 | 2016-10-26 13:56:37.058 plugin-container[1948:20790] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:46 INFO - PROCESS | 1947 | RSS: Main: 238534656 13:56:46 INFO - PROCESS | 1947 | 13:57:36 INFO - PROCESS | 1947 | 1477515456416 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:59:49 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56166/tests/dromaeo/cssquery-ext.html) 13:59:50 INFO - PROCESS | 1947 | RSS: Main: 253788160 13:59:50 INFO - PROCESS | 1947 | 14:02:52 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56166/tests/dromaeo/cssquery-ext.html (next: http://localhost:56166/tests/dromaeo/cssquery-jquery.html) 14:02:53 INFO - PROCESS | 1947 | RSS: Main: 264482816 14:02:53 INFO - PROCESS | 1947 | 14:05:55 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56166/tests/dromaeo/cssquery-mootools.html) 14:05:55 INFO - PROCESS | 1947 | RSS: Main: 269725696 14:05:55 INFO - PROCESS | 1947 | 14:08:57 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56166/tests/dromaeo/cssquery-prototype.html) 14:08:58 INFO - PROCESS | 1947 | RSS: Main: 269291520 14:08:58 INFO - PROCESS | 1947 | 14:12:01 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56166/tests/dromaeo/cssquery-yui.html) 14:12:01 INFO - PROCESS | 1947 | RSS: Main: 274817024 14:12:01 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:56166/tests/dromaeo/cssquery-yui.html (next: http://localhost:56166/tests/dromaeo/cssquery-dojo.html) 14:15:04 INFO - PROCESS | 1947 | RSS: Main: 277184512 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | __start_tp_report 14:15:04 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 14:15:04 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 14:15:04 INFO - PROCESS | 1947 | |i|pagename|runs| 14:15:04 INFO - PROCESS | 1947 | |0;dojo.html;3028.6062811834463;3237.3201627658177;3302.7357811375077;3310.2220978070163;3322.634510203878;5337.439568845273;5413.296271484706;5424.8915021699595;5429.429909859467;5468.070428027235;5410.134378499441;5422.75597598108;5427.565794736422;5514.09017512111;5568.3596386415575;4989.376327959005;5002.424721157059;5044.545990860822;5112.539871411572;5121;4326.43756311679;4714.952850471503;5063.898722025558;5103.106956282654;5198.064348417283;4214.967333003434;4349.195398851222;4535.841245556389;4584.541545845389;4966.404031516223;4091.9565510794855;4416.845410410652;4958.181899986498;5032.194848824207;5084.669496482717;4497.887552811173;4986.551210391046;5039.21892106724;5078.339815823956;5099.745012749385;4253.574642535753;5250.422453530108;5412.675239485643;5578.693171875545;5613.915791263134;5778.988676981511;5910.527157827363;5926.436988486087;5997.640141591519;6008.369121242294;5975.402459754033;6069.180660610805;6097.390260973867;6111.908321375183;6116.877662446771;5423.566114710814;5486.890262194734;5500.889982200333;5568.66588004717;5569.192467092289;6054.848628784315;6202.906956395657;6222.408871157233;6246.094316324198;6256.092866534418;5883.558733094949;5899.587028908021;5900.232969713996;5907.911381329283;5961.821145365646;5792.391798861143;5911.201987731687;6075.453209211192;6075.936711075632;6098.969505152446;5932.644041357532;5963.98612235921;5988.760449581968;6024.698765061729;6061.212042434456;5904.704764761745;5952.285725712855;5971.044632858721;5978.8206353809455;5993.730282137314;4612.815487380534;4694.718316900997;4702.3416721659;4752.405949256343;4754.001659651442;4192.45498085247;4241.130568233505;4253.617174454314;4261.552536983634;4314.158739045919;5476.561875050066;5577.860553486195;5578.191162281447;5579.609427340129;5612.989661860905;5802.535797136219;6069.575129740964;6077.17958075663;6085.482733967662;6097.420745029215;5435.782568697208;5472.589555783253;5490.6980116094;5566.415526369754;5626.803061892896;5177.8446646599905;5190.584753219733;5199.584033277329;5211.5830733541225;5217.843464696065;6173.8456538586;6257.8748425031245;6270.310265870842;6271.090691849657;6278.623282602875;5749.597528172988;5927.436893495111;5936.495397891227;6001.2498437695285;6054.33402325735;6250.0937364082865;6252.843678907881;6253.593516421418;6255.343188965275;6263.029230469285;5716.571257155813;5830.416958304136;5922.763089476372;5936.614120082181;5992.520598352208;5887.61730487517;5985.371535988658;5986.281646202484;6055;6108.75564977396;4630;5813.709314534171;5825.825225243249;5844.620099693507;5850.180974663465;5540.722963851711;5853.180554722428;5871.500922421471;5874.148248503858;5878.147668588116;5567.3040869891265;5572.996860564975;5633.295838020247;5692.2600061993335;5799.072148456226;5879.176915231786;5887.146363777143;5903.321118071305;5905.852353691021;5917.408259174048;4154.771487568213;5015.774290156879;5662.292213473316;5676.545876329967;5702.230198923092 14:15:04 INFO - PROCESS | 1947 | |1;ext.html;516.4009748691517;517.5290485658052;529.4811085136566;529.8092686632814;530.2602868997748;30639.38721225574;32708.345833083324;41252.79373603128;41307.58692413075;42073.15853682924;42489.57510424895;42957.57042429575;43000;43044.354334685006;43157.136857262834;9742.805143897118;9894.208463322917;9913.008699130065;9927.205823534136;9931.702048938543;9647.131758141766;9783.02169783023;9785;9803.460809655466;9805.313628046004;9715.805683886318;9742.22062235023;9774.90225097747;9786.657466988658;9804.607815687365;9737;9745.756356091084;9751.17115045222;9780.413175209475;9812.264080193978;9709.223262139012;9789.755256118582;9793.21654267657;9795.118439340422;9808.215342772632;40514.79742601298;40543.39184912229;40680.38979415311;40886;41018.76943691694;3321.136504508821;3395.049386171876;3497.300539892032;3529.7882127072203;3652.7625704329134;30626.84686576553;30860.691393086232;30960;30984.8450757747;31957.360852783047;3171.4132885416043;3235.078002769223;3250.382427338798;3250.983745081283;3345.180430794471;497960;503634;504711;505757;505955;56898;57145.428545714014;57207;57341;57373.42626573681;60659.696701517096;61438;61540;61551.38448615546;61713.691431543455;15653;15865.20673966297;15934.964227325187;15969;16006.839931600767;12435.06736994711;12447.315397653036;12552.435140418704;12584.874151258553;12624.368781560885;13053.869461305456;15878.761818572731;16234;16239.918800405922;16267.837321626868;5871.32479764824;6833.4191593715095;6858;6913.723451061901;7005.124359455068;869.4001139213922;890.6526454682679;965.8551217317319;1019.8419245017034;1035.30634474902;29170;29229.123126306244;29693.703062969525;29920.004752193006;30121.246968825955;910.2126660438673;1057.281048886749;1111.2665640677114;1160.5879912630894;1182.408795602199;14797.704045919021;15302.311395987208;15379.154146522049;15541.84458155404;15619.191133097607;641414;648228;649610;654329.6536277087;654927;56838.7158064207;57063;57129.42870571241;57153;57192.42807571871;1107.9446027698582;1304.804279358104;1338.5649663859285;1372.4373007067254;1374.4845682868925;24142.758572414754;28492.287692807844;28821.991230306838;29413.85293073521;29499.55750663699;39888.80055599703;42076;49548.50451495583;50105.747356314925;50834.745826270635;543672;570588;582627;584293;588727;39761.00597485086;40247;40416.3937540943;40482.595174047885;40745.98135046648;45737;45744;46845.59463216109;47240.29139562978;47252.29121563111;38382;38789.80605097069;38790.22419551649;39256;39324;37792.62207377891;37846;37966.43050354302;38736.80631596824;39111.217775644895;36570.8171459141;36955.70655027061;36973;37213;37991.81004094962;30831.845840770653;32796.34407311888;33758.662413376536;34502.65497344994;34701.13247168841;21124.894375528023;24822.50354992854;24864.37839054038;25093;25383.98464061417 14:15:04 INFO - PROCESS | 1947 | |2;jquery.html;311.86589766400436;369.9926001479969;373.26280595823255;378.9981050094749;398.36858579152045;15632.2965466554;19092.809071909276;19491.902540487295;20324.069213424737;20713.585728285427;20163;20408.897955510238;20420.795792042114;20463.795362046374;20924.790752092475;5772.740226689788;5792.102224155263;5981.551383646222;6088.45203931646;6095.268567771852;5080.949190508103;5817.941820581782;5908.409159084079;5988.2215312009375;5992.7303271352675;5678.403767604404;5907.970460147693;5951.702414879261;5957;5964.612300200495;5885.470307672309;5929.051351783715;5943.64338139713;5950.851228719273;5962.075878238858;5092.567131793802;5178.844634660929;5192.844214673566;5396.622236443451;5417.295751552273;12815;13099;13144.014198935023;14602.415903363853;23906;2092.801183887528;2230.60964331243;2292.701948746669;2414.8913298901593;2945.3520225550346;9989.90010099897;10179.949100254526;10937.906209379078;13947;13985.692360760462;1434.0176978769575;1817.5456135966008;1821.1986725840588;1857.4984754116313;1920.2894928876265;112117;114529;114650;118072;118986.81013189844;9096.545172741337;10784.411741182217;11101.722456938642;11132;11199.776004480027;14039.157650540796;14067.788983165261;14155.29223538819;14198;14233.64415889611;8258.628361723737;8377.120402357787;8413.505759984851;8432.45189062709;8488.278496327881;7858;8355.331573474228;8406.117357677478;8463.322934165375;8545;3891.669208117285;4011.398290256485;4321.9135617287475;4571.611413029929;4587.197240482902;1615.7980252468442;1630.1823466834394;1657.1962598139892;1784.97322540162;1909.0931807391378;797.4736673795384;892.7009451833578;927.4713413354458;965.464167387107;968.2302569457298;20290.898545507473;21015.8949205253;21137.471563211042;21293.041813118445;21337.67993480099;919.7332773495746;920.3879420185501;922.9947370503638;933.5518950903604;947.4410098042188;10821.67534973952;11208.15938804593;11259.042981346514;11261.43692815356;11372.20394572372;574208;578041;581495;585001;592566;122128;122377;125008.74991250153;127984;128047;939.2251392601131;941.8634298026885;956.1920177450044;962.9807403851884;963.7060696487498;18502.98233597111;18757.90621046886;18782.71825922585;18871.433856984313;18885.811141888957;42239.155216896106;51111.48888511067;53756.46243537514;54182;54735.178972316244;76791.46417071739;77222.61388693245;77442;77644.22355776596;78319;7662.6934922604705;7684.961575192312;7922.168172342052;7982.481138725964;8169.632366543638;8954.507502087448;11987.64037078889;12369.62891113268;12702.174358666656;12856.871431285568;10535.63125290611;10624.52189651483;10749.86708008492;10798.892011079788;10978.670639880816;9390.95304523473;10416.375017498975;10494.68515944523;10693.572257109628;11088.611898583511;8724.65101395937;10768.300060496043;11004.779904402027;11022.173336999918;11112.888871111185;7778.88331675014;7959.442839001446;7975.202479751978;8078.434509584507;8084.110747817617;9403.508771929824;9405.20055795265;10615.522301496298;10979.725506862393;11027.944860275647 14:15:04 INFO - PROCESS | 1947 | |3;mootools.html;1465.9267036648166;1498.4830233569419;1698.1763844535399;1804.0077957123578;1821.04395192524;6666.433353164987;8019.679212831487;8177.386695997794;9177.632894684204;9190.21883139933;7596.316331530161;8613.095624959384;8945.418547794405;8954.641814327435;9022.96235932868;2126.766055733868;2283.6232021716396;2325.4883925536396;2343.6015877300815;2352.0356653771955;2013.2450331125829;2124.3733098735834;2170.1644866726347;2349.3186975777003;2369.514249578841;2011.768646605637;2334.3463830127594;2346.038124369009;2350.17743789674;2357.8467399619058;2038.5311378382908;2259.6271615183473;2315.0045480443405;2327;2331.3122628824453;2242.9102835886547;2291.117919600949;2293.6559516072557;2294.4034551016857;2298.321995011476;8747.125287471203;8783.38516303859;8803.339749518811;8807.955960220223;8822;5280.735963201863;5388.164834450667;5436.075867102602;5444.945550544483;5447.400785913546;3432.4164891968176;3529.0647978285774;3631.800250986195;3642.3261696586214;3657.030886814996;825.5211977053294;930.7393929699628;1076.6554702495205;1098.1544210957597;1098.730810951314;9865.408075515421;11340.376279304635;11570.652880413601;11748.647540573711;11968.940155299255;4451.465824101064;4513.50351461339;4613.95386046142;4622.907541849144;4654.301854721751;9265.861012084824;9278.95360523193;9366.859497107549;9378.48418336998;9378.765530861647;5233.607479439057;5273.683578985273;5290.682559046392;5299.2316114164005;5307.416184219733;3758.285925674113;4405.845795397146;4882.096812089775;4893.828715994923;4912.754362281943;3743.7192210584317;3766.2090960898518;3836.558795738526;3861.4593956846065;3870.59358767331;1123.8482804821408;1144.0961640304067;1154.0940361815933;1158.5365853658436;1168.8831116888243;871.7123349294718;881.378628067211;894.1237587164616;905.4889690021289;919.9034101419388;5644.604877658525;5671.716414179275;5986.46121849027;6028.125921741323;6090.056041313604;417.07617626956437;423.7478700173392;426.6927811975373;432.5479873532166;434.27476114888213;3865.4588357629955;4007.1584967157223;4064.3700226464944;4134.37984302357;4207.158568286355;10895.564177432972;10981.505832237568;11096.500657470433;11130.666080017612;11172.994430501294;9860.506974651238;10840.078593319498;10903.400312982862;11065.114790816715;11084.944575277072;8135.7152499662225;8190.959045204736;8343.290820280345;8383.035950865607;8408.495490270603;5818.301803783404;5994.100884867305;6002.249718785152;6098.481629061579;6141;8275.420720549504;9691.515424228619;10037.247206459691;10130.493475326057;10298.845517317097;10098.343607665773;10170.135538479311;10314.793704125725;10335.586576536854;10338.896611033793;6290.308066112632;7634.4655874088285;7658.310752032344;7738.032745906762;7757.185495522889;8310.418270720991;8395.538245396318;8472.856164417972;8478.448900821428;8485.40602157843;6581.2102547694585;7536.585487798224;7645.808854778675;7650.540967541965;7786.805329866798;7385.483016188815;7424.331810137113;7457.216992215956;7476.887846682195;7573.962130189314;7041.084658994298;7109.964450177716;7141.392981596415;7184.317489838457;7193.460490463341;4647.837325693585;4721.055788842176;4928;5136.0241554104605;5146.50751282124;4570.497245302948;4726.1020406122725;4979.452260251297;5014.247862820606;5226.033183860998 14:15:04 INFO - PROCESS | 1947 | |4;prototype.html;295.4843797573235;303.65231809578034;309.98915037973677;315.605493133583;318.09184777460365;4288.421063156473;5006.499350064992;5116.718580478072;5195.350581177353;5329.747509335303;4466.91066178677;5019.899602007967;5288.920666190001;5306.946930530694;5322.201669749539;3302;3445.810480423576;3652.689521390685;3713.275911197318;3909.2767837949928;4004.8998775030714;4012.638862502374;4056.559921227966;4056.837726490937;4101.2207680540605;4060.3706425504092;4062.6343629073376;4069.2268468990947;4073.348264277716;4113.9177216455655;3892.260470510594;4025.798710064485;4081;4098.631123198911;4108.671306295504;3077.461444247248;3529.823508824574;3533.3463309287863;3562.6437356264423;3564.9821750891338;5168.302279192299;5170.1727723564045;5206.817761378334;5228.163493840967;5257.8159764408065;3358.9160270993175;4616.422947131608;4627.467841198271;4653.348531205634;4683.414573178353;4933.481984391659;5561.332640083176;5571.022287088066;5658.773649054033;5669.206311116447;3820.732548721591;3829.5787463379006;3834.9262206582202;3844.884653460401;3895.02624343914;4748.9525104748855;5030.471800460936;5993.321869876441;6011.879762404771;6025.427584379477;3797.5632802227547;3855.614438556122;3872.8644497442456;3894.7468414552964;3906.160175562211;3498.212902097008;3944.3294639911283;3956.208758248362;3963.5441924178513;3964.484616999829;4608.308753686973;4612.7462989535225;4621.653375996813;4627.329037289574;4629.606483448944;5327.360716713942;5372.650777699437;5679.829605111853;5727.4845263926445;5765.740541675635;1326.2506683723666;1345.5425155447194;1353.708952575201;1355.4849157320155;1356.6947436826833;737.7167666073494;794.8330850521339;799.3245707377373;829;835.1314632781961;3922.843086276574;4400.251957167289;4479.193745125908;4569.565891240327;5151.484851514819;4928.950710492921;5306.7611957462;5488.313960754906;5809.854753631109;5840.948629246776;5145.331106956071;5329.401179646091;5429.6199266051;5431;5436.320459942507;2990.5813186153955;3053.648830384534;3058.1742929408933;3058.608333208385;3077.276839942612;5551.9722401387735;5938.2280303560265;6112;6121.296050954108;6178.907316390258;4658.571539236186;5386.037679276383;5740.024195886709;5835.649861008268;5925.99258126111;5058.7976480941825;5436.565074794007;6127.958247098004;6131.846703832351;6141.969290153521;5499.807506737405;5834.716362400265;5849.795257165979;5861.648301101947;5884.529237661062;5003.773320872177;5459.972700136633;5610.831675049755;5636.098224284095;5752.942470575241;5473.863153421196;5702.973464776214;6037.486813620716;6103.938960610337;6113.755449781959;3257.990023092849;3493.615702272799;3831.4061320495366;3930.4497370368745;4000.0199951012187;5589.916151257653;5752;5773.971130144322;5797.5361971041375;5800.303963524404;5129.794808207779;5623;5625.184348269559;5635.774569017357;5677.943220567741;4821.5178482152905;5244.160934250502;5585.748641311069;5598.272224610938;5647.181158731879;4364.254298280586;4545.613552884762;4816.95183048165;5240.292560504283;5500.559955203494;4804.927926081042;5163.638545301943;5342.866428339323;5572.86067848307;5608.373571664171;4702.553257440538;4767.928481072856;5101.724568857786;5193.454687257784;5520.972395137998 14:15:04 INFO - PROCESS | 1947 | |5;yui.html;708.914930208375;729.6169511006717;778.3189709004621;789.9447038707293;811.3711873298193;12474.563390281342;15859.920700396511;15948;15969.201539923015;16018;14399.78400323996;14553.854461455383;14629.341679624416;14629.78055329171;14680.926595367035;666.8366250268691;702.3819039245457;816.2205094135087;826.9297109745664;850.3154960256991;867.7700409391516;869.2958703450194;869.647792643977;870.1342164546286;871.860502319629;918.5682729117337;918.9678361257357;919.5586118663045;919.6091661044063;920.9631614735436;904.3353135445442;917.2570218123275;917.7751450894574;919.56320747645;920.3741455810047;674.1068084787676;674.2414783368711;675.2605896543278;676.1041619853713;678.047343482408;13408.664783380396;14514.491992780308;14789.704205915821;14825.332860021217;14830.110193388324;13630.659233519142;14601.415943362254;14660.120392776467;14664.706705865823;14701.26493675312;10036.698899032968;11695.1228657851;11807.468663910058;11862.881371186264;11868.406579670982;3795.4686343911876;3808.9428658570146;3823;3932.8623498177426;4008.5390180129366;87864.5606771962;94007.35623934661;99758;117509;117602.41198794037;10031.448270345201;11180.273282236629;11205.225933397078;11255.831162532568;11332.093432525378;21643;21777.782222177575;21831.235906743506;21848.235311764012;21873.890630546746;7073.929260707327;7266.92733072673;7908.288254057163;7945.364370850318;7951.761447156595;3652.817359132033;4302.182585308844;4341.435613370241;4410.642620026717;4468.128714900628;3621.402468592705;3670.79810610419;3721.4417837324618;3771.057235691077;3771.75483593571;670.289493137276;681.6557638392679;690.5649440852231;704.9083619129481;707.939825114871;604.9957071261684;668.9866202675919;675.4596322941627;680.5576375356059;698.0785363320368;8533.701320453754;8949.373543851867;9331.0202428744;9396.295277854188;9845.852312215322;561.8117930493249;580.7676929228257;626.9874602507924;650.5283669339785;675.625028109404;3829.7319187656594;4240.194363071068;4506;4587.38070360497;4589;99501.00498994917;124407.37796310961;157472;164037.17981410018;167023;102030.48984755029;103332.48333758433;120367;120381.39809300897;142983.83750518685;72756.9086463714;104015;106372.9362706363;107850;108781;8534.530600816766;9850.113489785954;9943.651972180938;9954.253430992849;10033.849492257476;56797;57172.428275718376;57897.552561186305;57971.42028579829;58768.11847822201;82226.58886705528;88460;89938.55030724805;90070.54964725135;91465.54267228622;10880.347179169275;12896.871031289567;13030.153040052366;13230.933845330712;13610.86389136096;12416.627501174979;12740.18400155912;14322.427102915766;14476.927615361856;14662.193579353238;13715.519956801463;13719.382627781973;13817;13892.374843132286;14353.497627582985;10211.591536338463;12398.62804115878;12573.685657858261;13912.234827084607;14528.709425811636;11477.713057173303;11797.410129493319;13497.392617332047;13683.24742139192;13753.79369309441;10878.292910960763;11009.944950275198;11029.944850275697;11594.246373985665;11608.30350178992;8861.379703420698;10383.636572719919;10942.945285273523;11285.21003529745;11590.768184636428 14:15:04 INFO - PROCESS | 1947 | __end_tp_report 14:15:04 INFO - PROCESS | 1947 | __start_cc_report 14:15:04 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,361 14:15:04 INFO - PROCESS | 1947 | __end_cc_report 14:15:04 INFO - PROCESS | 1947 | __startTimestamp1477516504657__endTimestamp 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | ------- Summary: start ------- 14:15:04 INFO - PROCESS | 1947 | Number of tests: 6 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5479.02 Median:5662.29 stddev:686.78 (12.1%) stddev-sans-first:661.44 14:15:04 INFO - PROCESS | 1947 | Values: 3028.6 3237.3 3302.7 3310.2 3322.6 5337.4 5413.3 5424.9 5429.4 5468.1 5410.1 5422.8 5427.6 5514.1 5568.4 4989.4 5002.4 5044.5 5112.5 5121.0 4326.4 4715.0 5063.9 5103.1 5198.1 4215.0 4349.2 4535.8 4584.5 4966.4 4092.0 4416.8 4958.2 5032.2 5084.7 4497.9 4986.6 5039.2 5078.3 5099.7 4253.6 5250.4 5412.7 5578.7 5613.9 5779.0 5910.5 5926.4 5997.6 6008.4 5975.4 6069.2 6097.4 6111.9 6116.9 5423.6 5486.9 5500.9 5568.7 5569.2 6054.8 6202.9 6222.4 6246.1 6256.1 5883.6 5899.6 5900.2 5907.9 5961.8 5792.4 5911.2 6075.5 6075.9 6099.0 5932.6 5964.0 5988.8 6024.7 6061.2 5904.7 5952.3 5971.0 5978.8 5993.7 4612.8 4694.7 4702.3 4752.4 4754.0 4192.5 4241.1 4253.6 4261.6 4314.2 5476.6 5577.9 5578.2 5579.6 5613.0 5802.5 6069.6 6077.2 6085.5 6097.4 5435.8 5472.6 5490.7 5566.4 5626.8 5177.8 5190.6 5199.6 5211.6 5217.8 6173.8 6257.9 6270.3 6271.1 6278.6 5749.6 5927.4 5936.5 6001.2 6054.3 6250.1 6252.8 6253.6 6255.3 6263.0 5716.6 5830.4 5922.8 5936.6 5992.5 5887.6 5985.4 5986.3 6055.0 6108.8 4630.0 5813.7 5825.8 5844.6 5850.2 5540.7 5853.2 5871.5 5874.1 5878.1 5567.3 5573.0 5633.3 5692.3 5799.1 5879.2 5887.1 5903.3 5905.9 5917.4 4154.8 5015.8 5662.3 5676.5 5702.2 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:70660.95 Median:40713.19 stddev:154728.60 (380.0%) stddev-sans-first:155073.02 14:15:04 INFO - PROCESS | 1947 | Values: 516.4 517.5 529.5 529.8 530.3 30639.4 32708.3 41252.8 41307.6 42073.2 42489.6 42957.6 43000.0 43044.4 43157.1 9742.8 9894.2 9913.0 9927.2 9931.7 9647.1 9783.0 9785.0 9803.5 9805.3 9715.8 9742.2 9774.9 9786.7 9804.6 9737.0 9745.8 9751.2 9780.4 9812.3 9709.2 9789.8 9793.2 9795.1 9808.2 40514.8 40543.4 40680.4 40886.0 41018.8 3321.1 3395.0 3497.3 3529.8 3652.8 30626.8 30860.7 30960.0 30984.8 31957.4 3171.4 3235.1 3250.4 3251.0 3345.2 497960.0 503634.0 504711.0 505757.0 505955.0 56898.0 57145.4 57207.0 57341.0 57373.4 60659.7 61438.0 61540.0 61551.4 61713.7 15653.0 15865.2 15935.0 15969.0 16006.8 12435.1 12447.3 12552.4 12584.9 12624.4 13053.9 15878.8 16234.0 16239.9 16267.8 5871.3 6833.4 6858.0 6913.7 7005.1 869.4 890.7 965.9 1019.8 1035.3 29170.0 29229.1 29693.7 29920.0 30121.2 910.2 1057.3 1111.3 1160.6 1182.4 14797.7 15302.3 15379.2 15541.8 15619.2 641414.0 648228.0 649610.0 654329.7 654927.0 56838.7 57063.0 57129.4 57153.0 57192.4 1107.9 1304.8 1338.6 1372.4 1374.5 24142.8 28492.3 28822.0 29413.9 29499.6 39888.8 42076.0 49548.5 50105.7 50834.7 543672.0 570588.0 582627.0 584293.0 588727.0 39761.0 40247.0 40416.4 40482.6 40746.0 45737.0 45744.0 46845.6 47240.3 47252.3 38382.0 38789.8 38790.2 39256.0 39324.0 37792.6 37846.0 37966.4 38736.8 39111.2 36570.8 36955.7 36973.0 37213.0 37991.8 30831.8 32796.3 33758.7 34502.7 34701.1 21124.9 24822.5 24864.4 25093.0 25384.0 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:33965.74 Median:376.13 stddev:97266.67 (25859.8%) stddev-sans-first:97506.70 14:15:04 INFO - PROCESS | 1947 | Values: 311.9 370.0 373.3 379.0 398.4 15632.3 19092.8 19491.9 20324.1 20713.6 20163.0 20408.9 20420.8 20463.8 20924.8 5772.7 5792.1 5981.6 6088.5 6095.3 5080.9 5817.9 5908.4 5988.2 5992.7 5678.4 5908.0 5951.7 5957.0 5964.6 5885.5 5929.1 5943.6 5950.9 5962.1 5092.6 5178.8 5192.8 5396.6 5417.3 12815.0 13099.0 13144.0 14602.4 23906.0 2092.8 2230.6 2292.7 2414.9 2945.4 9989.9 10179.9 10937.9 13947.0 13985.7 1434.0 1817.5 1821.2 1857.5 1920.3 112117.0 114529.0 114650.0 118072.0 118986.8 9096.5 10784.4 11101.7 11132.0 11199.8 14039.2 14067.8 14155.3 14198.0 14233.6 8258.6 8377.1 8413.5 8432.5 8488.3 7858.0 8355.3 8406.1 8463.3 8545.0 3891.7 4011.4 4321.9 4571.6 4587.2 1615.8 1630.2 1657.2 1785.0 1909.1 797.5 892.7 927.5 965.5 968.2 20290.9 21015.9 21137.5 21293.0 21337.7 919.7 920.4 923.0 933.6 947.4 10821.7 11208.2 11259.0 11261.4 11372.2 574208.0 578041.0 581495.0 585001.0 592566.0 122128.0 122377.0 125008.7 127984.0 128047.0 939.2 941.9 956.2 963.0 963.7 18503.0 18757.9 18782.7 18871.4 18885.8 42239.2 51111.5 53756.5 54182.0 54735.2 76791.5 77222.6 77442.0 77644.2 78319.0 7662.7 7685.0 7922.2 7982.5 8169.6 8954.5 11987.6 12369.6 12702.2 12856.9 10535.6 10624.5 10749.9 10798.9 10978.7 9391.0 10416.4 10494.7 10693.6 11088.6 8724.7 10768.3 11004.8 11022.2 11112.9 7778.9 7959.4 7975.2 8078.4 8084.1 9403.5 9405.2 10615.5 10979.7 11027.9 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5656.89 Median:4887.96 stddev:3226.58 (66.0%) stddev-sans-first:3220.26 14:15:04 INFO - PROCESS | 1947 | Values: 1465.9 1498.5 1698.2 1804.0 1821.0 6666.4 8019.7 8177.4 9177.6 9190.2 7596.3 8613.1 8945.4 8954.6 9023.0 2126.8 2283.6 2325.5 2343.6 2352.0 2013.2 2124.4 2170.2 2349.3 2369.5 2011.8 2334.3 2346.0 2350.2 2357.8 2038.5 2259.6 2315.0 2327.0 2331.3 2242.9 2291.1 2293.7 2294.4 2298.3 8747.1 8783.4 8803.3 8808.0 8822.0 5280.7 5388.2 5436.1 5444.9 5447.4 3432.4 3529.1 3631.8 3642.3 3657.0 825.5 930.7 1076.7 1098.2 1098.7 9865.4 11340.4 11570.7 11748.6 11968.9 4451.5 4513.5 4614.0 4622.9 4654.3 9265.9 9279.0 9366.9 9378.5 9378.8 5233.6 5273.7 5290.7 5299.2 5307.4 3758.3 4405.8 4882.1 4893.8 4912.8 3743.7 3766.2 3836.6 3861.5 3870.6 1123.8 1144.1 1154.1 1158.5 1168.9 871.7 881.4 894.1 905.5 919.9 5644.6 5671.7 5986.5 6028.1 6090.1 417.1 423.7 426.7 432.5 434.3 3865.5 4007.2 4064.4 4134.4 4207.2 10895.6 10981.5 11096.5 11130.7 11173.0 9860.5 10840.1 10903.4 11065.1 11084.9 8135.7 8191.0 8343.3 8383.0 8408.5 5818.3 5994.1 6002.2 6098.5 6141.0 8275.4 9691.5 10037.2 10130.5 10298.8 10098.3 10170.1 10314.8 10335.6 10338.9 6290.3 7634.5 7658.3 7738.0 7757.2 8310.4 8395.5 8472.9 8478.4 8485.4 6581.2 7536.6 7645.8 7650.5 7786.8 7385.5 7424.3 7457.2 7476.9 7574.0 7041.1 7110.0 7141.4 7184.3 7193.5 4647.8 4721.1 4928.0 5136.0 5146.5 4570.5 4726.1 4979.5 5014.2 5226.0 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4516.09 Median:5044.63 stddev:1399.67 (27.7%) stddev-sans-first:1367.28 14:15:04 INFO - PROCESS | 1947 | Values: 295.5 303.7 310.0 315.6 318.1 4288.4 5006.5 5116.7 5195.4 5329.7 4466.9 5019.9 5288.9 5306.9 5322.2 3302.0 3445.8 3652.7 3713.3 3909.3 4004.9 4012.6 4056.6 4056.8 4101.2 4060.4 4062.6 4069.2 4073.3 4113.9 3892.3 4025.8 4081.0 4098.6 4108.7 3077.5 3529.8 3533.3 3562.6 3565.0 5168.3 5170.2 5206.8 5228.2 5257.8 3358.9 4616.4 4627.5 4653.3 4683.4 4933.5 5561.3 5571.0 5658.8 5669.2 3820.7 3829.6 3834.9 3844.9 3895.0 4749.0 5030.5 5993.3 6011.9 6025.4 3797.6 3855.6 3872.9 3894.7 3906.2 3498.2 3944.3 3956.2 3963.5 3964.5 4608.3 4612.7 4621.7 4627.3 4629.6 5327.4 5372.7 5679.8 5727.5 5765.7 1326.3 1345.5 1353.7 1355.5 1356.7 737.7 794.8 799.3 829.0 835.1 3922.8 4400.3 4479.2 4569.6 5151.5 4929.0 5306.8 5488.3 5809.9 5840.9 5145.3 5329.4 5429.6 5431.0 5436.3 2990.6 3053.6 3058.2 3058.6 3077.3 5552.0 5938.2 6112.0 6121.3 6178.9 4658.6 5386.0 5740.0 5835.6 5926.0 5058.8 5436.6 6128.0 6131.8 6142.0 5499.8 5834.7 5849.8 5861.6 5884.5 5003.8 5460.0 5610.8 5636.1 5752.9 5473.9 5703.0 6037.5 6103.9 6113.8 3258.0 3493.6 3831.4 3930.4 4000.0 5589.9 5752.0 5774.0 5797.5 5800.3 5129.8 5623.0 5625.2 5635.8 5677.9 4821.5 5244.2 5585.7 5598.3 5647.2 4364.3 4545.6 4817.0 5240.3 5500.6 4804.9 5163.6 5342.9 5572.9 5608.4 4702.6 4767.9 5101.7 5193.5 5521.0 14:15:04 INFO - PROCESS | 1947 | 14:15:04 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:23613.78 Median:3783.61 stddev:37451.27 (989.8%) stddev-sans-first:37516.84 14:15:04 INFO - PROCESS | 1947 | Values: 708.9 729.6 778.3 789.9 811.4 12474.6 15859.9 15948.0 15969.2 16018.0 14399.8 14553.9 14629.3 14629.8 14680.9 666.8 702.4 816.2 826.9 850.3 867.8 869.3 869.6 870.1 871.9 918.6 919.0 919.6 919.6 921.0 904.3 917.3 917.8 919.6 920.4 674.1 674.2 675.3 676.1 678.0 13408.7 14514.5 14789.7 14825.3 14830.1 13630.7 14601.4 14660.1 14664.7 14701.3 10036.7 11695.1 11807.5 11862.9 11868.4 3795.5 3808.9 3823.0 3932.9 4008.5 87864.6 94007.4 99758.0 117509.0 117602.4 10031.4 11180.3 11205.2 11255.8 11332.1 21643.0 21777.8 21831.2 21848.2 21873.9 7073.9 7266.9 7908.3 7945.4 7951.8 3652.8 4302.2 4341.4 4410.6 4468.1 3621.4 3670.8 3721.4 3771.1 3771.8 670.3 681.7 690.6 704.9 707.9 605.0 669.0 675.5 680.6 698.1 8533.7 8949.4 9331.0 9396.3 9845.9 561.8 580.8 627.0 650.5 675.6 3829.7 4240.2 4506.0 4587.4 4589.0 99501.0 124407.4 157472.0 164037.2 167023.0 102030.5 103332.5 120367.0 120381.4 142983.8 72756.9 104015.0 106372.9 107850.0 108781.0 8534.5 9850.1 9943.7 9954.3 10033.8 56797.0 57172.4 57897.6 57971.4 58768.1 82226.6 88460.0 89938.6 90070.5 91465.5 10880.3 12896.9 13030.2 13230.9 13610.9 12416.6 12740.2 14322.4 14476.9 14662.2 13715.5 13719.4 13817.0 13892.4 14353.5 10211.6 12398.6 12573.7 13912.2 14528.7 11477.7 11797.4 13497.4 13683.2 13753.8 10878.3 11009.9 11029.9 11594.2 11608.3 8861.4 10383.6 10942.9 11285.2 11590.8 14:15:04 INFO - PROCESS | 1947 | -------- Summary: end -------- 14:15:04 INFO - PROCESS | 1947 | 14:15:05 INFO - TEST-INFO | 1947: exit 0 14:15:05 INFO - TEST-OK | dromaeo_css | took 1114040ms 14:15:05 INFO - TEST-START | kraken 14:15:05 INFO - operating with platform_type : mac_ 14:15:05 INFO - Initialising browser for kraken test... 14:15:05 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp8Mss0a/profile http://localhost:56166/getInfo.html) 14:15:07 INFO - PROCESS | 1951 | 2016-10-26 14:15:07.926 plugin-container[1952:22746] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 14:15:07 INFO - PROCESS | 1951 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:07 INFO - PROCESS | 1951 | 2016-10-26 14:15:07.930 plugin-container[1952:22746] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:15:07 INFO - PROCESS | 1951 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:07 INFO - PROCESS | 1951 | 2016-10-26 14:15:07.930 plugin-container[1952:22746] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:08 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 14:15:08 INFO - PROCESS | 1951 | colorDepth:24 14:15:08 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 14:15:08 INFO - PROCESS | 1951 | __metrics 14:15:08 ERROR - PROCESS | 1951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:15:08 INFO - TEST-INFO | 1951: exit 0 14:15:08 INFO - Browser initialized. 14:15:08 INFO - Running cycle 1/1 for kraken test... 14:15:08 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp8Mss0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:11 INFO - PROCESS | 1953 | 2016-10-26 14:15:11.316 plugin-container[1954:22860] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 14:15:11 INFO - PROCESS | 1953 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:11 INFO - PROCESS | 1953 | 2016-10-26 14:15:11.316 plugin-container[1954:22860] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:15:11 INFO - PROCESS | 1953 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:11 INFO - PROCESS | 1953 | 2016-10-26 14:15:11.316 plugin-container[1954:22860] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:20 INFO - PROCESS | 1953 | RSS: Main: 239017984 14:15:20 INFO - PROCESS | 1953 | 14:15:23 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56166/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:24 INFO - PROCESS | 1953 | RSS: Main: 252350464 14:15:24 INFO - PROCESS | 1953 | 14:15:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56166/tests/kraken/driver.html?testName=audio-dft) 14:15:27 INFO - PROCESS | 1953 | RSS: Main: 260681728 14:15:27 INFO - PROCESS | 1953 | 14:15:31 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56166/tests/kraken/driver.html?testName=audio-fft) 14:15:32 INFO - PROCESS | 1953 | RSS: Main: 261611520 14:15:32 INFO - PROCESS | 1953 | 14:15:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56166/tests/kraken/driver.html?testName=audio-oscillator) 14:15:34 INFO - PROCESS | 1953 | RSS: Main: 263364608 14:15:34 INFO - PROCESS | 1953 | 14:15:36 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:37 INFO - PROCESS | 1953 | RSS: Main: 264323072 14:15:37 INFO - PROCESS | 1953 | 14:15:40 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56166/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:41 INFO - PROCESS | 1953 | RSS: Main: 264200192 14:15:41 INFO - PROCESS | 1953 | 14:15:44 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56166/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:44 INFO - PROCESS | 1953 | RSS: Main: 264482816 14:15:44 INFO - PROCESS | 1953 | 14:15:47 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56166/tests/kraken/driver.html?testName=json-parse-financial) 14:15:48 INFO - PROCESS | 1953 | RSS: Main: 264384512 14:15:48 INFO - PROCESS | 1953 | 14:15:50 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:50 INFO - PROCESS | 1953 | RSS: Main: 264269824 14:15:50 INFO - PROCESS | 1953 | 14:15:52 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:15:53 INFO - PROCESS | 1953 | RSS: Main: 264314880 14:15:53 INFO - PROCESS | 1953 | 14:15:55 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:15:56 INFO - PROCESS | 1953 | RSS: Main: 264433664 14:15:56 INFO - PROCESS | 1953 | 14:15:59 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:15:59 INFO - PROCESS | 1953 | RSS: Main: 264695808 14:15:59 INFO - PROCESS | 1953 | 14:16:02 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:03 INFO - PROCESS | 1953 | RSS: Main: 264544256 14:16:03 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:56166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56166/tests/kraken/driver.html?testName=ai-astar) 14:16:05 INFO - PROCESS | 1953 | RSS: Main: 266039296 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | __start_tp_report 14:16:05 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 14:16:05 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 14:16:05 INFO - PROCESS | 1953 | |i|pagename|runs| 14:16:05 INFO - PROCESS | 1953 | |0;ai-astar;118;118;117;117;118;143;174;120;117;119 14:16:05 INFO - PROCESS | 1953 | |1;audio-beat-detection;150;118;116;154;115;139;147;123;154;119 14:16:05 INFO - PROCESS | 1953 | |2;audio-dft;206;205;261;262;275;211;194;195;196;196 14:16:05 INFO - PROCESS | 1953 | |3;audio-fft;86;82;84;78;74;84;87;86;82;61 14:16:05 INFO - PROCESS | 1953 | |4;audio-oscillator;86;71;95;103;82;71;89;71;72;89 14:16:05 INFO - PROCESS | 1953 | |5;imaging-gaussian-blur;80;127;92;89;92;75;136;131;97;87 14:16:05 INFO - PROCESS | 1953 | |6;imaging-darkroom;101;101;98;102;101;101;143;171;131;103 14:16:05 INFO - PROCESS | 1953 | |7;imaging-desaturate;97;85;153;154;93;115;157;91;92;92 14:16:05 INFO - PROCESS | 1953 | |8;json-parse-financial;57;58;56;57;58;59;60;85;57;59 14:16:05 INFO - PROCESS | 1953 | |9;json-stringify-tinderbox;74;68;81;79;75;71;85;66;72;73 14:16:05 INFO - PROCESS | 1953 | |10;stanford-crypto-aes;94;87;90;88;91;91;92;92;90;102 14:16:05 INFO - PROCESS | 1953 | |11;stanford-crypto-ccm;166;167;181;161;164;164;160;149;184;155 14:16:05 INFO - PROCESS | 1953 | |12;stanford-crypto-pbkdf2;180;177;180;181;180;178;178;176;180;180 14:16:05 INFO - PROCESS | 1953 | |13;stanford-crypto-sha256-iterative;71;70;71;71;70;69;71;69;70;70 14:16:05 INFO - PROCESS | 1953 | __end_tp_report 14:16:05 INFO - PROCESS | 1953 | __start_cc_report 14:16:05 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,934 14:16:05 INFO - PROCESS | 1953 | __end_cc_report 14:16:05 INFO - PROCESS | 1953 | __startTimestamp1477516565439__endTimestamp 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | ------- Summary: start ------- 14:16:05 INFO - PROCESS | 1953 | Number of tests: 14 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#0] ai-astar Cycles:10 Average:126.10 Median:118.50 stddev:18.60 (15.7%) stddev-sans-first:19.49 14:16:05 INFO - PROCESS | 1953 | Values: 118.0 118.0 117.0 117.0 118.0 143.0 174.0 120.0 117.0 119.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:143.00 stddev:16.78 (11.7%) stddev-sans-first:16.70 14:16:05 INFO - PROCESS | 1953 | Values: 150.0 118.0 116.0 154.0 115.0 139.0 147.0 123.0 154.0 119.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#2] audio-dft Cycles:10 Average:220.10 Median:208.50 stddev:32.36 (15.5%) stddev-sans-first:33.92 14:16:05 INFO - PROCESS | 1953 | Values: 206.0 205.0 261.0 262.0 275.0 211.0 194.0 195.0 196.0 196.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#3] audio-fft Cycles:10 Average:80.40 Median:84.00 stddev:7.89 (9.4%) stddev-sans-first:8.11 14:16:05 INFO - PROCESS | 1953 | Values: 86.0 82.0 84.0 78.0 74.0 84.0 87.0 86.0 82.0 61.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:84.00 stddev:11.45 (13.6%) stddev-sans-first:12.08 14:16:05 INFO - PROCESS | 1953 | Values: 86.0 71.0 95.0 103.0 82.0 71.0 89.0 71.0 72.0 89.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:88.00 stddev:22.20 (25.2%) stddev-sans-first:22.26 14:16:05 INFO - PROCESS | 1953 | Values: 80.0 127.0 92.0 89.0 92.0 75.0 136.0 131.0 97.0 87.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#6] imaging-darkroom Cycles:10 Average:115.20 Median:117.00 stddev:24.86 (21.2%) stddev-sans-first:25.83 14:16:05 INFO - PROCESS | 1953 | Values: 101.0 101.0 98.0 102.0 101.0 101.0 143.0 171.0 131.0 103.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#7] imaging-desaturate Cycles:10 Average:112.90 Median:91.50 stddev:29.86 (32.6%) stddev-sans-first:31.12 14:16:05 INFO - PROCESS | 1953 | Values: 97.0 85.0 153.0 154.0 93.0 115.0 157.0 91.0 92.0 92.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:58.50 stddev:8.66 (14.8%) stddev-sans-first:9.08 14:16:05 INFO - PROCESS | 1953 | Values: 57.0 58.0 56.0 57.0 58.0 59.0 60.0 85.0 57.0 59.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:74.50 stddev:5.85 (7.9%) stddev-sans-first:6.21 14:16:05 INFO - PROCESS | 1953 | Values: 74.0 68.0 81.0 79.0 75.0 71.0 85.0 66.0 72.0 73.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:91.00 stddev:4.14 (4.5%) stddev-sans-first:4.30 14:16:05 INFO - PROCESS | 1953 | Values: 94.0 87.0 90.0 88.0 91.0 91.0 92.0 92.0 90.0 102.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#11] stanford-crypto-ccm Cycles:10 Average:165.10 Median:165.00 stddev:10.65 (6.5%) stddev-sans-first:11.29 14:16:05 INFO - PROCESS | 1953 | Values: 166.0 167.0 181.0 161.0 164.0 164.0 160.0 149.0 184.0 155.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:180.00 stddev:1.63 (0.9%) stddev-sans-first:1.69 14:16:05 INFO - PROCESS | 1953 | Values: 180.0 177.0 180.0 181.0 180.0 178.0 178.0 176.0 180.0 180.0 14:16:05 INFO - PROCESS | 1953 | 14:16:05 INFO - PROCESS | 1953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:0.79 (1.1%) stddev-sans-first:0.78 14:16:05 INFO - PROCESS | 1953 | Values: 71.0 70.0 71.0 71.0 70.0 69.0 71.0 69.0 70.0 70.0 14:16:05 INFO - PROCESS | 1953 | -------- Summary: end -------- 14:16:05 INFO - PROCESS | 1953 | 14:16:06 INFO - TEST-INFO | 1953: exit 0 14:16:06 INFO - TEST-OK | kraken | took 60967ms 14:16:06 INFO - SUITE-END | took 1175s 14:16:06 INFO - Completed test suite (00:19:35) 14:16:06 INFO - javascript benchmark 14:16:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7195.106558853083, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.6062811834463, 3237.3201627658177, 3302.7357811375077, 3310.2220978070163, 3322.634510203878, 5337.439568845273, 5413.296271484706, 5424.8915021699595, 5429.429909859467, 5468.070428027235, 5410.134378499441, 5422.75597598108, 5427.565794736422, 5514.09017512111, 5568.3596386415575, 4989.376327959005, 5002.424721157059, 5044.545990860822, 5112.539871411572, 5121.0, 4326.43756311679, 4714.952850471503, 5063.898722025558, 5103.106956282654, 5198.064348417283, 4214.967333003434, 4349.195398851222, 4535.841245556389, 4584.541545845389, 4966.404031516223, 4091.9565510794855, 4416.845410410652, 4958.181899986498, 5032.194848824207, 5084.669496482717, 4497.887552811173, 4986.551210391046, 5039.21892106724, 5078.339815823956, 5099.745012749385, 4253.574642535753, 5250.422453530108, 5412.675239485643, 5578.693171875545, 5613.915791263134, 5778.988676981511, 5910.527157827363, 5926.436988486087, 5997.640141591519, 6008.369121242294, 5975.402459754033, 6069.180660610805, 6097.390260973867, 6111.908321375183, 6116.877662446771, 5423.566114710814, 5486.890262194734, 5500.889982200333, 5568.66588004717, 5569.192467092289, 6054.848628784315, 6202.906956395657, 6222.408871157233, 6246.094316324198, 6256.092866534418, 5883.558733094949, 5899.587028908021, 5900.232969713996, 5907.911381329283, 5961.821145365646, 5792.391798861143, 5911.201987731687, 6075.453209211192, 6075.936711075632, 6098.969505152446, 5932.644041357532, 5963.98612235921, 5988.760449581968, 6024.698765061729, 6061.212042434456, 5904.704764761745, 5952.285725712855, 5971.044632858721, 5978.8206353809455, 5993.730282137314, 4612.815487380534, 4694.718316900997, 4702.3416721659, 4752.405949256343, 4754.001659651442, 4192.45498085247, 4241.130568233505, 4253.617174454314, 4261.552536983634, 4314.158739045919, 5476.561875050066, 5577.860553486195, 5578.191162281447, 5579.609427340129, 5612.989661860905, 5802.535797136219, 6069.575129740964, 6077.17958075663, 6085.482733967662, 6097.420745029215, 5435.782568697208, 5472.589555783253, 5490.6980116094, 5566.415526369754, 5626.803061892896, 5177.8446646599905, 5190.584753219733, 5199.584033277329, 5211.5830733541225, 5217.843464696065, 6173.8456538586, 6257.8748425031245, 6270.310265870842, 6271.090691849657, 6278.623282602875, 5749.597528172988, 5927.436893495111, 5936.495397891227, 6001.2498437695285, 6054.33402325735, 6250.0937364082865, 6252.843678907881, 6253.593516421418, 6255.343188965275, 6263.029230469285, 5716.571257155813, 5830.416958304136, 5922.763089476372, 5936.614120082181, 5992.520598352208, 5887.61730487517, 5985.371535988658, 5986.281646202484, 6055.0, 6108.75564977396, 4630.0, 5813.709314534171, 5825.825225243249, 5844.620099693507, 5850.180974663465, 5540.722963851711, 5853.180554722428, 5871.500922421471, 5874.148248503858, 5878.147668588116, 5567.3040869891265, 5572.996860564975, 5633.295838020247, 5692.2600061993335, 5799.072148456226, 5879.176915231786, 5887.146363777143, 5903.321118071305, 5905.852353691021, 5917.408259174048, 4154.771487568213, 5015.774290156879, 5662.292213473316, 5676.545876329967, 5702.230198923092], "value": 5433.880558511478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4009748691517, 517.5290485658052, 529.4811085136566, 529.8092686632814, 530.2602868997748, 30639.38721225574, 32708.345833083324, 41252.79373603128, 41307.58692413075, 42073.15853682924, 42489.57510424895, 42957.57042429575, 43000.0, 43044.354334685006, 43157.136857262834, 9742.805143897118, 9894.208463322917, 9913.008699130065, 9927.205823534136, 9931.702048938543, 9647.131758141766, 9783.02169783023, 9785.0, 9803.460809655466, 9805.313628046004, 9715.805683886318, 9742.22062235023, 9774.90225097747, 9786.657466988658, 9804.607815687365, 9737.0, 9745.756356091084, 9751.17115045222, 9780.413175209475, 9812.264080193978, 9709.223262139012, 9789.755256118582, 9793.21654267657, 9795.118439340422, 9808.215342772632, 40514.79742601298, 40543.39184912229, 40680.38979415311, 40886.0, 41018.76943691694, 3321.136504508821, 3395.049386171876, 3497.300539892032, 3529.7882127072203, 3652.7625704329134, 30626.84686576553, 30860.691393086232, 30960.0, 30984.8450757747, 31957.360852783047, 3171.4132885416043, 3235.078002769223, 3250.382427338798, 3250.983745081283, 3345.180430794471, 497960.0, 503634.0, 504711.0, 505757.0, 505955.0, 56898.0, 57145.428545714014, 57207.0, 57341.0, 57373.42626573681, 60659.696701517096, 61438.0, 61540.0, 61551.38448615546, 61713.691431543455, 15653.0, 15865.20673966297, 15934.964227325187, 15969.0, 16006.839931600767, 12435.06736994711, 12447.315397653036, 12552.435140418704, 12584.874151258553, 12624.368781560885, 13053.869461305456, 15878.761818572731, 16234.0, 16239.918800405922, 16267.837321626868, 5871.32479764824, 6833.4191593715095, 6858.0, 6913.723451061901, 7005.124359455068, 869.4001139213922, 890.6526454682679, 965.8551217317319, 1019.8419245017034, 1035.30634474902, 29170.0, 29229.123126306244, 29693.703062969525, 29920.004752193006, 30121.246968825955, 910.2126660438673, 1057.281048886749, 1111.2665640677114, 1160.5879912630894, 1182.408795602199, 14797.704045919021, 15302.311395987208, 15379.154146522049, 15541.84458155404, 15619.191133097607, 641414.0, 648228.0, 649610.0, 654329.6536277087, 654927.0, 56838.7158064207, 57063.0, 57129.42870571241, 57153.0, 57192.42807571871, 1107.9446027698582, 1304.804279358104, 1338.5649663859285, 1372.4373007067254, 1374.4845682868925, 24142.758572414754, 28492.287692807844, 28821.991230306838, 29413.85293073521, 29499.55750663699, 39888.80055599703, 42076.0, 49548.50451495583, 50105.747356314925, 50834.745826270635, 543672.0, 570588.0, 582627.0, 584293.0, 588727.0, 39761.00597485086, 40247.0, 40416.3937540943, 40482.595174047885, 40745.98135046648, 45737.0, 45744.0, 46845.59463216109, 47240.29139562978, 47252.29121563111, 38382.0, 38789.80605097069, 38790.22419551649, 39256.0, 39324.0, 37792.62207377891, 37846.0, 37966.43050354302, 38736.80631596824, 39111.217775644895, 36570.8171459141, 36955.70655027061, 36973.0, 37213.0, 37991.81004094962, 30831.845840770653, 32796.34407311888, 33758.662413376536, 34502.65497344994, 34701.13247168841, 21124.894375528023, 24822.50354992854, 24864.37839054038, 25093.0, 25383.98464061417], "value": 19899.128750492935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.86589766400436, 369.9926001479969, 373.26280595823255, 378.9981050094749, 398.36858579152045, 15632.2965466554, 19092.809071909276, 19491.902540487295, 20324.069213424737, 20713.585728285427, 20163.0, 20408.897955510238, 20420.795792042114, 20463.795362046374, 20924.790752092475, 5772.740226689788, 5792.102224155263, 5981.551383646222, 6088.45203931646, 6095.268567771852, 5080.949190508103, 5817.941820581782, 5908.409159084079, 5988.2215312009375, 5992.7303271352675, 5678.403767604404, 5907.970460147693, 5951.702414879261, 5957.0, 5964.612300200495, 5885.470307672309, 5929.051351783715, 5943.64338139713, 5950.851228719273, 5962.075878238858, 5092.567131793802, 5178.844634660929, 5192.844214673566, 5396.622236443451, 5417.295751552273, 12815.0, 13099.0, 13144.014198935023, 14602.415903363853, 23906.0, 2092.801183887528, 2230.60964331243, 2292.701948746669, 2414.8913298901593, 2945.3520225550346, 9989.90010099897, 10179.949100254526, 10937.906209379078, 13947.0, 13985.692360760462, 1434.0176978769575, 1817.5456135966008, 1821.1986725840588, 1857.4984754116313, 1920.2894928876265, 112117.0, 114529.0, 114650.0, 118072.0, 118986.81013189844, 9096.545172741337, 10784.411741182217, 11101.722456938642, 11132.0, 11199.776004480027, 14039.157650540796, 14067.788983165261, 14155.29223538819, 14198.0, 14233.64415889611, 8258.628361723737, 8377.120402357787, 8413.505759984851, 8432.45189062709, 8488.278496327881, 7858.0, 8355.331573474228, 8406.117357677478, 8463.322934165375, 8545.0, 3891.669208117285, 4011.398290256485, 4321.9135617287475, 4571.611413029929, 4587.197240482902, 1615.7980252468442, 1630.1823466834394, 1657.1962598139892, 1784.97322540162, 1909.0931807391378, 797.4736673795384, 892.7009451833578, 927.4713413354458, 965.464167387107, 968.2302569457298, 20290.898545507473, 21015.8949205253, 21137.471563211042, 21293.041813118445, 21337.67993480099, 919.7332773495746, 920.3879420185501, 922.9947370503638, 933.5518950903604, 947.4410098042188, 10821.67534973952, 11208.15938804593, 11259.042981346514, 11261.43692815356, 11372.20394572372, 574208.0, 578041.0, 581495.0, 585001.0, 592566.0, 122128.0, 122377.0, 125008.74991250153, 127984.0, 128047.0, 939.2251392601131, 941.8634298026885, 956.1920177450044, 962.9807403851884, 963.7060696487498, 18502.98233597111, 18757.90621046886, 18782.71825922585, 18871.433856984313, 18885.811141888957, 42239.155216896106, 51111.48888511067, 53756.46243537514, 54182.0, 54735.178972316244, 76791.46417071739, 77222.61388693245, 77442.0, 77644.22355776596, 78319.0, 7662.6934922604705, 7684.961575192312, 7922.168172342052, 7982.481138725964, 8169.632366543638, 8954.507502087448, 11987.64037078889, 12369.62891113268, 12702.174358666656, 12856.871431285568, 10535.63125290611, 10624.52189651483, 10749.86708008492, 10798.892011079788, 10978.670639880816, 9390.95304523473, 10416.375017498975, 10494.68515944523, 10693.572257109628, 11088.611898583511, 8724.65101395937, 10768.300060496043, 11004.779904402027, 11022.173336999918, 11112.888871111185, 7778.88331675014, 7959.442839001446, 7975.202479751978, 8078.434509584507, 8084.110747817617, 9403.508771929824, 9405.20055795265, 10615.522301496298, 10979.725506862393, 11027.944860275647], "value": 9239.523362080856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.9267036648166, 1498.4830233569419, 1698.1763844535399, 1804.0077957123578, 1821.04395192524, 6666.433353164987, 8019.679212831487, 8177.386695997794, 9177.632894684204, 9190.21883139933, 7596.316331530161, 8613.095624959384, 8945.418547794405, 8954.641814327435, 9022.96235932868, 2126.766055733868, 2283.6232021716396, 2325.4883925536396, 2343.6015877300815, 2352.0356653771955, 2013.2450331125829, 2124.3733098735834, 2170.1644866726347, 2349.3186975777003, 2369.514249578841, 2011.768646605637, 2334.3463830127594, 2346.038124369009, 2350.17743789674, 2357.8467399619058, 2038.5311378382908, 2259.6271615183473, 2315.0045480443405, 2327.0, 2331.3122628824453, 2242.9102835886547, 2291.117919600949, 2293.6559516072557, 2294.4034551016857, 2298.321995011476, 8747.125287471203, 8783.38516303859, 8803.339749518811, 8807.955960220223, 8822.0, 5280.735963201863, 5388.164834450667, 5436.075867102602, 5444.945550544483, 5447.400785913546, 3432.4164891968176, 3529.0647978285774, 3631.800250986195, 3642.3261696586214, 3657.030886814996, 825.5211977053294, 930.7393929699628, 1076.6554702495205, 1098.1544210957597, 1098.730810951314, 9865.408075515421, 11340.376279304635, 11570.652880413601, 11748.647540573711, 11968.940155299255, 4451.465824101064, 4513.50351461339, 4613.95386046142, 4622.907541849144, 4654.301854721751, 9265.861012084824, 9278.95360523193, 9366.859497107549, 9378.48418336998, 9378.765530861647, 5233.607479439057, 5273.683578985273, 5290.682559046392, 5299.2316114164005, 5307.416184219733, 3758.285925674113, 4405.845795397146, 4882.096812089775, 4893.828715994923, 4912.754362281943, 3743.7192210584317, 3766.2090960898518, 3836.558795738526, 3861.4593956846065, 3870.59358767331, 1123.8482804821408, 1144.0961640304067, 1154.0940361815933, 1158.5365853658436, 1168.8831116888243, 871.7123349294718, 881.378628067211, 894.1237587164616, 905.4889690021289, 919.9034101419388, 5644.604877658525, 5671.716414179275, 5986.46121849027, 6028.125921741323, 6090.056041313604, 417.07617626956437, 423.7478700173392, 426.6927811975373, 432.5479873532166, 434.27476114888213, 3865.4588357629955, 4007.1584967157223, 4064.3700226464944, 4134.37984302357, 4207.158568286355, 10895.564177432972, 10981.505832237568, 11096.500657470433, 11130.666080017612, 11172.994430501294, 9860.506974651238, 10840.078593319498, 10903.400312982862, 11065.114790816715, 11084.944575277072, 8135.7152499662225, 8190.959045204736, 8343.290820280345, 8383.035950865607, 8408.495490270603, 5818.301803783404, 5994.100884867305, 6002.249718785152, 6098.481629061579, 6141.0, 8275.420720549504, 9691.515424228619, 10037.247206459691, 10130.493475326057, 10298.845517317097, 10098.343607665773, 10170.135538479311, 10314.793704125725, 10335.586576536854, 10338.896611033793, 6290.308066112632, 7634.4655874088285, 7658.310752032344, 7738.032745906762, 7757.185495522889, 8310.418270720991, 8395.538245396318, 8472.856164417972, 8478.448900821428, 8485.40602157843, 6581.2102547694585, 7536.585487798224, 7645.808854778675, 7650.540967541965, 7786.805329866798, 7385.483016188815, 7424.331810137113, 7457.216992215956, 7476.887846682195, 7573.962130189314, 7041.084658994298, 7109.964450177716, 7141.392981596415, 7184.317489838457, 7193.460490463341, 4647.837325693585, 4721.055788842176, 4928.0, 5136.0241554104605, 5146.50751282124, 4570.497245302948, 4726.1020406122725, 4979.452260251297, 5014.247862820606, 5226.033183860998], "value": 4435.937190928039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4843797573235, 303.65231809578034, 309.98915037973677, 315.605493133583, 318.09184777460365, 4288.421063156473, 5006.499350064992, 5116.718580478072, 5195.350581177353, 5329.747509335303, 4466.91066178677, 5019.899602007967, 5288.920666190001, 5306.946930530694, 5322.201669749539, 3302.0, 3445.810480423576, 3652.689521390685, 3713.275911197318, 3909.2767837949928, 4004.8998775030714, 4012.638862502374, 4056.559921227966, 4056.837726490937, 4101.2207680540605, 4060.3706425504092, 4062.6343629073376, 4069.2268468990947, 4073.348264277716, 4113.9177216455655, 3892.260470510594, 4025.798710064485, 4081.0, 4098.631123198911, 4108.671306295504, 3077.461444247248, 3529.823508824574, 3533.3463309287863, 3562.6437356264423, 3564.9821750891338, 5168.302279192299, 5170.1727723564045, 5206.817761378334, 5228.163493840967, 5257.8159764408065, 3358.9160270993175, 4616.422947131608, 4627.467841198271, 4653.348531205634, 4683.414573178353, 4933.481984391659, 5561.332640083176, 5571.022287088066, 5658.773649054033, 5669.206311116447, 3820.732548721591, 3829.5787463379006, 3834.9262206582202, 3844.884653460401, 3895.02624343914, 4748.9525104748855, 5030.471800460936, 5993.321869876441, 6011.879762404771, 6025.427584379477, 3797.5632802227547, 3855.614438556122, 3872.8644497442456, 3894.7468414552964, 3906.160175562211, 3498.212902097008, 3944.3294639911283, 3956.208758248362, 3963.5441924178513, 3964.484616999829, 4608.308753686973, 4612.7462989535225, 4621.653375996813, 4627.329037289574, 4629.606483448944, 5327.360716713942, 5372.650777699437, 5679.829605111853, 5727.4845263926445, 5765.740541675635, 1326.2506683723666, 1345.5425155447194, 1353.708952575201, 1355.4849157320155, 1356.6947436826833, 737.7167666073494, 794.8330850521339, 799.3245707377373, 829.0, 835.1314632781961, 3922.843086276574, 4400.251957167289, 4479.193745125908, 4569.565891240327, 5151.484851514819, 4928.950710492921, 5306.7611957462, 5488.313960754906, 5809.854753631109, 5840.948629246776, 5145.331106956071, 5329.401179646091, 5429.6199266051, 5431.0, 5436.320459942507, 2990.5813186153955, 3053.648830384534, 3058.1742929408933, 3058.608333208385, 3077.276839942612, 5551.9722401387735, 5938.2280303560265, 6112.0, 6121.296050954108, 6178.907316390258, 4658.571539236186, 5386.037679276383, 5740.024195886709, 5835.649861008268, 5925.99258126111, 5058.7976480941825, 5436.565074794007, 6127.958247098004, 6131.846703832351, 6141.969290153521, 5499.807506737405, 5834.716362400265, 5849.795257165979, 5861.648301101947, 5884.529237661062, 5003.773320872177, 5459.972700136633, 5610.831675049755, 5636.098224284095, 5752.942470575241, 5473.863153421196, 5702.973464776214, 6037.486813620716, 6103.938960610337, 6113.755449781959, 3257.990023092849, 3493.615702272799, 3831.4061320495366, 3930.4497370368745, 4000.0199951012187, 5589.916151257653, 5752.0, 5773.971130144322, 5797.5361971041375, 5800.303963524404, 5129.794808207779, 5623.0, 5625.184348269559, 5635.774569017357, 5677.943220567741, 4821.5178482152905, 5244.160934250502, 5585.748641311069, 5598.272224610938, 5647.181158731879, 4364.254298280586, 4545.613552884762, 4816.95183048165, 5240.292560504283, 5500.559955203494, 4804.927926081042, 5163.638545301943, 5342.866428339323, 5572.86067848307, 5608.373571664171, 4702.553257440538, 4767.928481072856, 5101.724568857786, 5193.454687257784, 5520.972395137998], "value": 4067.1692393703693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.914930208375, 729.6169511006717, 778.3189709004621, 789.9447038707293, 811.3711873298193, 12474.563390281342, 15859.920700396511, 15948.0, 15969.201539923015, 16018.0, 14399.78400323996, 14553.854461455383, 14629.341679624416, 14629.78055329171, 14680.926595367035, 666.8366250268691, 702.3819039245457, 816.2205094135087, 826.9297109745664, 850.3154960256991, 867.7700409391516, 869.2958703450194, 869.647792643977, 870.1342164546286, 871.860502319629, 918.5682729117337, 918.9678361257357, 919.5586118663045, 919.6091661044063, 920.9631614735436, 904.3353135445442, 917.2570218123275, 917.7751450894574, 919.56320747645, 920.3741455810047, 674.1068084787676, 674.2414783368711, 675.2605896543278, 676.1041619853713, 678.047343482408, 13408.664783380396, 14514.491992780308, 14789.704205915821, 14825.332860021217, 14830.110193388324, 13630.659233519142, 14601.415943362254, 14660.120392776467, 14664.706705865823, 14701.26493675312, 10036.698899032968, 11695.1228657851, 11807.468663910058, 11862.881371186264, 11868.406579670982, 3795.4686343911876, 3808.9428658570146, 3823.0, 3932.8623498177426, 4008.5390180129366, 87864.5606771962, 94007.35623934661, 99758.0, 117509.0, 117602.41198794037, 10031.448270345201, 11180.273282236629, 11205.225933397078, 11255.831162532568, 11332.093432525378, 21643.0, 21777.782222177575, 21831.235906743506, 21848.235311764012, 21873.890630546746, 7073.929260707327, 7266.92733072673, 7908.288254057163, 7945.364370850318, 7951.761447156595, 3652.817359132033, 4302.182585308844, 4341.435613370241, 4410.642620026717, 4468.128714900628, 3621.402468592705, 3670.79810610419, 3721.4417837324618, 3771.057235691077, 3771.75483593571, 670.289493137276, 681.6557638392679, 690.5649440852231, 704.9083619129481, 707.939825114871, 604.9957071261684, 668.9866202675919, 675.4596322941627, 680.5576375356059, 698.0785363320368, 8533.701320453754, 8949.373543851867, 9331.0202428744, 9396.295277854188, 9845.852312215322, 561.8117930493249, 580.7676929228257, 626.9874602507924, 650.5283669339785, 675.625028109404, 3829.7319187656594, 4240.194363071068, 4506.0, 4587.38070360497, 4589.0, 99501.00498994917, 124407.37796310961, 157472.0, 164037.17981410018, 167023.0, 102030.48984755029, 103332.48333758433, 120367.0, 120381.39809300897, 142983.83750518685, 72756.9086463714, 104015.0, 106372.9362706363, 107850.0, 108781.0, 8534.530600816766, 9850.113489785954, 9943.651972180938, 9954.253430992849, 10033.849492257476, 56797.0, 57172.428275718376, 57897.552561186305, 57971.42028579829, 58768.11847822201, 82226.58886705528, 88460.0, 89938.55030724805, 90070.54964725135, 91465.54267228622, 10880.347179169275, 12896.871031289567, 13030.153040052366, 13230.933845330712, 13610.86389136096, 12416.627501174979, 12740.18400155912, 14322.427102915766, 14476.927615361856, 14662.193579353238, 13715.519956801463, 13719.382627781973, 13817.0, 13892.374843132286, 14353.497627582985, 10211.591536338463, 12398.62804115878, 12573.685657858261, 13912.234827084607, 14528.709425811636, 11477.713057173303, 11797.410129493319, 13497.392617332047, 13683.24742139192, 13753.79369309441, 10878.292910960763, 11009.944950275198, 11029.944850275697, 11594.246373985665, 11608.30350178992, 8861.379703420698, 10383.636572719919, 10942.945285273523, 11285.21003529745, 11590.768184636428], "value": 7696.696107611829, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 143.0, 174.0, 120.0, 117.0, 119.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 116.0, 154.0, 115.0, 139.0, 147.0, 123.0, 154.0, 119.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 205.0, 261.0, 262.0, 275.0, 211.0, 194.0, 195.0, 196.0, 196.0], "value": 220.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 84.0, 78.0, 74.0, 84.0, 87.0, 86.0, 82.0, 61.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 95.0, 103.0, 82.0, 71.0, 89.0, 71.0, 72.0, 89.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 127.0, 92.0, 89.0, 92.0, 75.0, 136.0, 131.0, 97.0, 87.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 98.0, 102.0, 101.0, 101.0, 143.0, 171.0, 131.0, 103.0], "value": 115.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 85.0, 153.0, 154.0, 93.0, 115.0, 157.0, 91.0, 92.0, 92.0], "value": 112.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 57.0, 58.0, 59.0, 60.0, 85.0, 57.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 81.0, 79.0, 75.0, 71.0, 85.0, 66.0, 72.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 87.0, 90.0, 88.0, 91.0, 91.0, 92.0, 92.0, 90.0, 102.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 181.0, 161.0, 164.0, 164.0, 160.0, 149.0, 184.0, 155.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 180.0, 181.0, 180.0, 178.0, 178.0, 176.0, 180.0, 180.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 71.0, 70.0, 69.0, 71.0, 69.0, 70.0, 70.0], "value": 70.2, "unit": "score"}]}]} 14:16:06 INFO - Return code: 0 14:16:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:06 ERROR - # TBPL SUCCESS # 14:16:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:06 INFO - 2016-10-26 14:16:06.746 screenresolution[1958:23244] starting screenresolution argv=screenresolution get 14:16:06 INFO - 2016-10-26 14:16:06.749 screenresolution[1958:23244] Display 0: 1600x1200x32@60 14:16:06 INFO - 2016-10-26 14:16:06.755 screenresolution[1959:23247] starting screenresolution argv=screenresolution list 14:16:06 INFO - Available Modes on Display 0 14:16:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:06 INFO - Intel Iris: 14:16:06 INFO - Chipset Model: Intel Iris 14:16:06 INFO - Type: GPU 14:16:06 INFO - Bus: Built-In 14:16:06 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:06 INFO - Vendor: Intel (0x8086) 14:16:06 INFO - Device ID: 0x0a2e 14:16:06 INFO - Revision ID: 0x0009 14:16:06 INFO - Displays: 14:16:06 INFO - Display: 14:16:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:06 INFO - Display Serial Number: 1600x1200 60 14:16:06 INFO - Main Display: Yes 14:16:06 INFO - Mirror: Off 14:16:06 INFO - Online: Yes 14:16:06 INFO - Rotation: Supported 14:16:06 INFO - Return code: 0 14:16:06 INFO - Running post-action listener: _resource_record_post_action 14:16:06 INFO - [mozharness: 2016-10-26 21:16:06.999591Z] Finished run-tests step (success) 14:16:06 INFO - Running post-run listener: _resource_record_post_run 14:16:07 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1234432; Write bytes: 708098560; Read time: 9; Write time: 1988 14:16:07 INFO - TinderboxPrint: CPU usage
54.5% 14:16:07 INFO - TinderboxPrint: I/O read bytes / time
1,234,432 / 9 14:16:07 INFO - TinderboxPrint: I/O write bytes / time
708,098,560 / 1,988 14:16:07 INFO - TinderboxPrint: CPU idle
2,204.1 (45.5%) 14:16:07 INFO - TinderboxPrint: CPU system
979.5 (20.2%) 14:16:07 INFO - TinderboxPrint: CPU user
1,658.0 (34.2%) 14:16:07 INFO - TinderboxPrint: Swap in / out
408,719,360 / 0 14:16:07 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408302080; Write bytes: 411060224; Read time: 30834; Write time: 831 14:16:07 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1197568; Write bytes: 295457280; Read time: 9; Write time: 1146 14:16:07 INFO - Running post-run listener: _upload_blobber_files 14:16:07 INFO - Blob upload gear active. 14:16:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:07 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 14:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:16:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:09 INFO - (blobuploader) - INFO - Done attempting. 14:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:10 INFO - (blobuploader) - INFO - Done attempting. 14:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:12 INFO - (blobuploader) - INFO - Done attempting. 14:16:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:12 INFO - Return code: 0 14:16:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c2583775f566d1930f21fbfaf4593b1b40baae27bf83835632b0b25a1bfff61a837db3dc93a222094bfe705dc576c6c146af4a158a2a4eae81edfb170493a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19759bfe6a1555061b46261ed9e37eabd3c759b440d5ba16f23ce24a8cd8e0725c7254174b14a6004f07cb6495daa662fbf975c5383b77b259696e2c36e4ec61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cdfaaa2ceb1441e9787c30a4348e4812529494c3097b313f9789c2c285922eef47abb6cc115a41ffbc76f5a463f4583b8159b9adb6c5302ad84cc58cfc37994"} 14:16:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:12 INFO - Contents: 14:16:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c2583775f566d1930f21fbfaf4593b1b40baae27bf83835632b0b25a1bfff61a837db3dc93a222094bfe705dc576c6c146af4a158a2a4eae81edfb170493a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19759bfe6a1555061b46261ed9e37eabd3c759b440d5ba16f23ce24a8cd8e0725c7254174b14a6004f07cb6495daa662fbf975c5383b77b259696e2c36e4ec61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cdfaaa2ceb1441e9787c30a4348e4812529494c3097b313f9789c2c285922eef47abb6cc115a41ffbc76f5a463f4583b8159b9adb6c5302ad84cc58cfc37994"} 14:16:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:12 INFO - Copying logs to upload dir... 14:16:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.905256 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-10-26 14:16:12.842372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:12.845466) ========= 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.XpXecJYA7A/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.AyaOZyNr4O/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c2583775f566d1930f21fbfaf4593b1b40baae27bf83835632b0b25a1bfff61a837db3dc93a222094bfe705dc576c6c146af4a158a2a4eae81edfb170493a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19759bfe6a1555061b46261ed9e37eabd3c759b440d5ba16f23ce24a8cd8e0725c7254174b14a6004f07cb6495daa662fbf975c5383b77b259696e2c36e4ec61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cdfaaa2ceb1441e9787c30a4348e4812529494c3097b313f9789c2c285922eef47abb6cc115a41ffbc76f5a463f4583b8159b9adb6c5302ad84cc58cfc37994"} build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011031 build_url: 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c2583775f566d1930f21fbfaf4593b1b40baae27bf83835632b0b25a1bfff61a837db3dc93a222094bfe705dc576c6c146af4a158a2a4eae81edfb170493a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19759bfe6a1555061b46261ed9e37eabd3c759b440d5ba16f23ce24a8cd8e0725c7254174b14a6004f07cb6495daa662fbf975c5383b77b259696e2c36e4ec61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cdfaaa2ceb1441e9787c30a4348e4812529494c3097b313f9789c2c285922eef47abb6cc115a41ffbc76f5a463f4583b8159b9adb6c5302ad84cc58cfc37994"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:12.880631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:12.880966) ========= 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.XpXecJYA7A/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.AyaOZyNr4O/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005278 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:12.929886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:12.933255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:12.933610) ========= ========= Total master_lag: 0.20 =========