builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1481109594.34 results: success (0) buildid: 20161207023139 builduid: 9970d6b8d8244a41a50344e0f848b62b revision: c401d72933641748f3738e90e7bbe539705e2f1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.335996) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.336400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.336687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.350947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.351212) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 03:19:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.4M=0s 2016-12-07 03:19:54 (99.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.449365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.449647) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.499437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:54.499761) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c401d72933641748f3738e90e7bbe539705e2f1c --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 c401d72933641748f3738e90e7bbe539705e2f1c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 03:19:54,868 truncating revision to first 12 chars 2016-12-07 03:19:54,868 Setting DEBUG logging. 2016-12-07 03:19:54,868 attempt 1/10 2016-12-07 03:19:54,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c401d7293364?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 03:19:55,159 unpacking tar archive at: mozilla-central-c401d7293364/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:55.111097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:55.111552) ========= script_repo_revision: c401d72933641748f3738e90e7bbe539705e2f1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:55.111940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:55.112206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 03:19:55.120552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-07 03:19:55.120816) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:19:55 INFO - MultiFileLogger online at 20161207 03:19:55 in /builds/slave/test 03:19:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:19:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:55 INFO - {'append_to_log': False, 03:19:55 INFO - 'base_work_dir': '/builds/slave/test', 03:19:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:19:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:55 INFO - 'branch': 'Firefox-Non-PGO', 03:19:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:55 INFO - 'config_files': ('talos/linux_config.py',), 03:19:55 INFO - 'default_actions': ('clobber', 03:19:55 INFO - 'read-buildbot-config', 03:19:55 INFO - 'download-and-extract', 03:19:55 INFO - 'populate-webroot', 03:19:55 INFO - 'create-virtualenv', 03:19:55 INFO - 'install', 03:19:55 INFO - 'run-tests'), 03:19:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:55 INFO - 'download_minidump_stackwalk': True, 03:19:55 INFO - 'download_symbols': 'ondemand', 03:19:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:19:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:19:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:19:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:19:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:55 INFO - 'installer_path': 'installer.exe', 03:19:55 INFO - 'log_level': 'info', 03:19:55 INFO - 'log_name': 'talos', 03:19:55 INFO - 'log_to_console': True, 03:19:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:19:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:19:55 INFO - 'opt_config_files': (), 03:19:55 INFO - 'pip_index': False, 03:19:55 INFO - 'sps_profile': False, 03:19:55 INFO - 'sps_profile_interval': 0, 03:19:55 INFO - 'suite': 'dromaeojs', 03:19:55 INFO - 'system_bits': '32', 03:19:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:55 INFO - 'title': 'talos-linux64-ix-015', 03:19:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:55 INFO - 'use_talos_json': True, 03:19:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:55 INFO - 'work_dir': 'build'} 03:19:55 INFO - [mozharness: 2016-12-07 11:19:55.582579Z] Running clobber step. 03:19:55 INFO - Running pre-action listener: _resource_record_pre_action 03:19:55 INFO - Running main action method: clobber 03:19:55 INFO - rmtree: /builds/slave/test/build 03:19:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:56 INFO - Running post-action listener: _resource_record_post_action 03:19:56 INFO - [mozharness: 2016-12-07 11:19:56.548188Z] Finished clobber step (success) 03:19:56 INFO - [mozharness: 2016-12-07 11:19:56.548287Z] Running read-buildbot-config step. 03:19:56 INFO - Running pre-action listener: _resource_record_pre_action 03:19:56 INFO - Running main action method: read_buildbot_config 03:19:56 INFO - Using buildbot properties: 03:19:56 INFO - { 03:19:56 INFO - "project": "", 03:19:56 INFO - "product": "firefox", 03:19:56 INFO - "script_repo_revision": "production", 03:19:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:19:56 INFO - "repository": "", 03:19:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:19:56 INFO - "buildid": "20161207023139", 03:19:56 INFO - "pgo_build": "False", 03:19:56 INFO - "basedir": "/builds/slave/test", 03:19:56 INFO - "buildnumber": 330, 03:19:56 INFO - "slavename": "talos-linux64-ix-015", 03:19:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:19:56 INFO - "platform": "ubuntu64_hw", 03:19:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:19:56 INFO - "branch": "mozilla-central", 03:19:56 INFO - "repo_path": "mozilla-central", 03:19:56 INFO - "revision": "c401d72933641748f3738e90e7bbe539705e2f1c", 03:19:56 INFO - "stage_platform": "linux64", 03:19:56 INFO - "builduid": "9970d6b8d8244a41a50344e0f848b62b", 03:19:56 INFO - "slavebuilddir": "test" 03:19:56 INFO - } 03:19:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 03:19:56 INFO - Running post-action listener: _resource_record_post_action 03:19:56 INFO - [mozharness: 2016-12-07 11:19:56.550706Z] Finished read-buildbot-config step (success) 03:19:56 INFO - [mozharness: 2016-12-07 11:19:56.550795Z] Running download-and-extract step. 03:19:56 INFO - Running pre-action listener: _resource_record_pre_action 03:19:56 INFO - Running main action method: download_and_extract 03:19:56 INFO - mkdir: /builds/slave/test/build/tests 03:19:56 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')]} 03:19:56 INFO - trying https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 03:19:56 INFO - Downloading https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 03:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:19:57 INFO - Downloaded 1361 bytes. 03:19:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 03:19:57 INFO - Using the following test package requirements: 03:19:57 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 03:19:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:19:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:19:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'jsshell-linux-x86_64.zip'], 03:19:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:19:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 03:19:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:19:57 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:19:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:19:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:19:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:19:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:19:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 03:19:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:19:57 INFO - Fetch https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:19:57 INFO - Expected file size: 20219060 03:19:57 INFO - Obtained file size: 20219060 03:20:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:20:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 03:20:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:20:01 INFO - Fetch https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:20:02 INFO - Expected file size: 20219060 03:20:02 INFO - Obtained file size: 20219060 03:20:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 03:20:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:20:07 INFO - Fetch https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:20:08 INFO - Expected file size: 14409734 03:20:08 INFO - Obtained file size: 14409734 03:20:08 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')]} 03:20:08 INFO - trying https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:20:08 INFO - Downloading https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:20:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:20:10 INFO - Downloaded 55707221 bytes. 03:20:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:20:10 INFO - mkdir: /builds/slave/test/properties 03:20:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:10 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:10 INFO - Contents: 03:20:10 INFO - build_url:https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:20:11 INFO - Running post-action listener: _resource_record_post_action 03:20:11 INFO - Running post-action listener: set_extra_try_arguments 03:20:11 INFO - [mozharness: 2016-12-07 11:20:11.682670Z] Finished download-and-extract step (success) 03:20:11 INFO - [mozharness: 2016-12-07 11:20:11.682903Z] Running populate-webroot step. 03:20:11 INFO - Running pre-action listener: _resource_record_pre_action 03:20:11 INFO - Running main action method: populate_webroot 03:20:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:20:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:20:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:20:11 INFO - '--tppagecycles', 03:20:11 INFO - '7'], 03:20:11 INFO - 'tests': ['tsvgm']}}, 03:20:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:20:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:20:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['damp', 'tps']}, 03:20:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'tests': ['damp', 'tps']}, 03:20:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['dromaeo_dom']}, 03:20:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['basic_compositor_video']}, 03:20:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:20:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['a11yr', 03:20:11 INFO - 'ts_paint', 03:20:11 INFO - 'tpaint', 03:20:11 INFO - 'sessionrestore', 03:20:11 INFO - 'sessionrestore_no_auto_restore', 03:20:11 INFO - 'tabpaint']}, 03:20:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:11 INFO - 'ts_paint', 03:20:11 INFO - 'tpaint', 03:20:11 INFO - 'sessionrestore', 03:20:11 INFO - 'sessionrestore_no_auto_restore', 03:20:11 INFO - 'tabpaint']}, 03:20:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:20:11 INFO - 'ts_paint', 03:20:11 INFO - 'tpaint', 03:20:11 INFO - 'sessionrestore', 03:20:11 INFO - 'sessionrestore_no_auto_restore', 03:20:11 INFO - 'tabpaint']}, 03:20:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:20:11 INFO - 'ts_paint', 03:20:11 INFO - 'tpaint', 03:20:11 INFO - 'sessionrestore', 03:20:11 INFO - 'sessionrestore_no_auto_restore', 03:20:11 INFO - 'tabpaint']}, 03:20:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['a11yr', 03:20:11 INFO - 'ts_paint', 03:20:11 INFO - 'tpaint', 03:20:11 INFO - 'sessionrestore', 03:20:11 INFO - 'sessionrestore_no_auto_restore', 03:20:11 INFO - 'tabpaint']}, 03:20:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['a11yr', 03:20:11 INFO - 'ts_paint', 03:20:11 INFO - 'tpaint', 03:20:11 INFO - 'sessionrestore', 03:20:11 INFO - 'sessionrestore_no_auto_restore', 03:20:11 INFO - 'tabpaint']}, 03:20:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['tsvgx', 03:20:11 INFO - 'tsvgr_opacity', 03:20:11 INFO - 'tart', 03:20:11 INFO - 'tscrollx', 03:20:11 INFO - 'cart', 03:20:11 INFO - 'tsvg_static']}, 03:20:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:11 INFO - 'tsvgr_opacity', 03:20:11 INFO - 'tart', 03:20:11 INFO - 'tscrollx', 03:20:11 INFO - 'cart', 03:20:11 INFO - 'tsvg_static']}, 03:20:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'talos_options': ['--disable-e10s'], 03:20:11 INFO - 'tests': ['tp5o']}, 03:20:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'talos_options': ['--disable-e10s', 03:20:11 INFO - '--xperf_path', 03:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:11 INFO - 'tests': ['tp5n']}, 03:20:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:11 INFO - 'talos_options': ['--xperf_path', 03:20:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:11 INFO - 'tests': ['tp5n']}}, 03:20:11 INFO - 'talos.zip': {'path': '', 03:20:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:20:11 INFO - Running post-action listener: _resource_record_post_action 03:20:11 INFO - [mozharness: 2016-12-07 11:20:11.703310Z] Finished populate-webroot step (success) 03:20:11 INFO - [mozharness: 2016-12-07 11:20:11.703398Z] Running create-virtualenv step. 03:20:11 INFO - Running pre-action listener: _resource_record_pre_action 03:20:11 INFO - Running main action method: create_virtualenv 03:20:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:11 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 03:20:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:20:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:11 INFO - Using real prefix '/usr' 03:20:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:14 INFO - Installing pip.................done. 03:20:14 INFO - Return code: 0 03:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:14 INFO - Reading from file tmpfile_stdout 03:20:14 INFO - Output received: 03:20:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:20:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:14 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')]} 03:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:14 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')]} 03:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:14 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:14 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 03:20:14 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 03:20:14 INFO - Using env: {'DISPLAY': ':0', 03:20:14 INFO - 'HOME': '/home/cltbld', 03:20:14 INFO - 'LANG': 'en_US.UTF-8', 03:20:14 INFO - 'LANGUAGE': 'en_US:en', 03:20:14 INFO - 'LOGNAME': 'cltbld', 03:20:14 INFO - 'MAIL': '/var/mail/cltbld', 03:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:14 INFO - 'MOZ_NO_REMOTE': '1', 03:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:14 INFO - 'NO_EM_RESTART': '1', 03:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:14 INFO - 'PWD': '/builds/slave/test', 03:20:14 INFO - 'SHELL': '/bin/bash', 03:20:14 INFO - 'SHLVL': '1', 03:20:14 INFO - 'TERM': 'linux', 03:20:14 INFO - 'TMOUT': '86400', 03:20:14 INFO - 'USER': 'cltbld', 03:20:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:14 INFO - '_': '/tools/buildbot/bin/python'} 03:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:14 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 03:20:14 INFO - Cleaning up... 03:20:14 INFO - Return code: 0 03:20:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:14 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')]} 03:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:14 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')]} 03:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:14 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:14 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 03:20:14 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 03:20:14 INFO - Using env: {'DISPLAY': ':0', 03:20:14 INFO - 'HOME': '/home/cltbld', 03:20:14 INFO - 'LANG': 'en_US.UTF-8', 03:20:14 INFO - 'LANGUAGE': 'en_US:en', 03:20:14 INFO - 'LOGNAME': 'cltbld', 03:20:14 INFO - 'MAIL': '/var/mail/cltbld', 03:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:14 INFO - 'MOZ_NO_REMOTE': '1', 03:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:14 INFO - 'NO_EM_RESTART': '1', 03:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:14 INFO - 'PWD': '/builds/slave/test', 03:20:14 INFO - 'SHELL': '/bin/bash', 03:20:14 INFO - 'SHLVL': '1', 03:20:14 INFO - 'TERM': 'linux', 03:20:14 INFO - 'TMOUT': '86400', 03:20:14 INFO - 'USER': 'cltbld', 03:20:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:14 INFO - '_': '/tools/buildbot/bin/python'} 03:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:14 INFO - Downloading/unpacking psutil>=3.1.1 03:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:17 INFO - Installing collected packages: psutil 03:20:17 INFO - Running setup.py install for psutil 03:20:17 INFO - building 'psutil._psutil_linux' extension 03:20:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:20:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:20:17 INFO - building 'psutil._psutil_posix' extension 03:20:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:20:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:17 INFO - Successfully installed psutil 03:20:17 INFO - Cleaning up... 03:20:17 INFO - Return code: 0 03:20:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20:17 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')]} 03:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:17 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')]} 03:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:17 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:17 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 03:20:17 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 03:20:17 INFO - Using env: {'DISPLAY': ':0', 03:20:17 INFO - 'HOME': '/home/cltbld', 03:20:17 INFO - 'LANG': 'en_US.UTF-8', 03:20:17 INFO - 'LANGUAGE': 'en_US:en', 03:20:17 INFO - 'LOGNAME': 'cltbld', 03:20:17 INFO - 'MAIL': '/var/mail/cltbld', 03:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:17 INFO - 'MOZ_NO_REMOTE': '1', 03:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:17 INFO - 'NO_EM_RESTART': '1', 03:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:17 INFO - 'PWD': '/builds/slave/test', 03:20:17 INFO - 'SHELL': '/bin/bash', 03:20:17 INFO - 'SHLVL': '1', 03:20:17 INFO - 'TERM': 'linux', 03:20:17 INFO - 'TMOUT': '86400', 03:20:17 INFO - 'USER': 'cltbld', 03:20:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:17 INFO - '_': '/tools/buildbot/bin/python'} 03:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:18 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 03:20:18 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 03:20:18 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 03:20:18 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 03:20:18 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 03:20:18 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 03:20:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:20 INFO - Installing collected packages: mozsystemmonitor 03:20:20 INFO - Running setup.py install for mozsystemmonitor 03:20:20 INFO - Successfully installed mozsystemmonitor 03:20:20 INFO - Cleaning up... 03:20:20 INFO - Return code: 0 03:20:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:20 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')]} 03:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:20 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')]} 03:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:20 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:20 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 03:20:20 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 03:20:20 INFO - Using env: {'DISPLAY': ':0', 03:20:20 INFO - 'HOME': '/home/cltbld', 03:20:20 INFO - 'LANG': 'en_US.UTF-8', 03:20:20 INFO - 'LANGUAGE': 'en_US:en', 03:20:20 INFO - 'LOGNAME': 'cltbld', 03:20:20 INFO - 'MAIL': '/var/mail/cltbld', 03:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:20 INFO - 'MOZ_NO_REMOTE': '1', 03:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:20 INFO - 'NO_EM_RESTART': '1', 03:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:20 INFO - 'PWD': '/builds/slave/test', 03:20:20 INFO - 'SHELL': '/bin/bash', 03:20:20 INFO - 'SHLVL': '1', 03:20:20 INFO - 'TERM': 'linux', 03:20:20 INFO - 'TMOUT': '86400', 03:20:20 INFO - 'USER': 'cltbld', 03:20:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:20 INFO - '_': '/tools/buildbot/bin/python'} 03:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:20 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 03:20:20 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 03:20:20 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 03:20:20 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 03:20:20 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 03:20:20 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 03:20:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:23 INFO - warning: no files found matching '*.txt' 03:20:23 INFO - no previously-included directories found matching 'build' 03:20:23 INFO - no previously-included directories found matching 'dist' 03:20:23 INFO - no previously-included directories found matching '.git*' 03:20:23 INFO - Installing collected packages: jsonschema, functools32 03:20:23 INFO - Running setup.py install for functools32 03:20:23 INFO - warning: no files found matching '*.txt' 03:20:23 INFO - no previously-included directories found matching 'build' 03:20:23 INFO - no previously-included directories found matching 'dist' 03:20:23 INFO - no previously-included directories found matching '.git*' 03:20:23 INFO - Successfully installed jsonschema functools32 03:20:23 INFO - Cleaning up... 03:20:23 INFO - Return code: 0 03:20:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:23 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')]} 03:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:23 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')]} 03:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:23 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:23 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 03:20:23 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 03:20:23 INFO - Using env: {'DISPLAY': ':0', 03:20:23 INFO - 'HOME': '/home/cltbld', 03:20:23 INFO - 'LANG': 'en_US.UTF-8', 03:20:23 INFO - 'LANGUAGE': 'en_US:en', 03:20:23 INFO - 'LOGNAME': 'cltbld', 03:20:23 INFO - 'MAIL': '/var/mail/cltbld', 03:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:23 INFO - 'MOZ_NO_REMOTE': '1', 03:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:23 INFO - 'NO_EM_RESTART': '1', 03:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:23 INFO - 'PWD': '/builds/slave/test', 03:20:23 INFO - 'SHELL': '/bin/bash', 03:20:23 INFO - 'SHLVL': '1', 03:20:23 INFO - 'TERM': 'linux', 03:20:23 INFO - 'TMOUT': '86400', 03:20:23 INFO - 'USER': 'cltbld', 03:20:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:23 INFO - '_': '/tools/buildbot/bin/python'} 03:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:23 INFO - Cleaning up... 03:20:23 INFO - Return code: 0 03:20:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:23 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')]} 03:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:23 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')]} 03:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:23 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:23 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 03:20:23 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 03:20:23 INFO - Using env: {'DISPLAY': ':0', 03:20:23 INFO - 'HOME': '/home/cltbld', 03:20:23 INFO - 'LANG': 'en_US.UTF-8', 03:20:23 INFO - 'LANGUAGE': 'en_US:en', 03:20:23 INFO - 'LOGNAME': 'cltbld', 03:20:23 INFO - 'MAIL': '/var/mail/cltbld', 03:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:23 INFO - 'MOZ_NO_REMOTE': '1', 03:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:23 INFO - 'NO_EM_RESTART': '1', 03:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:23 INFO - 'PWD': '/builds/slave/test', 03:20:23 INFO - 'SHELL': '/bin/bash', 03:20:23 INFO - 'SHLVL': '1', 03:20:23 INFO - 'TERM': 'linux', 03:20:23 INFO - 'TMOUT': '86400', 03:20:23 INFO - 'USER': 'cltbld', 03:20:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:23 INFO - '_': '/tools/buildbot/bin/python'} 03:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:25 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 03:20:25 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 03:20:25 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 03:20:25 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 03:20:25 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 03:20:25 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 03:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:26 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 03:20:26 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 03:20:26 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 03:20:26 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 03:20:26 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 03:20:26 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 03:20:26 INFO - Downloading docopt-0.6.1.tar.gz 03:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:26 INFO - Running setup.py install for blobuploader 03:20:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:26 INFO - Running setup.py install for requests 03:20:26 INFO - Running setup.py install for docopt 03:20:27 INFO - Successfully installed blobuploader requests docopt 03:20:27 INFO - Cleaning up... 03:20:27 INFO - Return code: 0 03:20:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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')]} 03:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:27 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:27 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 03:20:27 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 03:20:27 INFO - Using env: {'DISPLAY': ':0', 03:20:27 INFO - 'HOME': '/home/cltbld', 03:20:27 INFO - 'LANG': 'en_US.UTF-8', 03:20:27 INFO - 'LANGUAGE': 'en_US:en', 03:20:27 INFO - 'LOGNAME': 'cltbld', 03:20:27 INFO - 'MAIL': '/var/mail/cltbld', 03:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:27 INFO - 'MOZ_NO_REMOTE': '1', 03:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:27 INFO - 'NO_EM_RESTART': '1', 03:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:27 INFO - 'PWD': '/builds/slave/test', 03:20:27 INFO - 'SHELL': '/bin/bash', 03:20:27 INFO - 'SHLVL': '1', 03:20:27 INFO - 'TERM': 'linux', 03:20:27 INFO - 'TMOUT': '86400', 03:20:27 INFO - 'USER': 'cltbld', 03:20:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:27 INFO - '_': '/tools/buildbot/bin/python'} 03:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:27 INFO - Running setup.py (path:/tmp/pip-PnENjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:27 INFO - Running setup.py (path:/tmp/pip-510Zrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:27 INFO - Running setup.py (path:/tmp/pip-D3vG39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:27 INFO - Running setup.py (path:/tmp/pip-mNRk0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:27 INFO - Running setup.py (path:/tmp/pip-UtjeEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:27 INFO - Running setup.py (path:/tmp/pip-S4H0JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:27 INFO - Running setup.py (path:/tmp/pip-Owlbae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:27 INFO - Running setup.py (path:/tmp/pip-Wz2vPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:27 INFO - Running setup.py (path:/tmp/pip-VHEbIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:28 INFO - Running setup.py (path:/tmp/pip-M4tZFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:28 INFO - Running setup.py (path:/tmp/pip-MtUOt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:28 INFO - Running setup.py (path:/tmp/pip-8_KsFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:28 INFO - Running setup.py (path:/tmp/pip-BWS4e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:28 INFO - Running setup.py (path:/tmp/pip-cD6efP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:28 INFO - Running setup.py (path:/tmp/pip-sZ17Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:28 INFO - Running setup.py (path:/tmp/pip-CE0PeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:28 INFO - Running setup.py (path:/tmp/pip-T2Srtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:28 INFO - Running setup.py install for manifestparser 03:20:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:28 INFO - Running setup.py install for mozcrash 03:20:28 INFO - Running setup.py install for mozdebug 03:20:28 INFO - Running setup.py install for mozdevice 03:20:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for mozfile 03:20:29 INFO - Running setup.py install for mozhttpd 03:20:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for mozinfo 03:20:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for mozInstall 03:20:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for mozleak 03:20:29 INFO - Running setup.py install for mozlog 03:20:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for moznetwork 03:20:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for mozprocess 03:20:29 INFO - Running setup.py install for mozprofile 03:20:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:29 INFO - Running setup.py install for mozrunner 03:20:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:30 INFO - Running setup.py install for mozscreenshot 03:20:30 INFO - Running setup.py install for moztest 03:20:30 INFO - Running setup.py install for mozversion 03:20:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:30 INFO - Cleaning up... 03:20:30 INFO - Return code: 0 03:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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')]} 03:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:30 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:30 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 03:20:30 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 03:20:30 INFO - Using env: {'DISPLAY': ':0', 03:20:30 INFO - 'HOME': '/home/cltbld', 03:20:30 INFO - 'LANG': 'en_US.UTF-8', 03:20:30 INFO - 'LANGUAGE': 'en_US:en', 03:20:30 INFO - 'LOGNAME': 'cltbld', 03:20:30 INFO - 'MAIL': '/var/mail/cltbld', 03:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:30 INFO - 'MOZ_NO_REMOTE': '1', 03:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:30 INFO - 'NO_EM_RESTART': '1', 03:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:30 INFO - 'PWD': '/builds/slave/test', 03:20:30 INFO - 'SHELL': '/bin/bash', 03:20:30 INFO - 'SHLVL': '1', 03:20:30 INFO - 'TERM': 'linux', 03:20:30 INFO - 'TMOUT': '86400', 03:20:30 INFO - 'USER': 'cltbld', 03:20:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:30 INFO - '_': '/tools/buildbot/bin/python'} 03:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:30 INFO - Running setup.py (path:/tmp/pip-aIZ6I1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:30 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)) 03:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:30 INFO - Running setup.py (path:/tmp/pip-VAupkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:30 INFO - Running setup.py (path:/tmp/pip-wxRGPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:30 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)) 03:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:30 INFO - Running setup.py (path:/tmp/pip-TQHbFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:30 INFO - Running setup.py (path:/tmp/pip-XOqYlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:31 INFO - Running setup.py (path:/tmp/pip-35Pxyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:31 INFO - Running setup.py (path:/tmp/pip-IvEbCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:31 INFO - Running setup.py (path:/tmp/pip-Zox6D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:31 INFO - Running setup.py (path:/tmp/pip-qbPb9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:31 INFO - Running setup.py (path:/tmp/pip-r8V8MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:31 INFO - Running setup.py (path:/tmp/pip-nxz7SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:31 INFO - Running setup.py (path:/tmp/pip-Xgl2EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:31 INFO - Running setup.py (path:/tmp/pip-Bmkj4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:31 INFO - Running setup.py (path:/tmp/pip-OUov0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:31 INFO - Running setup.py (path:/tmp/pip-nl8adt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:31 INFO - Running setup.py (path:/tmp/pip-3tdhBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:31 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)) 03:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:31 INFO - Running setup.py (path:/tmp/pip-nRdgfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:31 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)) 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:31 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)) 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:33 INFO - Downloading blessings-1.6.tar.gz 03:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:33 INFO - Installing collected packages: blessings 03:20:33 INFO - Running setup.py install for blessings 03:20:34 INFO - Successfully installed blessings 03:20:34 INFO - Cleaning up... 03:20:34 INFO - Return code: 0 03:20:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:34 INFO - Reading from file tmpfile_stdout 03:20:34 INFO - Current package versions: 03:20:34 INFO - argparse == 1.2.1 03:20:34 INFO - blessings == 1.6 03:20:34 INFO - blobuploader == 1.2.4 03:20:34 INFO - docopt == 0.6.1 03:20:34 INFO - functools32 == 3.2.3-2 03:20:34 INFO - jsonschema == 2.5.1 03:20:34 INFO - manifestparser == 1.1 03:20:34 INFO - mozInstall == 1.12 03:20:34 INFO - mozcrash == 1.0 03:20:34 INFO - mozdebug == 0.1 03:20:34 INFO - mozdevice == 0.49 03:20:34 INFO - mozfile == 1.2 03:20:34 INFO - mozhttpd == 0.7 03:20:34 INFO - mozinfo == 0.9 03:20:34 INFO - mozleak == 0.1 03:20:34 INFO - mozlog == 3.4 03:20:34 INFO - moznetwork == 0.27 03:20:34 INFO - mozprocess == 0.23 03:20:34 INFO - mozprofile == 0.28 03:20:34 INFO - mozrunner == 6.13 03:20:34 INFO - mozscreenshot == 0.1 03:20:34 INFO - mozsystemmonitor == 0.3 03:20:34 INFO - moztest == 0.7 03:20:34 INFO - mozversion == 1.4 03:20:34 INFO - psutil == 3.1.1 03:20:34 INFO - requests == 1.2.3 03:20:34 INFO - wsgiref == 0.1.2 03:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:34 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')]} 03:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:34 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')]} 03:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:34 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:34 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 03:20:34 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 03:20:34 INFO - Using env: {'DISPLAY': ':0', 03:20:34 INFO - 'HOME': '/home/cltbld', 03:20:34 INFO - 'LANG': 'en_US.UTF-8', 03:20:34 INFO - 'LANGUAGE': 'en_US:en', 03:20:34 INFO - 'LOGNAME': 'cltbld', 03:20:34 INFO - 'MAIL': '/var/mail/cltbld', 03:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:34 INFO - 'MOZ_NO_REMOTE': '1', 03:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:34 INFO - 'NO_EM_RESTART': '1', 03:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:34 INFO - 'PWD': '/builds/slave/test', 03:20:34 INFO - 'SHELL': '/bin/bash', 03:20:34 INFO - 'SHLVL': '1', 03:20:34 INFO - 'TERM': 'linux', 03:20:34 INFO - 'TMOUT': '86400', 03:20:34 INFO - 'USER': 'cltbld', 03:20:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:34 INFO - '_': '/tools/buildbot/bin/python'} 03:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 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)) 03:20:34 INFO - Cleaning up... 03:20:34 INFO - Return code: 0 03:20:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20:34 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')]} 03:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:34 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')]} 03:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:34 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 0x7ffe9faa7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:34 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 03:20:34 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 03:20:34 INFO - Using env: {'DISPLAY': ':0', 03:20:34 INFO - 'HOME': '/home/cltbld', 03:20:34 INFO - 'LANG': 'en_US.UTF-8', 03:20:34 INFO - 'LANGUAGE': 'en_US:en', 03:20:34 INFO - 'LOGNAME': 'cltbld', 03:20:34 INFO - 'MAIL': '/var/mail/cltbld', 03:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:34 INFO - 'MOZ_NO_REMOTE': '1', 03:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:34 INFO - 'NO_EM_RESTART': '1', 03:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:34 INFO - 'PWD': '/builds/slave/test', 03:20:34 INFO - 'SHELL': '/bin/bash', 03:20:34 INFO - 'SHLVL': '1', 03:20:34 INFO - 'TERM': 'linux', 03:20:34 INFO - 'TMOUT': '86400', 03:20:34 INFO - 'USER': 'cltbld', 03:20:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:34 INFO - '_': '/tools/buildbot/bin/python'} 03:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:34 INFO - Cleaning up... 03:20:34 INFO - Return code: 0 03:20:34 INFO - Running post-action listener: _resource_record_post_action 03:20:34 INFO - Running post-action listener: _start_resource_monitoring 03:20:34 INFO - Starting resource monitoring. 03:20:34 INFO - [mozharness: 2016-12-07 11:20:34.870575Z] Finished create-virtualenv step (success) 03:20:34 INFO - [mozharness: 2016-12-07 11:20:34.871257Z] Running install step. 03:20:34 INFO - Running pre-action listener: _resource_record_pre_action 03:20:34 INFO - Running main action method: install 03:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:35 INFO - Reading from file tmpfile_stdout 03:20:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:35 INFO - Reading from file tmpfile_stdout 03:20:35 INFO - Output received: 03:20:35 INFO - Usage: mozinstall [options] installer 03:20:35 INFO - Options: 03:20:35 INFO - -h, --help show this help message and exit 03:20:35 INFO - -d DEST, --destination=DEST 03:20:35 INFO - Directory to install application into. [default: 03:20:35 INFO - "/builds/slave/test"] 03:20:35 INFO - --app=APP Application being installed. [default: firefox] 03:20:35 INFO - mkdir: /builds/slave/test/build/application 03:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:20:51 INFO - Reading from file tmpfile_stdout 03:20:51 INFO - Output received: 03:20:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:20:51 INFO - Running post-action listener: _resource_record_post_action 03:20:51 INFO - [mozharness: 2016-12-07 11:20:51.301970Z] Finished install step (success) 03:20:51 INFO - [mozharness: 2016-12-07 11:20:51.302210Z] Running run-tests step. 03:20:51 INFO - Running pre-action listener: _resource_record_pre_action 03:20:51 INFO - Running main action method: run_tests 03:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:51 INFO - Python 2.7.3 03:20:51 INFO - Return code: 0 03:20:51 INFO - grabbing minidump binary from tooltool 03:20: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')]} 03:20:51 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/linux64/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 0x1f44f20>, '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 0x1eb1c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:51 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:20:51 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/linux64/releng.manifest -o -c /builds/tooltool_cache 03:20:51 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:20:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:51 INFO - Return code: 0 03:20:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:20:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:20:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:20:51 INFO - Using env: {'DISPLAY': ':0', 03:20:51 INFO - 'HOME': '/home/cltbld', 03:20:51 INFO - 'LANG': 'en_US.UTF-8', 03:20:51 INFO - 'LANGUAGE': 'en_US:en', 03:20:51 INFO - 'LOGNAME': 'cltbld', 03:20:51 INFO - 'MAIL': '/var/mail/cltbld', 03:20:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:51 INFO - 'MOZ_NO_REMOTE': '1', 03:20:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:51 INFO - 'NO_EM_RESTART': '1', 03:20:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:51 INFO - 'PWD': '/builds/slave/test', 03:20:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:51 INFO - 'SHELL': '/bin/bash', 03:20:51 INFO - 'SHLVL': '1', 03:20:51 INFO - 'TERM': 'linux', 03:20:51 INFO - 'TMOUT': '86400', 03:20:51 INFO - 'USER': 'cltbld', 03:20:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911', 03:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:51 INFO - '_': '/tools/buildbot/bin/python'} 03:20:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:20:51 INFO - mozversion application_buildid: 20161207023139 03:20:51 INFO - mozversion application_changeset: c401d72933641748f3738e90e7bbe539705e2f1c 03:20:51 INFO - mozversion application_display_name: Nightly 03:20:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:51 INFO - mozversion application_name: Firefox 03:20:51 INFO - mozversion application_remotingname: firefox 03:20:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:20:51 INFO - mozversion application_vendor: Mozilla 03:20:51 INFO - mozversion application_version: 53.0a1 03:20:51 INFO - mozversion platform_buildid: 20161207023139 03:20:51 INFO - mozversion platform_changeset: c401d72933641748f3738e90e7bbe539705e2f1c 03:20:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:20:51 INFO - mozversion platform_version: 53.0a1 03:20:51 INFO - using testdate: 1481109651 03:20:51 INFO - actual date: 1481109651 03:20:51 INFO - starting webserver on 'localhost:39218' 03:20:51 INFO - SUITE-START | Running 2 tests 03:20:51 INFO - TEST-START | dromaeo_css 03:20:51 INFO - operating with platform_type : linux_ 03:20:51 INFO - Initialising browser for dromaeo_css test... 03:20:51 INFO - TEST-INFO | started process 22724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dkVVv/profile http://localhost:39218/getInfo.html) 03:20:55 INFO - PROCESS | 22724 | __metrics Screen width/height:1600/1200 03:20:55 INFO - PROCESS | 22724 | colorDepth:24 03:20:55 INFO - PROCESS | 22724 | Browser inner width/height: 1024/697 03:20:55 INFO - PROCESS | 22724 | __metrics 03:20:56 INFO - PROCESS | 22724 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:56 INFO - PROCESS | 22724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:56 INFO - PROCESS | 22724 | console.error: PushService: 03:20:56 INFO - PROCESS | 22724 | stateChangeProcessEnqueue: Error transitioning state 03:20:56 INFO - PROCESS | 22724 | UnknownError 03:20:57 INFO - TEST-INFO | 22724: exit 0 03:20:57 INFO - Browser initialized. 03:20:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:57 INFO - TEST-INFO | started process 22807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dkVVv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:10 INFO - PROCESS | 22807 | RSS: Main: 173395968 03:21:10 INFO - PROCESS | 22807 | 03:22:01 INFO - PROCESS | 22807 | 1481109721190 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] 03:24:14 INFO - PROCESS | 22807 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39218/tests/dromaeo/cssquery-ext.html) 03:24:16 INFO - PROCESS | 22807 | RSS: Main: 355561472 03:24:16 INFO - PROCESS | 22807 | 03:27:19 INFO - PROCESS | 22807 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-ext.html (next: http://localhost:39218/tests/dromaeo/cssquery-jquery.html) 03:27:20 INFO - PROCESS | 22807 | RSS: Main: 287752192 03:27:20 INFO - PROCESS | 22807 | 03:30:22 INFO - PROCESS | 22807 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39218/tests/dromaeo/cssquery-mootools.html) 03:30:23 INFO - PROCESS | 22807 | RSS: Main: 257269760 03:30:23 INFO - PROCESS | 22807 | 03:33:25 INFO - PROCESS | 22807 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39218/tests/dromaeo/cssquery-prototype.html) 03:33:26 INFO - PROCESS | 22807 | RSS: Main: 242098176 03:33:26 INFO - PROCESS | 22807 | 03:36:29 INFO - PROCESS | 22807 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39218/tests/dromaeo/cssquery-yui.html) 03:36:29 INFO - PROCESS | 22807 | RSS: Main: 220020736 03:36:29 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-yui.html (next: http://localhost:39218/tests/dromaeo/cssquery-dojo.html) 03:39:33 INFO - PROCESS | 22807 | RSS: Main: 311513088 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | __start_tp_report 03:39:33 INFO - PROCESS | 22807 | _x_x_mozilla_page_load 03:39:33 INFO - PROCESS | 22807 | _x_x_mozilla_page_load_details 03:39:33 INFO - PROCESS | 22807 | |i|pagename|runs| 03:39:33 INFO - PROCESS | 22807 | |0;dojo.html;2555.514452254072;2589.197348821864;2612.7648511633956;2623.5802271636544;2630.118910165095;4517.277235642289;4558.726476411418;4666.5333466653365;4707.929381059283;4713.5757781799675;4550.49944506104;4580.610648094916;4595.540445955403;4623.606993405556;4641.2341963576055;4189.22499337622;4202.117555313388;4243.448351714273;4267.4452321198205;4381.737095774248;4271.273883439807;4323.4163387942535;4355.54266801986;4364.061726728753;4383.211022016036;4118.341065429517;4260.4248426462655;4275.380069889879;4345.956540434587;4367.301231802912;4128.504579450455;4169.2703776839235;4207.389928460356;4221.91556168878;4243.045314804144;4212.68404869636;4214.136102099093;4214.157168566299;4244.766537840417;4271.615554600101;4581.037982023779;4582.908341833178;4599.034202817413;4622.237330840408;4639.930401043987;4839.298301746262;4874.780634871439;4883.047805677894;4883.584895283905;4934.425904247947;4953.628477864138;5021.146405111103;5033.597312215014;5063.822766203202;5084.313617661605;4669.719816811003;4674.976625116853;4681.040386720714;4682.929756053662;4734.337192793012;4914.778834952435;4952.306677065214;5123.7438128093445;5128.7179205144075;5166.5866730661455;4804.711717296974;4838.95161048392;4850.927236091461;4864.927026094611;4958.231474121517;4978.751062446863;4986.252062190628;4988.625853061035;4988.800447982113;5034;4936.136176169156;4939.036887806843;4943.3573635427165;4945.431275403303;5001.424836143818;4784.091022705675;4794.041191761592;4795.880102997453;4797.784099715521;4842.95157048425;4045.37296719009;4066.3087275163293;4105.753654780723;4105.835766569304;4106.691998100155;3638.508801311789;3661.029827095822;3664.59689434162;3695.5011073504734;3701.0932321581386;4247.214265360918;4282.464691913511;4320.071184695243;4379.562043795659;4391.692581519263;5037.168867136955;5092;5093.821716239914;5117.002184574047;5140.254663073833;4352.303631418958;4379.277419225792;4383.671224658099;4383.693141480129;4423.20382331177;4307.461567304087;4345.456817897762;4442.8667139985855;4458.464984201916;4534;4641.048585039991;4656.650751193606;4695.896464330811;4697.201475749062;4759.785809638505;5016.749162541785;5021.748912554284;5025.145725226647;5030;5071.061853557104;4708.482066972561;4710.128626204163;4713.7643117844655;4716.434027916672;4766.833160839354;4732.029933863619;4756.096341695067;4846.80612775485;4890.437599676083;4890.486498917705;4998.2002879539095;5000.774965126505;5004.3994720633755;5007.474215207497;5046.722430266371;4827.637927155548;4864;4866;4867.561919427127;4905.632077594123;4683.15703173432;4709.670323077488;4713.905721885474;4787.928181077217;4911.950880491149;4716.929246061243;4727.078219747116;4727.598154156935;4730.6215502759005;4734.07685501324;4775.665703400868;4795.808167673394;4806.351142595705;4818.469968303414;4819.855404337875;4694.812207511798;4728.101660684459;4763.785629646605;4767.809287628456;4775.6657034007285 03:39:33 INFO - PROCESS | 22807 | |1;ext.html;555.3030946162565;580.3471095018105;588.5674029588251;589.292848581702;600.6696317025635;28291;30400.695993040063;38207.426888596696;39560.802195989054;39627.80186099073;39449.60550394495;39836.41881183665;39848.40227396591;39897.800510997404;40001.199976000535;7484.588347640864;7610.238976102401;7616.885746713804;7617.885731714001;7627.847443051136;7137.464690148234;7310.780676579711;7362.674718550658;9460.385074970105;9715.659951901685;9727.75680607987;9801.656942007032;9805.705828825146;9807.705768826947;9810.362326448758;9608.08723171301;9664.516774161264;9677;9678.806423871554;9686;9379;9447.291453141042;9448.149666530046;9449.338546301762;9454.574544145462;37135.25729485395;37425.81287093574;37444.62555374439;37472.43791343132;37505;2993.9101826945225;3015.8492075396143;3066.1874603230162;3228.741700663941;3308.123347312964;27976.580351294746;28278.293042673893;28373;28871.278218044507;29427;3369.22507823202;3460.0830779843363;3460.8269586520823;3465.9480107798404;3510.4207805712026;241721;242879;243215;243528;243547;44572.3314150288;44944.10111797811;44954.77522612366;45143.77428112838;45191.548084518734;53076.73461632667;53210;53415.73292133515;53432.46567534275;53504.73247633737;13069.562348141697;13296.800547991788;13315.201087934754;13319.800202996963;13320.067595268238;8716.825663486821;10048.899511004942;10120.949395252977;10132.2907396483;10141.645042423628;12973.481060757653;14257.64355891111;14476.638084047983;14680.559583212307;15043.924780376028;5452.536534394541;5454.181872719124;5467.644603100785;5519.365272993577;5616.5787565932715;770.9653065611949;800.1358532784578;903.8779764731809;909.6361455417754;1008.470552959702;25305.493890122096;27090.90278225276;27374.452510949668;27708.30729231785;27881.302967425978;910.3809409601403;963.4556475591269;1005.406809982114;1033.7467320506523;1034.2088302448633;13576.93211533936;14508.1295122293;14579.125252484884;14599.708005839824;14686.265686715622;338739;338827;341259;342086;342724;47613.28580071302;47825.76087119542;47833;47840.282395764094;47914.52085479101;1078.4607696151768;1134.9092072634005;1166.0671462829703;1173.3781096019125;1179.4574495731888;25512;26599.202023939313;27000.86499567568;27605.30986725348;27758;41304;41341.58658413377;41456.58543414648;41543;41740.373894392214;247800;248932;249766;250211;250691;34690.82654586711;34993.30013399768;35521.644783551834;35542.64457355497;35865.64134358623;39713.67444464518;39835.2032959345;40509.59490405058;40781.59218407778;41200.38199426951;31461.528077078405;34936.65063349334;35006;35077;35486.82256588701;34418;34672.47991280082;34947;35047.47428788621;35831.82084089563;33942.490862637576;34233.657663423044;34259.82870085733;34296.82851585726;35196.648033519334;30217.69782302237;31569.21076973094;31656.841715791274;31810;31844;23743;24122.87938560366;24226.273211803673;24654.767261637204;24679.753202467746 03:39:33 INFO - PROCESS | 22807 | |2;jquery.html;337.09321924024357;354.22248165277193;357.44238987179995;361.34776728005954;384.44639718804916;12893;15544.84455155448;15731.606709832246;16702;16780.496585102435;15864.444744433948;15893.44372946947;16846.663066738656;16975.91512042438;17206.05366704831;4781.6891902026255;4812.783424745878;4903.950960490403;4926.137925862978;5034.043531728978;3650.4159334506485;3842.4236364545263;4919.1637421638225;5011.473795251501;5012.573931215833;5477.397486276506;5719;5740.052891272956;5835.35811060783;5836;5622.0041885131;5745;5809.302883653967;5814.970925145347;5822.505087067583;4975.179095449246;4992.176290911995;5015.799368025275;5023.547880690755;5023.773930173114;19197;19865.20539178431;20079.899600501903;20096.196152154043;20112.698309525367;1853.8887666740038;1912.8565357598236;1921.4812000759716;2033.6034473277716;2394.6546286192606;12416.627501174979;13057.34713264333;13499.122557033761;13522;13689.494155642871;1614.3946020242408;1672.3861473677837;1694.9745753813702;1700.5663555793317;1737.1922056243782;60310.69844650792;61246.08130877996;61600.38399616036;62055.379446205414;63638;9237.261019118454;9266.583003764847;9440.858387124199;9537.332386732862;9723.416595004323;12462.127651064338;12480.375981200903;12490.188137771198;12490.937545312398;12506.124571279923;6520.836979075466;6772.051912732221;6962.965185174143;6965.82585435358;6977.372036516738;6241.157443745127;6272.341404152589;6363.96818015907;6404.903926441107;6550.574212676161;6055.545834062463;6083.422074902877;6084.60450070744;6096.683260361035;6110.175126357884;1675.3717355991503;1692.636083242109;1710.7084151465565;1712.24661149094;1739;790.5770412829108;833.3125171733224;843.4812590256947;865.8613922691766;929.3912487320815;15403.152826594422;16211.027338359736;17130.143492825307;17750.91124544395;17971.820281797278;832.2759199496477;867.197841996151;887.724805310343;906.4515967839362;908.2416182487565;9303.395279306958;9431.528423578793;9701.90298097024;9949.353292035994;10179.796404071878;339249;340885;341736;349974;350358.4726293286;78128;78139.60930195313;80117;81210;82600;935.457434687893;954.5418199264253;989.6338354808767;991.5339790298548;991.548845275398;15197;15644;15983.760243596123;16038.198090095215;16321.918390408448;35437.40531676029;35697.28605427825;36908.63091369052;37356.81321593375;37665.62334376731;49427.258591120444;50326.74836625793;50397.74801125971;50719;51033.38632750469;7369.373603243785;7454.105507339154;7549.3583045439555;7578.317951384402;7801.063872335356;10579.418132002813;11641.243319184226;11783.705407364541;11834.585789497327;11865.525378984745;9986.751656042994;10543.736406589896;10617.734556635836;10660.89339106599;10773.24587278883;10133.341332813343;10179.03299186576;10364.481775911023;10487.737806554896;10529.4735263235;10127.240456965905;10363.430011349448;10396.896031039592;10714.25000249975;11280.605178818701;7612.3148916597775;7627.961860190663;7641.694332226649;7642;7913.881291780513;8938.284937205139;10455.215858810772;10476.895231047896;10665.680029599125;10714.73213169677 03:39:33 INFO - PROCESS | 22807 | |3;mootools.html;1181.8345431639577;1292.7802273613486;1307.1438207973777;1329.395125218026;1611.7743515907769;5926.644401335923;6428.132202152714;6746.460283177346;6756.493263005276;6878.759243426481;6774.356436138572;6833.829154271146;6844.212915514705;6846.7945961621235;6849.075374824397;1764.6470705858815;1824.936127235547;2050.5441136792856;2084.551821358408;2088.227355878327;2035.2571311471281;2091.3307741522717;2098.790120987904;2110.8522403431766;2112.8309735221223;2052.9281475148373;2053.3121404329568;2057.6501994660944;2061.2064355223197;2067.3694523170425;2056.496158441184;2071.140476702167;2072.7149167516086;2076.595063962528;2078.812906838392;2046.6827641715558;2048.764392094913;2065.163608738463;2069.1102825784906;2069.855110142291;6482.41658250755;6580.703868325889;6595.274519802866;6599.6700164992035;6600.834979125512;4149.8962525936795;4315.525292217853;4324.978375108104;4326.178026175016;4329.1558146161515;2630.18464276075;2793.1899749072745;2845.9430811383863;2850.4299140172047;2865.9856700716573;848.9023762267357;880.7181701855409;899.7120921305185;932.7807965128189;937.3625934364629;8858.645654173826;8946.776330591721;8973.416727912665;8983.056779038172;8996.730098097067;3621.9818900905325;3787.223619158066;3849.7690138591215;3850.403187505941;3972.245273398045;7761.146273909865;7812.53124812513;7823.491473054347;7824.726134585376;7827.295543401007;4314.41755363022;4322.0491491871735;4322.481302243688;4325.76208308546;4328.675349348811;3391.2878295558207;3502.141975216088;3805.200907809391;3912.5891781363116;3916.236333914916;3326.8336583170744;3328.234506063619;3436.43298855686;3441.5698037745283;3451.188970591909;1115.3976852499559;1148.3913525831322;1156.6009726644295;1161.3264306702092;1162.3382454180003;733.6735152856927;814.2793627639463;836.0886633569438;846.3018010141658;847.0597636623343;4909.803607855646;4914.115459217303;4954.529319714621;4961.305417241589;5048.7475626219275;378.10389377176267;379.89932667843044;391.8765588839506;396.28272826184696;401.3658419696872;3399.4560870261134;3399.5580574525648;3421.0934102462866;3421.3157368526395;3512.4906888501023;7736.4584479085925;8145.429819912668;8235.629396677044;8254.092049874509;8254.917450825535;8068.475549089408;8072.717454889051;8082.1513741057515;8082.595870206584;8136.14570470104;6257.9687101564205;6396.1045453636525;6476.6114033158165;6490.383413575702;6496.9025464617125;4783.712977221238;4797.424309082932;4900.26496025599;4912.778924948315;5060.924086138637;7447.962760186381;7471.701131954661;7538.434617403607;7543.660535276035;7548.622568871644;7223.530470519399;7445.255474452511;7634.656440460304;7637.88543171864;7642;5058.317127187783;5233.6074794389815;5799.971000144972;5907.054871220584;5915.08316210988;6130.63216207029;6412.519061070345;6413.454856337077;6527.869442611026;6528.249251336157;5910.4089591042275;5928.110783382527;5978.491828194652;6002.639841609517;6075.726592303268;5736.68448235351;5775.162601422686;5777.0179069557435;5796.1305804129715;5841.50347220474;5384.569234461155;5554.1946417770005;5594.832155035356;5661.943380566307;5663.943360566342;4224.746515209097;4253.27694291965;4290.227759003409;4306.849260275875;4484.529124442017;4161.313383291723;4165.729227600196;4221.472315960505;4249.787510624518;4390.1878152541885 03:39:33 INFO - PROCESS | 22807 | |4;prototype.html;279.46621952071547;284.0668404291901;286.4700304436792;289.77831958551724;291.65438954838504;4606.8617941461725;4716.504766999467;4746.905061898764;4762.523747625236;4790.778351520362;4591.724496530211;4649.9302510462285;4700.824793801549;4705.788239529221;4720.126776546342;3705.1848593309564;3711.4618380334837;3723.5531736191697;3723.7021038317007;3735.7198210134347;3512.6838584527386;3722.673329169269;3728.8694895678655;3736.0473079364724;3736.8878933632036;3536.416491278936;3584.4623306503972;3609.855605775766;3630.4191329387304;3678.889633311005;3638.7634803737938;3639.781613103209;3640.3993341098953;3642.908927276839;3650.2699460108083;3211.6948889855425;3228.6287076985977;3232.7898686585295;3233.822139782311;3234.579504664402;4390.473143222802;4596.7588751037365;4600.309953506967;4612.561806628399;4614.330922016323;4187.685923555746;4194.4337514435465;4194.937075943863;4198.769067701275;4216.451861258048;4933.038057578774;4962.975185124052;4963.45402005779;4971.33460290803;4975.651704380694;3546.680798728101;3557.5908770491465;3558.3275860345598;3564.7148228141687;3568.4468907319406;4954.925676114861;5076.492350764931;5130.589552835764;5146.6911985281;5170.7073231692075;3615.8610037838;3626.256617393428;3628.9455658165148;3629.637036296402;3632.8546858125906;3673.2653469306247;3675.5114178757644;3682.6133256007734;3690.0774806298427;3692.2061756722433;3928.332183528807;4118.567550407224;4192.266353388206;4193.643540299047;4204.1801848639225;4932.112219800399;4946.876328091755;4958.528939750718;4965.975170124127;4981.352424184833;1206.3666575048169;1217.4764851113928;1221.8209427902118;1222.6576558563615;1224.9755004899853;767.2902565127347;787.5471603827822;807.8182408957938;812.1594150054665;818.4066551749934;4281.486221653421;4288.335308027261;4313.202057619351;4333.508232766172;4352.521222665504;5000.524950129732;5016.720736212243;5028.874278143076;5032.3961124665275;5047.722375269322;4073.877783666495;4279.7218180818145;4319.179355922364;4337.9132417351475;4357.215701173819;2630.5528060229426;2637.947241055168;2650.4566563854364;2651.270900502377;2659.7473240042164;4559.202139625619;4638.966721107568;4659.790309436084;4678.76606169697;4681.180793361148;4843.903121937541;4996.700857777004;5039.44566097729;5067.189249720027;5069;4684.212893328464;4690.812367505261;4694.95305046952;4713.6464765142755;4714.104320179155;4988.950110498994;4990.351254337058;5006.799728010838;5024.698518088926;5025.572826309804;4598.885027874196;4807.735574543433;4829.309741590415;4878.829240976549;4893.266010098514;4625;4625.560571745679;4655.650826187982;4672.009913655332;4675.854415668047;3428.879989200466;3432.4508078707286;3434.7767395120236;3441.208522039995;3448.8620455181513;4748.691335063209;4939.851164743348;4947.90755777639;4994.2508623706735;4998.750062496788;4715.339852420595;4745.667803253739;4769.2130798417875;4772.427308722976;4799.496052914534;4672.369230153886;4708.97645511784;4740.905181896412;4763.666543341933;4820;4714.740689262124;4716.29255611661;4733.5266473352385;4737.099951009297;4738.763061846963;4558.518481493462;4696.577308042292;5007.7746501408255;5011.223260394645;5018.548330650259;4887.802488390367;4890.951090489049;4892.926606100982;4896.608271338213;4911.140550403594 03:39:33 INFO - PROCESS | 22807 | |5;yui.html;647.8671872266185;663.9004149377596;689.6103701408707;727.2436665867498;732.9120505539332;12070.577529786447;13016.674583135426;13095.083344165912;13106.41021154048;13116.737665246701;12953.35233238339;13135.737285254289;13145.079844410895;13152.73694526109;13160.144590601603;622.2843729710846;637.9011253255729;748.5620911766623;757.223845558303;779.4777499075605;774.4733581164805;774.9612519374037;779.5050143159107;780.2938340801584;780.3640033372783;820.659426338069;821.1460081515218;822.8354329134168;823.2056065896409;823.2343920154254;652.4617190817595;815.9306458950996;816.5508970066439;817.1787353709543;817.4237162800241;495.5044955044955;577.6591810831587;599.1851082527759;601.1523751510349;604.1722839709582;12869.034822388357;12880.484780608764;12946.611601651966;12987.675308117277;13028.218306901616;11822.231554948901;12193;12431.37843107841;12466;12616;11257.324560526395;11749.4712737927;11909.106816988673;12049.93975030128;12077.214981026293;4084.7957602119777;4094.5905409459115;4140;4140.937885931713;4270.359446083081;59517.40482595162;60746.696266518826;62286.68856655733;62327.37672623261;63204;9803.803923921481;9938.254630902567;10053.798924021625;10065.496725163712;10142.898571014195;18595.070246487623;18622.441326760218;18631.906840465712;18639.90680046591;18659.720104198448;6631.3700198481065;6764.864702705919;6783.660816959133;6836.151440919312;6859.17689877208;3663.3222853772136;3705.8332375043187;3736.925261494809;3859.2281543691374;3879.8448062077764;2645.8677066146615;2706.6075419064127;2727.972720272812;2730.331068888135;2732.699403065661;471.3942583779826;480.2987638048488;486.3264378835268;490.9582685471775;493.08778759295734;458.12269503900325;460.2842579788461;501.51603702426604;566.5043087298614;568.8919105369966;7607.885881711779;7724.459287849797;7792.805179870548;7907.327877130509;8016.198380162054;439.6109443142778;539.0889396919194;543.8912217556425;557.8493806672176;567.2597260574989;3665.376885929398;3733.250793777552;3738.6635202831876;3778.905527361838;3798.9620103798607;68525.65737171282;69973.3002669977;70111.64944175247;70570.2942970574;71892;50061;54867;59169;60627.20544686241;61657.38342616606;53983;54392.184117237484;54716.72641636767;54926.72536637291;54970;6873.725050997904;6885.380315771605;7173.282671732785;7176.7488137914925;7691.230876912264;31483.370332593677;33182.502262466565;33530.32939341248;37264.44103338398;40027.599724002386;46997.530024699314;47684.5231547694;47997.5200248007;49677.25484117669;51057.74471127621;9044.954775226082;9308.627654893728;10700.518476668723;11472.369019703663;11726.88273117292;10724.302920310154;10758.8386174209;10961.890381096087;11441.427928603704;11970.76058478843;12349.814752778895;12484.188527745668;12610.813832760683;12875.356232188165;13217.40521676546;11367.829482557603;11774.529018839494;11851.466683999413;12168.878311216775;12654;11243.7751244973;12073.215241009306;12201;12686.238825670489;12974.675633109247;9593.808123837345;9634.71095867125;10382.532786024496;10581.10060644823;10667.946660266649;10107.49462526856;10453.320534165256;10475.371477711362;10571.2600117991;10724.195685323788 03:39:33 INFO - PROCESS | 22807 | __end_tp_report 03:39:33 INFO - PROCESS | 22807 | __start_cc_report 03:39:33 INFO - PROCESS | 22807 | _x_x_mozilla_cycle_collect,2061 03:39:33 INFO - PROCESS | 22807 | __end_cc_report 03:39:33 INFO - PROCESS | 22807 | __startTimestamp1481110773340__endTimestamp 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | ------- Summary: start ------- 03:39:33 INFO - PROCESS | 22807 | Number of tests: 6 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | [#0] dojo.html Cycles:165 Average:4581.03 Median:4713.58 stddev:483.00 (10.2%) stddev-sans-first:457.60 03:39:33 INFO - PROCESS | 22807 | Values: 2555.5 2589.2 2612.8 2623.6 2630.1 4517.3 4558.7 4666.5 4707.9 4713.6 4550.5 4580.6 4595.5 4623.6 4641.2 4189.2 4202.1 4243.4 4267.4 4381.7 4271.3 4323.4 4355.5 4364.1 4383.2 4118.3 4260.4 4275.4 4346.0 4367.3 4128.5 4169.3 4207.4 4221.9 4243.0 4212.7 4214.1 4214.2 4244.8 4271.6 4581.0 4582.9 4599.0 4622.2 4639.9 4839.3 4874.8 4883.0 4883.6 4934.4 4953.6 5021.1 5033.6 5063.8 5084.3 4669.7 4675.0 4681.0 4682.9 4734.3 4914.8 4952.3 5123.7 5128.7 5166.6 4804.7 4839.0 4850.9 4864.9 4958.2 4978.8 4986.3 4988.6 4988.8 5034.0 4936.1 4939.0 4943.4 4945.4 5001.4 4784.1 4794.0 4795.9 4797.8 4843.0 4045.4 4066.3 4105.8 4105.8 4106.7 3638.5 3661.0 3664.6 3695.5 3701.1 4247.2 4282.5 4320.1 4379.6 4391.7 5037.2 5092.0 5093.8 5117.0 5140.3 4352.3 4379.3 4383.7 4383.7 4423.2 4307.5 4345.5 4442.9 4458.5 4534.0 4641.0 4656.7 4695.9 4697.2 4759.8 5016.7 5021.7 5025.1 5030.0 5071.1 4708.5 4710.1 4713.8 4716.4 4766.8 4732.0 4756.1 4846.8 4890.4 4890.5 4998.2 5000.8 5004.4 5007.5 5046.7 4827.6 4864.0 4866.0 4867.6 4905.6 4683.2 4709.7 4713.9 4787.9 4912.0 4716.9 4727.1 4727.6 4730.6 4734.1 4775.7 4795.8 4806.4 4818.5 4819.9 4694.8 4728.1 4763.8 4767.8 4775.7 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | [#1] ext.html Cycles:180 Average:43418.19 Median:35026.74 stddev:73632.95 (210.2%) stddev-sans-first:73769.18 03:39:33 INFO - PROCESS | 22807 | Values: 555.3 580.3 588.6 589.3 600.7 28291.0 30400.7 38207.4 39560.8 39627.8 39449.6 39836.4 39848.4 39897.8 40001.2 7484.6 7610.2 7616.9 7617.9 7627.8 7137.5 7310.8 7362.7 9460.4 9715.7 9727.8 9801.7 9805.7 9807.7 9810.4 9608.1 9664.5 9677.0 9678.8 9686.0 9379.0 9447.3 9448.1 9449.3 9454.6 37135.3 37425.8 37444.6 37472.4 37505.0 2993.9 3015.8 3066.2 3228.7 3308.1 27976.6 28278.3 28373.0 28871.3 29427.0 3369.2 3460.1 3460.8 3465.9 3510.4 241721.0 242879.0 243215.0 243528.0 243547.0 44572.3 44944.1 44954.8 45143.8 45191.5 53076.7 53210.0 53415.7 53432.5 53504.7 13069.6 13296.8 13315.2 13319.8 13320.1 8716.8 10048.9 10120.9 10132.3 10141.6 12973.5 14257.6 14476.6 14680.6 15043.9 5452.5 5454.2 5467.6 5519.4 5616.6 771.0 800.1 903.9 909.6 1008.5 25305.5 27090.9 27374.5 27708.3 27881.3 910.4 963.5 1005.4 1033.7 1034.2 13576.9 14508.1 14579.1 14599.7 14686.3 338739.0 338827.0 341259.0 342086.0 342724.0 47613.3 47825.8 47833.0 47840.3 47914.5 1078.5 1134.9 1166.1 1173.4 1179.5 25512.0 26599.2 27000.9 27605.3 27758.0 41304.0 41341.6 41456.6 41543.0 41740.4 247800.0 248932.0 249766.0 250211.0 250691.0 34690.8 34993.3 35521.6 35542.6 35865.6 39713.7 39835.2 40509.6 40781.6 41200.4 31461.5 34936.7 35006.0 35077.0 35486.8 34418.0 34672.5 34947.0 35047.5 35831.8 33942.5 34233.7 34259.8 34296.8 35196.6 30217.7 31569.2 31656.8 31810.0 31844.0 23743.0 24122.9 24226.3 24654.8 24679.8 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | [#2] jquery.html Cycles:180 Average:22914.14 Median:4312.06 stddev:57115.82 (1324.6%) stddev-sans-first:57250.89 03:39:33 INFO - PROCESS | 22807 | Values: 337.1 354.2 357.4 361.3 384.4 12893.0 15544.8 15731.6 16702.0 16780.5 15864.4 15893.4 16846.7 16975.9 17206.1 4781.7 4812.8 4904.0 4926.1 5034.0 3650.4 3842.4 4919.2 5011.5 5012.6 5477.4 5719.0 5740.1 5835.4 5836.0 5622.0 5745.0 5809.3 5815.0 5822.5 4975.2 4992.2 5015.8 5023.5 5023.8 19197.0 19865.2 20079.9 20096.2 20112.7 1853.9 1912.9 1921.5 2033.6 2394.7 12416.6 13057.3 13499.1 13522.0 13689.5 1614.4 1672.4 1695.0 1700.6 1737.2 60310.7 61246.1 61600.4 62055.4 63638.0 9237.3 9266.6 9440.9 9537.3 9723.4 12462.1 12480.4 12490.2 12490.9 12506.1 6520.8 6772.1 6963.0 6965.8 6977.4 6241.2 6272.3 6364.0 6404.9 6550.6 6055.5 6083.4 6084.6 6096.7 6110.2 1675.4 1692.6 1710.7 1712.2 1739.0 790.6 833.3 843.5 865.9 929.4 15403.2 16211.0 17130.1 17750.9 17971.8 832.3 867.2 887.7 906.5 908.2 9303.4 9431.5 9701.9 9949.4 10179.8 339249.0 340885.0 341736.0 349974.0 350358.5 78128.0 78139.6 80117.0 81210.0 82600.0 935.5 954.5 989.6 991.5 991.5 15197.0 15644.0 15983.8 16038.2 16321.9 35437.4 35697.3 36908.6 37356.8 37665.6 49427.3 50326.7 50397.7 50719.0 51033.4 7369.4 7454.1 7549.4 7578.3 7801.1 10579.4 11641.2 11783.7 11834.6 11865.5 9986.8 10543.7 10617.7 10660.9 10773.2 10133.3 10179.0 10364.5 10487.7 10529.5 10127.2 10363.4 10396.9 10714.3 11280.6 7612.3 7628.0 7641.7 7642.0 7913.9 8938.3 10455.2 10476.9 10665.7 10714.7 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | [#3] mootools.html Cycles:180 Average:4519.25 Median:4934.32 stddev:2389.65 (48.4%) stddev-sans-first:2383.19 03:39:33 INFO - PROCESS | 22807 | Values: 1181.8 1292.8 1307.1 1329.4 1611.8 5926.6 6428.1 6746.5 6756.5 6878.8 6774.4 6833.8 6844.2 6846.8 6849.1 1764.6 1824.9 2050.5 2084.6 2088.2 2035.3 2091.3 2098.8 2110.9 2112.8 2052.9 2053.3 2057.7 2061.2 2067.4 2056.5 2071.1 2072.7 2076.6 2078.8 2046.7 2048.8 2065.2 2069.1 2069.9 6482.4 6580.7 6595.3 6599.7 6600.8 4149.9 4315.5 4325.0 4326.2 4329.2 2630.2 2793.2 2845.9 2850.4 2866.0 848.9 880.7 899.7 932.8 937.4 8858.6 8946.8 8973.4 8983.1 8996.7 3622.0 3787.2 3849.8 3850.4 3972.2 7761.1 7812.5 7823.5 7824.7 7827.3 4314.4 4322.0 4322.5 4325.8 4328.7 3391.3 3502.1 3805.2 3912.6 3916.2 3326.8 3328.2 3436.4 3441.6 3451.2 1115.4 1148.4 1156.6 1161.3 1162.3 733.7 814.3 836.1 846.3 847.1 4909.8 4914.1 4954.5 4961.3 5048.7 378.1 379.9 391.9 396.3 401.4 3399.5 3399.6 3421.1 3421.3 3512.5 7736.5 8145.4 8235.6 8254.1 8254.9 8068.5 8072.7 8082.2 8082.6 8136.1 6258.0 6396.1 6476.6 6490.4 6496.9 4783.7 4797.4 4900.3 4912.8 5060.9 7448.0 7471.7 7538.4 7543.7 7548.6 7223.5 7445.3 7634.7 7637.9 7642.0 5058.3 5233.6 5800.0 5907.1 5915.1 6130.6 6412.5 6413.5 6527.9 6528.2 5910.4 5928.1 5978.5 6002.6 6075.7 5736.7 5775.2 5777.0 5796.1 5841.5 5384.6 5554.2 5594.8 5661.9 5663.9 4224.7 4253.3 4290.2 4306.8 4484.5 4161.3 4165.7 4221.5 4249.8 4390.2 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | [#4] prototype.html Cycles:180 Average:4049.21 Median:4625.28 stddev:1171.27 (25.3%) stddev-sans-first:1139.87 03:39:33 INFO - PROCESS | 22807 | Values: 279.5 284.1 286.5 289.8 291.7 4606.9 4716.5 4746.9 4762.5 4790.8 4591.7 4649.9 4700.8 4705.8 4720.1 3705.2 3711.5 3723.6 3723.7 3735.7 3512.7 3722.7 3728.9 3736.0 3736.9 3536.4 3584.5 3609.9 3630.4 3678.9 3638.8 3639.8 3640.4 3642.9 3650.3 3211.7 3228.6 3232.8 3233.8 3234.6 4390.5 4596.8 4600.3 4612.6 4614.3 4187.7 4194.4 4194.9 4198.8 4216.5 4933.0 4963.0 4963.5 4971.3 4975.7 3546.7 3557.6 3558.3 3564.7 3568.4 4954.9 5076.5 5130.6 5146.7 5170.7 3615.9 3626.3 3628.9 3629.6 3632.9 3673.3 3675.5 3682.6 3690.1 3692.2 3928.3 4118.6 4192.3 4193.6 4204.2 4932.1 4946.9 4958.5 4966.0 4981.4 1206.4 1217.5 1221.8 1222.7 1225.0 767.3 787.5 807.8 812.2 818.4 4281.5 4288.3 4313.2 4333.5 4352.5 5000.5 5016.7 5028.9 5032.4 5047.7 4073.9 4279.7 4319.2 4337.9 4357.2 2630.6 2637.9 2650.5 2651.3 2659.7 4559.2 4639.0 4659.8 4678.8 4681.2 4843.9 4996.7 5039.4 5067.2 5069.0 4684.2 4690.8 4695.0 4713.6 4714.1 4989.0 4990.4 5006.8 5024.7 5025.6 4598.9 4807.7 4829.3 4878.8 4893.3 4625.0 4625.6 4655.7 4672.0 4675.9 3428.9 3432.5 3434.8 3441.2 3448.9 4748.7 4939.9 4947.9 4994.3 4998.8 4715.3 4745.7 4769.2 4772.4 4799.5 4672.4 4709.0 4740.9 4763.7 4820.0 4714.7 4716.3 4733.5 4737.1 4738.8 4558.5 4696.6 5007.8 5011.2 5018.5 4887.8 4891.0 4892.9 4896.6 4911.1 03:39:33 INFO - PROCESS | 22807 | 03:39:33 INFO - PROCESS | 22807 | [#5] yui.html Cycles:180 Average:15009.12 Median:459.20 stddev:18964.62 (4129.9%) stddev-sans-first:18987.16 03:39:33 INFO - PROCESS | 22807 | Values: 647.9 663.9 689.6 727.2 732.9 12070.6 13016.7 13095.1 13106.4 13116.7 12953.4 13135.7 13145.1 13152.7 13160.1 622.3 637.9 748.6 757.2 779.5 774.5 775.0 779.5 780.3 780.4 820.7 821.1 822.8 823.2 823.2 652.5 815.9 816.6 817.2 817.4 495.5 577.7 599.2 601.2 604.2 12869.0 12880.5 12946.6 12987.7 13028.2 11822.2 12193.0 12431.4 12466.0 12616.0 11257.3 11749.5 11909.1 12049.9 12077.2 4084.8 4094.6 4140.0 4140.9 4270.4 59517.4 60746.7 62286.7 62327.4 63204.0 9803.8 9938.3 10053.8 10065.5 10142.9 18595.1 18622.4 18631.9 18639.9 18659.7 6631.4 6764.9 6783.7 6836.2 6859.2 3663.3 3705.8 3736.9 3859.2 3879.8 2645.9 2706.6 2728.0 2730.3 2732.7 471.4 480.3 486.3 491.0 493.1 458.1 460.3 501.5 566.5 568.9 7607.9 7724.5 7792.8 7907.3 8016.2 439.6 539.1 543.9 557.8 567.3 3665.4 3733.3 3738.7 3778.9 3799.0 68525.7 69973.3 70111.6 70570.3 71892.0 50061.0 54867.0 59169.0 60627.2 61657.4 53983.0 54392.2 54716.7 54926.7 54970.0 6873.7 6885.4 7173.3 7176.7 7691.2 31483.4 33182.5 33530.3 37264.4 40027.6 46997.5 47684.5 47997.5 49677.3 51057.7 9045.0 9308.6 10700.5 11472.4 11726.9 10724.3 10758.8 10961.9 11441.4 11970.8 12349.8 12484.2 12610.8 12875.4 13217.4 11367.8 11774.5 11851.5 12168.9 12654.0 11243.8 12073.2 12201.0 12686.2 12974.7 9593.8 9634.7 10382.5 10581.1 10667.9 10107.5 10453.3 10475.4 10571.3 10724.2 03:39:33 INFO - PROCESS | 22807 | -------- Summary: end -------- 03:39:33 INFO - PROCESS | 22807 | 03:39:34 INFO - TEST-INFO | 22807: exit 0 03:39:34 INFO - TEST-OK | dromaeo_css | took 1122808ms 03:39:34 INFO - TEST-START | kraken 03:39:34 INFO - operating with platform_type : linux_ 03:39:34 INFO - Initialising browser for kraken test... 03:39:34 INFO - TEST-INFO | started process 23114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjM_F7/profile http://localhost:39218/getInfo.html) 03:39:38 INFO - PROCESS | 23114 | __metrics Screen width/height:1600/1200 03:39:38 INFO - PROCESS | 23114 | colorDepth:24 03:39:38 INFO - PROCESS | 23114 | Browser inner width/height: 1024/697 03:39:38 INFO - PROCESS | 23114 | __metrics 03:39:39 INFO - PROCESS | 23114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:39:39 INFO - PROCESS | 23114 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:39 INFO - PROCESS | 23114 | console.error: PushService: 03:39:39 INFO - PROCESS | 23114 | stateChangeProcessEnqueue: Error transitioning state 03:39:39 INFO - PROCESS | 23114 | UnknownError 03:39:40 INFO - TEST-INFO | 23114: exit 0 03:39:40 INFO - Browser initialized. 03:39:40 INFO - Running cycle 1/1 for kraken test... 03:39:40 INFO - TEST-INFO | started process 23195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNjM_F7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:52 INFO - PROCESS | 23195 | RSS: Main: 173793280 03:39:52 INFO - PROCESS | 23195 | 03:39:55 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:56 INFO - PROCESS | 23195 | RSS: Main: 240742400 03:39:56 INFO - PROCESS | 23195 | 03:39:59 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-dft) 03:39:59 INFO - PROCESS | 23195 | RSS: Main: 218005504 03:39:59 INFO - PROCESS | 23195 | 03:40:03 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-fft) 03:40:03 INFO - PROCESS | 23195 | RSS: Main: 300384256 03:40:03 INFO - PROCESS | 23195 | 03:40:05 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-oscillator) 03:40:06 INFO - PROCESS | 23195 | RSS: Main: 210403328 03:40:06 INFO - PROCESS | 23195 | 03:40:08 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:09 INFO - PROCESS | 23195 | RSS: Main: 214831104 03:40:09 INFO - PROCESS | 23195 | 03:40:12 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39218/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:13 INFO - PROCESS | 23195 | RSS: Main: 254386176 03:40:13 INFO - PROCESS | 23195 | 03:40:16 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39218/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:17 INFO - PROCESS | 23195 | RSS: Main: 248233984 03:40:17 INFO - PROCESS | 23195 | 03:40:19 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39218/tests/kraken/driver.html?testName=json-parse-financial) 03:40:20 INFO - PROCESS | 23195 | RSS: Main: 250085376 03:40:20 INFO - PROCESS | 23195 | 03:40:22 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:22 INFO - PROCESS | 23195 | RSS: Main: 213663744 03:40:22 INFO - PROCESS | 23195 | 03:40:24 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:25 INFO - PROCESS | 23195 | RSS: Main: 220782592 03:40:25 INFO - PROCESS | 23195 | 03:40:27 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:28 INFO - PROCESS | 23195 | RSS: Main: 229453824 03:40:28 INFO - PROCESS | 23195 | 03:40:31 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:32 INFO - PROCESS | 23195 | RSS: Main: 239017984 03:40:32 INFO - PROCESS | 23195 | 03:40:35 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:35 INFO - PROCESS | 23195 | RSS: Main: 234971136 03:40:35 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39218/tests/kraken/driver.html?testName=ai-astar) 03:40:37 INFO - PROCESS | 23195 | RSS: Main: 286146560 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | __start_tp_report 03:40:37 INFO - PROCESS | 23195 | _x_x_mozilla_page_load 03:40:37 INFO - PROCESS | 23195 | _x_x_mozilla_page_load_details 03:40:37 INFO - PROCESS | 23195 | |i|pagename|runs| 03:40:37 INFO - PROCESS | 23195 | |0;ai-astar;109;116;116;116;115;116;116;116;115;115 03:40:37 INFO - PROCESS | 23195 | |1;audio-beat-detection;151;128;129;173;133;129;128;130;154;129 03:40:37 INFO - PROCESS | 23195 | |2;audio-dft;164;163;164;163;162;165;162;162;163;161 03:40:37 INFO - PROCESS | 23195 | |3;audio-fft;77;76;77;115;77;77;78;76;91;77 03:40:37 INFO - PROCESS | 23195 | |4;audio-oscillator;83;83;105;84;84;85;98;83;83;105 03:40:37 INFO - PROCESS | 23195 | |5;imaging-gaussian-blur;117;116;117;118;117;117;117;117;116;117 03:40:37 INFO - PROCESS | 23195 | |6;imaging-darkroom;147;146;145;146;147;146;146;146;146;146 03:40:37 INFO - PROCESS | 23195 | |7;imaging-desaturate;96;96;95;95;95;95;96;95;95;95 03:40:37 INFO - PROCESS | 23195 | |8;json-parse-financial;66;65;65;65;67;66;67;66;66;67 03:40:37 INFO - PROCESS | 23195 | |9;json-stringify-tinderbox;65;67;67;67;66;66;66;67;67;67 03:40:37 INFO - PROCESS | 23195 | |10;stanford-crypto-aes;86;86;89;95;86;85;86;89;93;85 03:40:37 INFO - PROCESS | 23195 | |11;stanford-crypto-ccm;152;140;150;141;138;142;142;146;186;173 03:40:37 INFO - PROCESS | 23195 | |12;stanford-crypto-pbkdf2;181;186;183;181;180;181;189;178;182;184 03:40:37 INFO - PROCESS | 23195 | |13;stanford-crypto-sha256-iterative;69;68;70;76;69;67;71;68;67;68 03:40:37 INFO - PROCESS | 23195 | __end_tp_report 03:40:37 INFO - PROCESS | 23195 | __start_cc_report 03:40:37 INFO - PROCESS | 23195 | _x_x_mozilla_cycle_collect,1975 03:40:37 INFO - PROCESS | 23195 | __end_cc_report 03:40:37 INFO - PROCESS | 23195 | __startTimestamp1481110837708__endTimestamp 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | ------- Summary: start ------- 03:40:37 INFO - PROCESS | 23195 | Number of tests: 14 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:2.16 (1.9%) stddev-sans-first:0.50 03:40:37 INFO - PROCESS | 23195 | Values: 109.0 116.0 116.0 116.0 115.0 116.0 116.0 116.0 115.0 115.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:131.50 stddev:15.56 (11.8%) stddev-sans-first:15.83 03:40:37 INFO - PROCESS | 23195 | Values: 151.0 128.0 129.0 173.0 133.0 129.0 128.0 130.0 154.0 129.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 03:40:37 INFO - PROCESS | 23195 | Values: 164.0 163.0 164.0 163.0 162.0 165.0 162.0 162.0 163.0 161.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:12.40 (16.1%) stddev-sans-first:13.01 03:40:37 INFO - PROCESS | 23195 | Values: 77.0 76.0 77.0 115.0 77.0 77.0 78.0 76.0 91.0 77.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.50 stddev:9.44 (11.3%) stddev-sans-first:9.73 03:40:37 INFO - PROCESS | 23195 | Values: 83.0 83.0 105.0 84.0 84.0 85.0 98.0 83.0 83.0 105.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:40:37 INFO - PROCESS | 23195 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 03:40:37 INFO - PROCESS | 23195 | Values: 147.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:40:37 INFO - PROCESS | 23195 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 03:40:37 INFO - PROCESS | 23195 | Values: 66.0 65.0 65.0 65.0 67.0 66.0 67.0 66.0 66.0 67.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 03:40:37 INFO - PROCESS | 23195 | Values: 65.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 67.0 67.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.50 stddev:3.50 (4.0%) stddev-sans-first:3.63 03:40:37 INFO - PROCESS | 23195 | Values: 86.0 86.0 89.0 95.0 86.0 85.0 86.0 89.0 93.0 85.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:148.00 stddev:15.94 (10.8%) stddev-sans-first:16.91 03:40:37 INFO - PROCESS | 23195 | Values: 152.0 140.0 150.0 141.0 138.0 142.0 142.0 146.0 186.0 173.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:182.50 stddev:3.17 (1.7%) stddev-sans-first:3.32 03:40:37 INFO - PROCESS | 23195 | Values: 181.0 186.0 183.0 181.0 180.0 181.0 189.0 178.0 182.0 184.0 03:40:37 INFO - PROCESS | 23195 | 03:40:37 INFO - PROCESS | 23195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.67 (3.9%) stddev-sans-first:2.83 03:40:37 INFO - PROCESS | 23195 | Values: 69.0 68.0 70.0 76.0 69.0 67.0 71.0 68.0 67.0 68.0 03:40:37 INFO - PROCESS | 23195 | -------- Summary: end -------- 03:40:37 INFO - PROCESS | 23195 | 03:40:39 INFO - TEST-INFO | 23195: exit 0 03:40:39 INFO - TEST-OK | kraken | took 64785ms 03:40:39 INFO - SUITE-END | took 1187s 03:40:39 INFO - Completed test suite (00:19:47) 03:40:39 INFO - javascript benchmark 03:40:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2555.514452254072, 2589.197348821864, 2612.7648511633956, 2623.5802271636544, 2630.118910165095, 4517.277235642289, 4558.726476411418, 4666.5333466653365, 4707.929381059283, 4713.5757781799675, 4550.49944506104, 4580.610648094916, 4595.540445955403, 4623.606993405556, 4641.2341963576055, 4189.22499337622, 4202.117555313388, 4243.448351714273, 4267.4452321198205, 4381.737095774248, 4271.273883439807, 4323.4163387942535, 4355.54266801986, 4364.061726728753, 4383.211022016036, 4118.341065429517, 4260.4248426462655, 4275.380069889879, 4345.956540434587, 4367.301231802912, 4128.504579450455, 4169.2703776839235, 4207.389928460356, 4221.91556168878, 4243.045314804144, 4212.68404869636, 4214.136102099093, 4214.157168566299, 4244.766537840417, 4271.615554600101, 4581.037982023779, 4582.908341833178, 4599.034202817413, 4622.237330840408, 4639.930401043987, 4839.298301746262, 4874.780634871439, 4883.047805677894, 4883.584895283905, 4934.425904247947, 4953.628477864138, 5021.146405111103, 5033.597312215014, 5063.822766203202, 5084.313617661605, 4669.719816811003, 4674.976625116853, 4681.040386720714, 4682.929756053662, 4734.337192793012, 4914.778834952435, 4952.306677065214, 5123.7438128093445, 5128.7179205144075, 5166.5866730661455, 4804.711717296974, 4838.95161048392, 4850.927236091461, 4864.927026094611, 4958.231474121517, 4978.751062446863, 4986.252062190628, 4988.625853061035, 4988.800447982113, 5034.0, 4936.136176169156, 4939.036887806843, 4943.3573635427165, 4945.431275403303, 5001.424836143818, 4784.091022705675, 4794.041191761592, 4795.880102997453, 4797.784099715521, 4842.95157048425, 4045.37296719009, 4066.3087275163293, 4105.753654780723, 4105.835766569304, 4106.691998100155, 3638.508801311789, 3661.029827095822, 3664.59689434162, 3695.5011073504734, 3701.0932321581386, 4247.214265360918, 4282.464691913511, 4320.071184695243, 4379.562043795659, 4391.692581519263, 5037.168867136955, 5092.0, 5093.821716239914, 5117.002184574047, 5140.254663073833, 4352.303631418958, 4379.277419225792, 4383.671224658099, 4383.693141480129, 4423.20382331177, 4307.461567304087, 4345.456817897762, 4442.8667139985855, 4458.464984201916, 4534.0, 4641.048585039991, 4656.650751193606, 4695.896464330811, 4697.201475749062, 4759.785809638505, 5016.749162541785, 5021.748912554284, 5025.145725226647, 5030.0, 5071.061853557104, 4708.482066972561, 4710.128626204163, 4713.7643117844655, 4716.434027916672, 4766.833160839354, 4732.029933863619, 4756.096341695067, 4846.80612775485, 4890.437599676083, 4890.486498917705, 4998.2002879539095, 5000.774965126505, 5004.3994720633755, 5007.474215207497, 5046.722430266371, 4827.637927155548, 4864.0, 4866.0, 4867.561919427127, 4905.632077594123, 4683.15703173432, 4709.670323077488, 4713.905721885474, 4787.928181077217, 4911.950880491149, 4716.929246061243, 4727.078219747116, 4727.598154156935, 4730.6215502759005, 4734.07685501324, 4775.665703400868, 4795.808167673394, 4806.351142595705, 4818.469968303414, 4819.855404337875, 4694.812207511798, 4728.101660684459, 4763.785629646605, 4767.809287628456, 4775.6657034007285], "value": 4550.224481870113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3030946162565, 580.3471095018105, 588.5674029588251, 589.292848581702, 600.6696317025635, 28291.0, 30400.695993040063, 38207.426888596696, 39560.802195989054, 39627.80186099073, 39449.60550394495, 39836.41881183665, 39848.40227396591, 39897.800510997404, 40001.199976000535, 7484.588347640864, 7610.238976102401, 7616.885746713804, 7617.885731714001, 7627.847443051136, 7137.464690148234, 7310.780676579711, 7362.674718550658, 9460.385074970105, 9715.659951901685, 9727.75680607987, 9801.656942007032, 9805.705828825146, 9807.705768826947, 9810.362326448758, 9608.08723171301, 9664.516774161264, 9677.0, 9678.806423871554, 9686.0, 9379.0, 9447.291453141042, 9448.149666530046, 9449.338546301762, 9454.574544145462, 37135.25729485395, 37425.81287093574, 37444.62555374439, 37472.43791343132, 37505.0, 2993.9101826945225, 3015.8492075396143, 3066.1874603230162, 3228.741700663941, 3308.123347312964, 27976.580351294746, 28278.293042673893, 28373.0, 28871.278218044507, 29427.0, 3369.22507823202, 3460.0830779843363, 3460.8269586520823, 3465.9480107798404, 3510.4207805712026, 241721.0, 242879.0, 243215.0, 243528.0, 243547.0, 44572.3314150288, 44944.10111797811, 44954.77522612366, 45143.77428112838, 45191.548084518734, 53076.73461632667, 53210.0, 53415.73292133515, 53432.46567534275, 53504.73247633737, 13069.562348141697, 13296.800547991788, 13315.201087934754, 13319.800202996963, 13320.067595268238, 8716.825663486821, 10048.899511004942, 10120.949395252977, 10132.2907396483, 10141.645042423628, 12973.481060757653, 14257.64355891111, 14476.638084047983, 14680.559583212307, 15043.924780376028, 5452.536534394541, 5454.181872719124, 5467.644603100785, 5519.365272993577, 5616.5787565932715, 770.9653065611949, 800.1358532784578, 903.8779764731809, 909.6361455417754, 1008.470552959702, 25305.493890122096, 27090.90278225276, 27374.452510949668, 27708.30729231785, 27881.302967425978, 910.3809409601403, 963.4556475591269, 1005.406809982114, 1033.7467320506523, 1034.2088302448633, 13576.93211533936, 14508.1295122293, 14579.125252484884, 14599.708005839824, 14686.265686715622, 338739.0, 338827.0, 341259.0, 342086.0, 342724.0, 47613.28580071302, 47825.76087119542, 47833.0, 47840.282395764094, 47914.52085479101, 1078.4607696151768, 1134.9092072634005, 1166.0671462829703, 1173.3781096019125, 1179.4574495731888, 25512.0, 26599.202023939313, 27000.86499567568, 27605.30986725348, 27758.0, 41304.0, 41341.58658413377, 41456.58543414648, 41543.0, 41740.373894392214, 247800.0, 248932.0, 249766.0, 250211.0, 250691.0, 34690.82654586711, 34993.30013399768, 35521.644783551834, 35542.64457355497, 35865.64134358623, 39713.67444464518, 39835.2032959345, 40509.59490405058, 40781.59218407778, 41200.38199426951, 31461.528077078405, 34936.65063349334, 35006.0, 35077.0, 35486.82256588701, 34418.0, 34672.47991280082, 34947.0, 35047.47428788621, 35831.82084089563, 33942.490862637576, 34233.657663423044, 34259.82870085733, 34296.82851585726, 35196.648033519334, 30217.69782302237, 31569.21076973094, 31656.841715791274, 31810.0, 31844.0, 23743.0, 24122.87938560366, 24226.273211803673, 24654.767261637204, 24679.753202467746], "value": 17109.144002510024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.09321924024357, 354.22248165277193, 357.44238987179995, 361.34776728005954, 384.44639718804916, 12893.0, 15544.84455155448, 15731.606709832246, 16702.0, 16780.496585102435, 15864.444744433948, 15893.44372946947, 16846.663066738656, 16975.91512042438, 17206.05366704831, 4781.6891902026255, 4812.783424745878, 4903.950960490403, 4926.137925862978, 5034.043531728978, 3650.4159334506485, 3842.4236364545263, 4919.1637421638225, 5011.473795251501, 5012.573931215833, 5477.397486276506, 5719.0, 5740.052891272956, 5835.35811060783, 5836.0, 5622.0041885131, 5745.0, 5809.302883653967, 5814.970925145347, 5822.505087067583, 4975.179095449246, 4992.176290911995, 5015.799368025275, 5023.547880690755, 5023.773930173114, 19197.0, 19865.20539178431, 20079.899600501903, 20096.196152154043, 20112.698309525367, 1853.8887666740038, 1912.8565357598236, 1921.4812000759716, 2033.6034473277716, 2394.6546286192606, 12416.627501174979, 13057.34713264333, 13499.122557033761, 13522.0, 13689.494155642871, 1614.3946020242408, 1672.3861473677837, 1694.9745753813702, 1700.5663555793317, 1737.1922056243782, 60310.69844650792, 61246.08130877996, 61600.38399616036, 62055.379446205414, 63638.0, 9237.261019118454, 9266.583003764847, 9440.858387124199, 9537.332386732862, 9723.416595004323, 12462.127651064338, 12480.375981200903, 12490.188137771198, 12490.937545312398, 12506.124571279923, 6520.836979075466, 6772.051912732221, 6962.965185174143, 6965.82585435358, 6977.372036516738, 6241.157443745127, 6272.341404152589, 6363.96818015907, 6404.903926441107, 6550.574212676161, 6055.545834062463, 6083.422074902877, 6084.60450070744, 6096.683260361035, 6110.175126357884, 1675.3717355991503, 1692.636083242109, 1710.7084151465565, 1712.24661149094, 1739.0, 790.5770412829108, 833.3125171733224, 843.4812590256947, 865.8613922691766, 929.3912487320815, 15403.152826594422, 16211.027338359736, 17130.143492825307, 17750.91124544395, 17971.820281797278, 832.2759199496477, 867.197841996151, 887.724805310343, 906.4515967839362, 908.2416182487565, 9303.395279306958, 9431.528423578793, 9701.90298097024, 9949.353292035994, 10179.796404071878, 339249.0, 340885.0, 341736.0, 349974.0, 350358.4726293286, 78128.0, 78139.60930195313, 80117.0, 81210.0, 82600.0, 935.457434687893, 954.5418199264253, 989.6338354808767, 991.5339790298548, 991.548845275398, 15197.0, 15644.0, 15983.760243596123, 16038.198090095215, 16321.918390408448, 35437.40531676029, 35697.28605427825, 36908.63091369052, 37356.81321593375, 37665.62334376731, 49427.258591120444, 50326.74836625793, 50397.74801125971, 50719.0, 51033.38632750469, 7369.373603243785, 7454.105507339154, 7549.3583045439555, 7578.317951384402, 7801.063872335356, 10579.418132002813, 11641.243319184226, 11783.705407364541, 11834.585789497327, 11865.525378984745, 9986.751656042994, 10543.736406589896, 10617.734556635836, 10660.89339106599, 10773.24587278883, 10133.341332813343, 10179.03299186576, 10364.481775911023, 10487.737806554896, 10529.4735263235, 10127.240456965905, 10363.430011349448, 10396.896031039592, 10714.25000249975, 11280.605178818701, 7612.3148916597775, 7627.961860190663, 7641.694332226649, 7642.0, 7913.881291780513, 8938.284937205139, 10455.215858810772, 10476.895231047896, 10665.680029599125, 10714.73213169677], "value": 8190.201136300414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1181.8345431639577, 1292.7802273613486, 1307.1438207973777, 1329.395125218026, 1611.7743515907769, 5926.644401335923, 6428.132202152714, 6746.460283177346, 6756.493263005276, 6878.759243426481, 6774.356436138572, 6833.829154271146, 6844.212915514705, 6846.7945961621235, 6849.075374824397, 1764.6470705858815, 1824.936127235547, 2050.5441136792856, 2084.551821358408, 2088.227355878327, 2035.2571311471281, 2091.3307741522717, 2098.790120987904, 2110.8522403431766, 2112.8309735221223, 2052.9281475148373, 2053.3121404329568, 2057.6501994660944, 2061.2064355223197, 2067.3694523170425, 2056.496158441184, 2071.140476702167, 2072.7149167516086, 2076.595063962528, 2078.812906838392, 2046.6827641715558, 2048.764392094913, 2065.163608738463, 2069.1102825784906, 2069.855110142291, 6482.41658250755, 6580.703868325889, 6595.274519802866, 6599.6700164992035, 6600.834979125512, 4149.8962525936795, 4315.525292217853, 4324.978375108104, 4326.178026175016, 4329.1558146161515, 2630.18464276075, 2793.1899749072745, 2845.9430811383863, 2850.4299140172047, 2865.9856700716573, 848.9023762267357, 880.7181701855409, 899.7120921305185, 932.7807965128189, 937.3625934364629, 8858.645654173826, 8946.776330591721, 8973.416727912665, 8983.056779038172, 8996.730098097067, 3621.9818900905325, 3787.223619158066, 3849.7690138591215, 3850.403187505941, 3972.245273398045, 7761.146273909865, 7812.53124812513, 7823.491473054347, 7824.726134585376, 7827.295543401007, 4314.41755363022, 4322.0491491871735, 4322.481302243688, 4325.76208308546, 4328.675349348811, 3391.2878295558207, 3502.141975216088, 3805.200907809391, 3912.5891781363116, 3916.236333914916, 3326.8336583170744, 3328.234506063619, 3436.43298855686, 3441.5698037745283, 3451.188970591909, 1115.3976852499559, 1148.3913525831322, 1156.6009726644295, 1161.3264306702092, 1162.3382454180003, 733.6735152856927, 814.2793627639463, 836.0886633569438, 846.3018010141658, 847.0597636623343, 4909.803607855646, 4914.115459217303, 4954.529319714621, 4961.305417241589, 5048.7475626219275, 378.10389377176267, 379.89932667843044, 391.8765588839506, 396.28272826184696, 401.3658419696872, 3399.4560870261134, 3399.5580574525648, 3421.0934102462866, 3421.3157368526395, 3512.4906888501023, 7736.4584479085925, 8145.429819912668, 8235.629396677044, 8254.092049874509, 8254.917450825535, 8068.475549089408, 8072.717454889051, 8082.1513741057515, 8082.595870206584, 8136.14570470104, 6257.9687101564205, 6396.1045453636525, 6476.6114033158165, 6490.383413575702, 6496.9025464617125, 4783.712977221238, 4797.424309082932, 4900.26496025599, 4912.778924948315, 5060.924086138637, 7447.962760186381, 7471.701131954661, 7538.434617403607, 7543.660535276035, 7548.622568871644, 7223.530470519399, 7445.255474452511, 7634.656440460304, 7637.88543171864, 7642.0, 5058.317127187783, 5233.6074794389815, 5799.971000144972, 5907.054871220584, 5915.08316210988, 6130.63216207029, 6412.519061070345, 6413.454856337077, 6527.869442611026, 6528.249251336157, 5910.4089591042275, 5928.110783382527, 5978.491828194652, 6002.639841609517, 6075.726592303268, 5736.68448235351, 5775.162601422686, 5777.0179069557435, 5796.1305804129715, 5841.50347220474, 5384.569234461155, 5554.1946417770005, 5594.832155035356, 5661.943380566307, 5663.943360566342, 4224.746515209097, 4253.27694291965, 4290.227759003409, 4306.849260275875, 4484.529124442017, 4161.313383291723, 4165.729227600196, 4221.472315960505, 4249.787510624518, 4390.1878152541885], "value": 3665.6891798885936, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.46621952071547, 284.0668404291901, 286.4700304436792, 289.77831958551724, 291.65438954838504, 4606.8617941461725, 4716.504766999467, 4746.905061898764, 4762.523747625236, 4790.778351520362, 4591.724496530211, 4649.9302510462285, 4700.824793801549, 4705.788239529221, 4720.126776546342, 3705.1848593309564, 3711.4618380334837, 3723.5531736191697, 3723.7021038317007, 3735.7198210134347, 3512.6838584527386, 3722.673329169269, 3728.8694895678655, 3736.0473079364724, 3736.8878933632036, 3536.416491278936, 3584.4623306503972, 3609.855605775766, 3630.4191329387304, 3678.889633311005, 3638.7634803737938, 3639.781613103209, 3640.3993341098953, 3642.908927276839, 3650.2699460108083, 3211.6948889855425, 3228.6287076985977, 3232.7898686585295, 3233.822139782311, 3234.579504664402, 4390.473143222802, 4596.7588751037365, 4600.309953506967, 4612.561806628399, 4614.330922016323, 4187.685923555746, 4194.4337514435465, 4194.937075943863, 4198.769067701275, 4216.451861258048, 4933.038057578774, 4962.975185124052, 4963.45402005779, 4971.33460290803, 4975.651704380694, 3546.680798728101, 3557.5908770491465, 3558.3275860345598, 3564.7148228141687, 3568.4468907319406, 4954.925676114861, 5076.492350764931, 5130.589552835764, 5146.6911985281, 5170.7073231692075, 3615.8610037838, 3626.256617393428, 3628.9455658165148, 3629.637036296402, 3632.8546858125906, 3673.2653469306247, 3675.5114178757644, 3682.6133256007734, 3690.0774806298427, 3692.2061756722433, 3928.332183528807, 4118.567550407224, 4192.266353388206, 4193.643540299047, 4204.1801848639225, 4932.112219800399, 4946.876328091755, 4958.528939750718, 4965.975170124127, 4981.352424184833, 1206.3666575048169, 1217.4764851113928, 1221.8209427902118, 1222.6576558563615, 1224.9755004899853, 767.2902565127347, 787.5471603827822, 807.8182408957938, 812.1594150054665, 818.4066551749934, 4281.486221653421, 4288.335308027261, 4313.202057619351, 4333.508232766172, 4352.521222665504, 5000.524950129732, 5016.720736212243, 5028.874278143076, 5032.3961124665275, 5047.722375269322, 4073.877783666495, 4279.7218180818145, 4319.179355922364, 4337.9132417351475, 4357.215701173819, 2630.5528060229426, 2637.947241055168, 2650.4566563854364, 2651.270900502377, 2659.7473240042164, 4559.202139625619, 4638.966721107568, 4659.790309436084, 4678.76606169697, 4681.180793361148, 4843.903121937541, 4996.700857777004, 5039.44566097729, 5067.189249720027, 5069.0, 4684.212893328464, 4690.812367505261, 4694.95305046952, 4713.6464765142755, 4714.104320179155, 4988.950110498994, 4990.351254337058, 5006.799728010838, 5024.698518088926, 5025.572826309804, 4598.885027874196, 4807.735574543433, 4829.309741590415, 4878.829240976549, 4893.266010098514, 4625.0, 4625.560571745679, 4655.650826187982, 4672.009913655332, 4675.854415668047, 3428.879989200466, 3432.4508078707286, 3434.7767395120236, 3441.208522039995, 3448.8620455181513, 4748.691335063209, 4939.851164743348, 4947.90755777639, 4994.2508623706735, 4998.750062496788, 4715.339852420595, 4745.667803253739, 4769.2130798417875, 4772.427308722976, 4799.496052914534, 4672.369230153886, 4708.97645511784, 4740.905181896412, 4763.666543341933, 4820.0, 4714.740689262124, 4716.29255611661, 4733.5266473352385, 4737.099951009297, 4738.763061846963, 4558.518481493462, 4696.577308042292, 5007.7746501408255, 5011.223260394645, 5018.548330650259, 4887.802488390367, 4890.951090489049, 4892.926606100982, 4896.608271338213, 4911.140550403594], "value": 3672.32775541109, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.8671872266185, 663.9004149377596, 689.6103701408707, 727.2436665867498, 732.9120505539332, 12070.577529786447, 13016.674583135426, 13095.083344165912, 13106.41021154048, 13116.737665246701, 12953.35233238339, 13135.737285254289, 13145.079844410895, 13152.73694526109, 13160.144590601603, 622.2843729710846, 637.9011253255729, 748.5620911766623, 757.223845558303, 779.4777499075605, 774.4733581164805, 774.9612519374037, 779.5050143159107, 780.2938340801584, 780.3640033372783, 820.659426338069, 821.1460081515218, 822.8354329134168, 823.2056065896409, 823.2343920154254, 652.4617190817595, 815.9306458950996, 816.5508970066439, 817.1787353709543, 817.4237162800241, 495.5044955044955, 577.6591810831587, 599.1851082527759, 601.1523751510349, 604.1722839709582, 12869.034822388357, 12880.484780608764, 12946.611601651966, 12987.675308117277, 13028.218306901616, 11822.231554948901, 12193.0, 12431.37843107841, 12466.0, 12616.0, 11257.324560526395, 11749.4712737927, 11909.106816988673, 12049.93975030128, 12077.214981026293, 4084.7957602119777, 4094.5905409459115, 4140.0, 4140.937885931713, 4270.359446083081, 59517.40482595162, 60746.696266518826, 62286.68856655733, 62327.37672623261, 63204.0, 9803.803923921481, 9938.254630902567, 10053.798924021625, 10065.496725163712, 10142.898571014195, 18595.070246487623, 18622.441326760218, 18631.906840465712, 18639.90680046591, 18659.720104198448, 6631.3700198481065, 6764.864702705919, 6783.660816959133, 6836.151440919312, 6859.17689877208, 3663.3222853772136, 3705.8332375043187, 3736.925261494809, 3859.2281543691374, 3879.8448062077764, 2645.8677066146615, 2706.6075419064127, 2727.972720272812, 2730.331068888135, 2732.699403065661, 471.3942583779826, 480.2987638048488, 486.3264378835268, 490.9582685471775, 493.08778759295734, 458.12269503900325, 460.2842579788461, 501.51603702426604, 566.5043087298614, 568.8919105369966, 7607.885881711779, 7724.459287849797, 7792.805179870548, 7907.327877130509, 8016.198380162054, 439.6109443142778, 539.0889396919194, 543.8912217556425, 557.8493806672176, 567.2597260574989, 3665.376885929398, 3733.250793777552, 3738.6635202831876, 3778.905527361838, 3798.9620103798607, 68525.65737171282, 69973.3002669977, 70111.64944175247, 70570.2942970574, 71892.0, 50061.0, 54867.0, 59169.0, 60627.20544686241, 61657.38342616606, 53983.0, 54392.184117237484, 54716.72641636767, 54926.72536637291, 54970.0, 6873.725050997904, 6885.380315771605, 7173.282671732785, 7176.7488137914925, 7691.230876912264, 31483.370332593677, 33182.502262466565, 33530.32939341248, 37264.44103338398, 40027.599724002386, 46997.530024699314, 47684.5231547694, 47997.5200248007, 49677.25484117669, 51057.74471127621, 9044.954775226082, 9308.627654893728, 10700.518476668723, 11472.369019703663, 11726.88273117292, 10724.302920310154, 10758.8386174209, 10961.890381096087, 11441.427928603704, 11970.76058478843, 12349.814752778895, 12484.188527745668, 12610.813832760683, 12875.356232188165, 13217.40521676546, 11367.829482557603, 11774.529018839494, 11851.466683999413, 12168.878311216775, 12654.0, 11243.7751244973, 12073.215241009306, 12201.0, 12686.238825670489, 12974.675633109247, 9593.808123837345, 9634.71095867125, 10382.532786024496, 10581.10060644823, 10667.946660266649, 10107.49462526856, 10453.320534165256, 10475.371477711362, 10571.2600117991, 10724.195685323788], "value": 6210.325125639805, "unit": "score"}], "name": "dromaeo_css", "value": 6134.847991695231, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 116.0, 115.0, 116.0, 116.0, 116.0, 115.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 129.0, 173.0, 133.0, 129.0, 128.0, 130.0, 154.0, 129.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 163.0, 162.0, 165.0, 162.0, 162.0, 163.0, 161.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 115.0, 77.0, 77.0, 78.0, 76.0, 91.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 84.0, 84.0, 85.0, 98.0, 83.0, 83.0, 105.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 89.0, 95.0, 86.0, 85.0, 86.0, 89.0, 93.0, 85.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 140.0, 150.0, 141.0, 138.0, 142.0, 142.0, 146.0, 186.0, 173.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 186.0, 183.0, 181.0, 180.0, 181.0, 189.0, 178.0, 182.0, 184.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 76.0, 69.0, 67.0, 71.0, 68.0, 67.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1569.3, "alertThreshold": 2.0}]} 03:40:39 INFO - Return code: 0 03:40:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:39 INFO - # TBPL SUCCESS # 03:40:39 INFO - Running post-action listener: _resource_record_post_action 03:40:39 INFO - [mozharness: 2016-12-07 11:40:39.502146Z] Finished run-tests step (success) 03:40:39 INFO - Running post-run listener: _resource_record_post_run 03:40:39 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392339456; Read time: 20; Write time: 206252 03:40:39 INFO - TinderboxPrint: CPU usage
13.1% 03:40:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:40:39 INFO - TinderboxPrint: I/O write bytes / time
392,339,456 / 206,252 03:40:39 INFO - TinderboxPrint: CPU idle
8,348.0 (86.9%) 03:40:39 INFO - TinderboxPrint: CPU user
1,210.4 (12.6%) 03:40:39 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99528704; Read time: 0; Write time: 56320 03:40:39 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292417536; Read time: 0; Write time: 149912 03:40:40 INFO - Running post-run listener: _upload_blobber_files 03:40:40 INFO - Blob upload gear active. 03:40:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:40 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 03:40:40 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:40 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:40 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:45 INFO - (blobuploader) - INFO - Done attempting. 03:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:46 INFO - (blobuploader) - INFO - Done attempting. 03:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:40:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:47 INFO - (blobuploader) - INFO - Done attempting. 03:40:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:47 INFO - Return code: 0 03:40:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1132a1f3cd420daace8dad4da14a040b2a75e331763dfe9921b263a53e0e194a0f80bd84516cafecbcb0425303bc940e4fb79e616279c110a9d0b0f5ea51559e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4066dab671531ba12f0c78c7db72590f0ced00c609e8c38959bc1c9f070970f2cfe134fd48b3f1467c1876670f3a7b3fa57ab6d42ec4863f86b6a3290bf3d0ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5ecb77e278a703e5e5f77e3f1797e97289cf7b2e78035a0abf7ae4ebb4f1fdfc1088ab4cbcd9f2ae08c110e81df29212a6d8ac27cd86a9a1eb5e65a7d521824"} 03:40:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:47 INFO - Contents: 03:40:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1132a1f3cd420daace8dad4da14a040b2a75e331763dfe9921b263a53e0e194a0f80bd84516cafecbcb0425303bc940e4fb79e616279c110a9d0b0f5ea51559e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4066dab671531ba12f0c78c7db72590f0ced00c609e8c38959bc1c9f070970f2cfe134fd48b3f1467c1876670f3a7b3fa57ab6d42ec4863f86b6a3290bf3d0ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5ecb77e278a703e5e5f77e3f1797e97289cf7b2e78035a0abf7ae4ebb4f1fdfc1088ab4cbcd9f2ae08c110e81df29212a6d8ac27cd86a9a1eb5e65a7d521824"} 03:40:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:47 INFO - Copying logs to upload dir... 03:40:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.759451 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-12-07 03:40:46.897873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 03:40:46.901156) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1132a1f3cd420daace8dad4da14a040b2a75e331763dfe9921b263a53e0e194a0f80bd84516cafecbcb0425303bc940e4fb79e616279c110a9d0b0f5ea51559e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4066dab671531ba12f0c78c7db72590f0ced00c609e8c38959bc1c9f070970f2cfe134fd48b3f1467c1876670f3a7b3fa57ab6d42ec4863f86b6a3290bf3d0ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5ecb77e278a703e5e5f77e3f1797e97289cf7b2e78035a0abf7ae4ebb4f1fdfc1088ab4cbcd9f2ae08c110e81df29212a6d8ac27cd86a9a1eb5e65a7d521824"} build_url:https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/cgMczoq6SwicUzCzdFlxng/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1132a1f3cd420daace8dad4da14a040b2a75e331763dfe9921b263a53e0e194a0f80bd84516cafecbcb0425303bc940e4fb79e616279c110a9d0b0f5ea51559e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4066dab671531ba12f0c78c7db72590f0ced00c609e8c38959bc1c9f070970f2cfe134fd48b3f1467c1876670f3a7b3fa57ab6d42ec4863f86b6a3290bf3d0ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5ecb77e278a703e5e5f77e3f1797e97289cf7b2e78035a0abf7ae4ebb4f1fdfc1088ab4cbcd9f2ae08c110e81df29212a6d8ac27cd86a9a1eb5e65a7d521824"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 03:40:46.927927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:40:46.928391) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1481109127.990019-2139744911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004364 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:40:47.010669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 03:40:47.011127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 03:40:47.011465) ========= ========= Total master_lag: 0.17 =========