builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1481297358.04 results: success (0) buildid: 20161209062651 builduid: 3b2a0f7316a642af82704a42fc0ef28d revision: 383de455893c1511918b04c72191893877bd0b5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.035493) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.035947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.036250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.047597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.047929) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-09 07:29:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-12-09 07:29:18 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.171812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.172154) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.221932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.222307) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 383de455893c1511918b04c72191893877bd0b5e --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 383de455893c1511918b04c72191893877bd0b5e --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=769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-09 07:29:19,053 truncating revision to first 12 chars 2016-12-09 07:29:19,053 Setting DEBUG logging. 2016-12-09 07:29:19,053 attempt 1/10 2016-12-09 07:29:19,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/383de455893c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 07:29:19,417 unpacking tar archive at: mozilla-central-383de455893c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.909186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.909524) ========= script_repo_revision: 383de455893c1511918b04c72191893877bd0b5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.909966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.910264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 07:29:18.919271) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-12-09 07:29:18.919575) ========= /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=769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:29:19 INFO - MultiFileLogger online at 20161209 07:29:19 in /builds/slave/test 07:29:19 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 07:29:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:19 INFO - {'append_to_log': False, 07:29:19 INFO - 'base_work_dir': '/builds/slave/test', 07:29:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:29:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:19 INFO - 'branch': 'Firefox-Non-PGO', 07:29:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:19 INFO - 'config_files': ('talos/linux_config.py',), 07:29:19 INFO - 'default_actions': ('clobber', 07:29:19 INFO - 'read-buildbot-config', 07:29:19 INFO - 'download-and-extract', 07:29:19 INFO - 'populate-webroot', 07:29:19 INFO - 'create-virtualenv', 07:29:19 INFO - 'install', 07:29:19 INFO - 'run-tests'), 07:29:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:19 INFO - 'download_minidump_stackwalk': True, 07:29:19 INFO - 'download_symbols': 'ondemand', 07:29:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:19 INFO - 'installer_path': 'installer.exe', 07:29:19 INFO - 'log_level': 'info', 07:29:19 INFO - 'log_name': 'talos', 07:29:19 INFO - 'log_to_console': True, 07:29:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:29:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:29:19 INFO - 'opt_config_files': (), 07:29:19 INFO - 'pip_index': False, 07:29:19 INFO - 'sps_profile': False, 07:29:19 INFO - 'sps_profile_interval': 0, 07:29:19 INFO - 'suite': 'dromaeojs', 07:29:19 INFO - 'system_bits': '32', 07:29:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:19 INFO - 'title': 'talos-linux64-ix-063', 07:29:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:19 INFO - 'use_talos_json': True, 07:29:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:19 INFO - 'work_dir': 'build'} 07:29:19 INFO - [mozharness: 2016-12-09 15:29:19.858085Z] Running clobber step. 07:29:19 INFO - Running pre-action listener: _resource_record_pre_action 07:29:19 INFO - Running main action method: clobber 07:29:19 INFO - rmtree: /builds/slave/test/build 07:29:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:29:20 INFO - Running post-action listener: _resource_record_post_action 07:29:20 INFO - [mozharness: 2016-12-09 15:29:20.842366Z] Finished clobber step (success) 07:29:20 INFO - [mozharness: 2016-12-09 15:29:20.842476Z] Running read-buildbot-config step. 07:29:20 INFO - Running pre-action listener: _resource_record_pre_action 07:29:20 INFO - Running main action method: read_buildbot_config 07:29:20 INFO - Using buildbot properties: 07:29:20 INFO - { 07:29:20 INFO - "project": "", 07:29:20 INFO - "product": "firefox", 07:29:20 INFO - "script_repo_revision": "production", 07:29:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:29:20 INFO - "repository": "", 07:29:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:29:20 INFO - "buildid": "20161209062651", 07:29:20 INFO - "pgo_build": "False", 07:29:20 INFO - "basedir": "/builds/slave/test", 07:29:20 INFO - "buildnumber": 738, 07:29:20 INFO - "slavename": "talos-linux64-ix-063", 07:29:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:29:20 INFO - "platform": "ubuntu64_hw", 07:29:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:29:20 INFO - "branch": "mozilla-central", 07:29:20 INFO - "repo_path": "mozilla-central", 07:29:20 INFO - "revision": "383de455893c1511918b04c72191893877bd0b5e", 07:29:20 INFO - "stage_platform": "linux64", 07:29:20 INFO - "builduid": "3b2a0f7316a642af82704a42fc0ef28d", 07:29:20 INFO - "slavebuilddir": "test" 07:29:20 INFO - } 07:29:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:29:20 INFO - Running post-action listener: _resource_record_post_action 07:29:20 INFO - [mozharness: 2016-12-09 15:29:20.844916Z] Finished read-buildbot-config step (success) 07:29:20 INFO - [mozharness: 2016-12-09 15:29:20.845004Z] Running download-and-extract step. 07:29:20 INFO - Running pre-action listener: _resource_record_pre_action 07:29:20 INFO - Running main action method: download_and_extract 07:29:20 INFO - mkdir: /builds/slave/test/build/tests 07:29: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')]} 07:29:20 INFO - trying https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:29:20 INFO - Downloading https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/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 07:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/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 07:29:21 INFO - Downloaded 1361 bytes. 07:29:21 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:29:21 INFO - Using the following test package requirements: 07:29:21 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:21 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:29:21 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:29:21 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'jsshell-linux-x86_64.zip'], 07:29:21 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:29:21 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:21 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:29:21 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:29:21 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:29:21 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:29:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:29:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:29:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:21 INFO - Fetch https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:22 INFO - Expected file size: 20222410 07:29:22 INFO - Obtained file size: 20222410 07:29:26 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 07:29:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:29:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:26 INFO - Fetch https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:26 INFO - Expected file size: 20222410 07:29:26 INFO - Obtained file size: 20222410 07:29:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:29:31 INFO - Fetch https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:29:32 INFO - Expected file size: 14409734 07:29:32 INFO - Obtained file size: 14409734 07:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:32 INFO - trying https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/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 07:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/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 07:29:33 INFO - Downloaded 55763073 bytes. 07:29:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:33 INFO - mkdir: /builds/slave/test/properties 07:29:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:33 INFO - Contents: 07:29:33 INFO - build_url:https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:34 INFO - Running post-action listener: _resource_record_post_action 07:29:34 INFO - Running post-action listener: set_extra_try_arguments 07:29:34 INFO - [mozharness: 2016-12-09 15:29:34.125201Z] Finished download-and-extract step (success) 07:29:34 INFO - [mozharness: 2016-12-09 15:29:34.125426Z] Running populate-webroot step. 07:29:34 INFO - Running pre-action listener: _resource_record_pre_action 07:29:34 INFO - Running main action method: populate_webroot 07:29:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:34 INFO - '--tppagecycles', 07:29:34 INFO - '7'], 07:29:34 INFO - 'tests': ['tsvgm']}}, 07:29:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:29:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:29:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:29:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['damp', 'tps']}, 07:29:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'tests': ['damp', 'tps']}, 07:29:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['dromaeo_dom']}, 07:29:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['basic_compositor_video']}, 07:29:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:29:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['a11yr', 07:29:34 INFO - 'ts_paint', 07:29:34 INFO - 'tpaint', 07:29:34 INFO - 'sessionrestore', 07:29:34 INFO - 'sessionrestore_no_auto_restore', 07:29:34 INFO - 'tabpaint']}, 07:29:34 INFO - 'other-e10s': {'tests': ['a11yr', 07:29:34 INFO - 'ts_paint', 07:29:34 INFO - 'tpaint', 07:29:34 INFO - 'sessionrestore', 07:29:34 INFO - 'sessionrestore_no_auto_restore', 07:29:34 INFO - 'tabpaint']}, 07:29:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:29:34 INFO - 'ts_paint', 07:29:34 INFO - 'tpaint', 07:29:34 INFO - 'sessionrestore', 07:29:34 INFO - 'sessionrestore_no_auto_restore', 07:29:34 INFO - 'tabpaint']}, 07:29:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:29:34 INFO - 'ts_paint', 07:29:34 INFO - 'tpaint', 07:29:34 INFO - 'sessionrestore', 07:29:34 INFO - 'sessionrestore_no_auto_restore', 07:29:34 INFO - 'tabpaint']}, 07:29:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['a11yr', 07:29:34 INFO - 'ts_paint', 07:29:34 INFO - 'tpaint', 07:29:34 INFO - 'sessionrestore', 07:29:34 INFO - 'sessionrestore_no_auto_restore', 07:29:34 INFO - 'tabpaint']}, 07:29:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['a11yr', 07:29:34 INFO - 'ts_paint', 07:29:34 INFO - 'tpaint', 07:29:34 INFO - 'sessionrestore', 07:29:34 INFO - 'sessionrestore_no_auto_restore', 07:29:34 INFO - 'tabpaint']}, 07:29:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['tsvgx', 07:29:34 INFO - 'tsvgr_opacity', 07:29:34 INFO - 'tart', 07:29:34 INFO - 'tscrollx', 07:29:34 INFO - 'cart', 07:29:34 INFO - 'tsvg_static']}, 07:29:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:29:34 INFO - 'tsvgr_opacity', 07:29:34 INFO - 'tart', 07:29:34 INFO - 'tscrollx', 07:29:34 INFO - 'cart', 07:29:34 INFO - 'tsvg_static']}, 07:29:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'talos_options': ['--disable-e10s'], 07:29:34 INFO - 'tests': ['tp5o']}, 07:29:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:29:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'talos_options': ['--disable-e10s', 07:29:34 INFO - '--xperf_path', 07:29:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:34 INFO - 'tests': ['tp5n']}, 07:29:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:29:34 INFO - 'talos_options': ['--xperf_path', 07:29:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:34 INFO - 'tests': ['tp5n']}}, 07:29:34 INFO - 'talos.zip': {'path': '', 07:29:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:34 INFO - Running post-action listener: _resource_record_post_action 07:29:34 INFO - [mozharness: 2016-12-09 15:29:34.144970Z] Finished populate-webroot step (success) 07:29:34 INFO - [mozharness: 2016-12-09 15:29:34.145058Z] Running create-virtualenv step. 07:29:34 INFO - Running pre-action listener: _resource_record_pre_action 07:29:34 INFO - Running main action method: create_virtualenv 07:29:34 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:29:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:34 INFO - Using real prefix '/usr' 07:29:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:36 INFO - Installing pip.................done. 07:29:36 INFO - Return code: 0 07:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:29:36 INFO - Reading from file tmpfile_stdout 07:29:36 INFO - Output received: 07:29:36 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) 07:29:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:36 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:29:36 INFO - Using env: {'DISPLAY': ':0', 07:29:36 INFO - 'HOME': '/home/cltbld', 07:29:36 INFO - 'LANG': 'en_US.UTF-8', 07:29:36 INFO - 'LANGUAGE': 'en_US:en', 07:29:36 INFO - 'LOGNAME': 'cltbld', 07:29:36 INFO - 'MAIL': '/var/mail/cltbld', 07:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:36 INFO - 'MOZ_NO_REMOTE': '1', 07:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:36 INFO - 'NO_EM_RESTART': '1', 07:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:36 INFO - 'PWD': '/builds/slave/test', 07:29:36 INFO - 'SHELL': '/bin/bash', 07:29:36 INFO - 'SHLVL': '1', 07:29:36 INFO - 'TERM': 'linux', 07:29:36 INFO - 'TMOUT': '86400', 07:29:36 INFO - 'USER': 'cltbld', 07:29:36 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:36 INFO - '_': '/tools/buildbot/bin/python'} 07:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:29:37 INFO - Cleaning up... 07:29:37 INFO - Return code: 0 07:29:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:29:37 INFO - Using env: {'DISPLAY': ':0', 07:29:37 INFO - 'HOME': '/home/cltbld', 07:29:37 INFO - 'LANG': 'en_US.UTF-8', 07:29:37 INFO - 'LANGUAGE': 'en_US:en', 07:29:37 INFO - 'LOGNAME': 'cltbld', 07:29:37 INFO - 'MAIL': '/var/mail/cltbld', 07:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:37 INFO - 'MOZ_NO_REMOTE': '1', 07:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:37 INFO - 'NO_EM_RESTART': '1', 07:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:37 INFO - 'PWD': '/builds/slave/test', 07:29:37 INFO - 'SHELL': '/bin/bash', 07:29:37 INFO - 'SHLVL': '1', 07:29:37 INFO - 'TERM': 'linux', 07:29:37 INFO - 'TMOUT': '86400', 07:29:37 INFO - 'USER': 'cltbld', 07:29:37 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:37 INFO - '_': '/tools/buildbot/bin/python'} 07:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:37 INFO - Downloading/unpacking psutil>=3.1.1 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:39 INFO - Installing collected packages: psutil 07:29:39 INFO - Running setup.py install for psutil 07:29:39 INFO - building 'psutil._psutil_linux' extension 07:29:39 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 07:29:39 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 07:29:39 INFO - building 'psutil._psutil_posix' extension 07:29:39 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 07:29:39 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 07:29:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:39 INFO - Successfully installed psutil 07:29:39 INFO - Cleaning up... 07:29:40 INFO - Return code: 0 07:29:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:40 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:29:40 INFO - Using env: {'DISPLAY': ':0', 07:29:40 INFO - 'HOME': '/home/cltbld', 07:29:40 INFO - 'LANG': 'en_US.UTF-8', 07:29:40 INFO - 'LANGUAGE': 'en_US:en', 07:29:40 INFO - 'LOGNAME': 'cltbld', 07:29:40 INFO - 'MAIL': '/var/mail/cltbld', 07:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:40 INFO - 'MOZ_NO_REMOTE': '1', 07:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:40 INFO - 'NO_EM_RESTART': '1', 07:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:40 INFO - 'PWD': '/builds/slave/test', 07:29:40 INFO - 'SHELL': '/bin/bash', 07:29:40 INFO - 'SHLVL': '1', 07:29:40 INFO - 'TERM': 'linux', 07:29:40 INFO - 'TMOUT': '86400', 07:29:40 INFO - 'USER': 'cltbld', 07:29:40 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:40 INFO - '_': '/tools/buildbot/bin/python'} 07:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:29:42 INFO - Installing collected packages: mozsystemmonitor 07:29:42 INFO - Running setup.py install for mozsystemmonitor 07:29:42 INFO - Successfully installed mozsystemmonitor 07:29:42 INFO - Cleaning up... 07:29:42 INFO - Return code: 0 07:29:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:29:42 INFO - Using env: {'DISPLAY': ':0', 07:29:42 INFO - 'HOME': '/home/cltbld', 07:29:42 INFO - 'LANG': 'en_US.UTF-8', 07:29:42 INFO - 'LANGUAGE': 'en_US:en', 07:29:42 INFO - 'LOGNAME': 'cltbld', 07:29:42 INFO - 'MAIL': '/var/mail/cltbld', 07:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:42 INFO - 'MOZ_NO_REMOTE': '1', 07:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:42 INFO - 'NO_EM_RESTART': '1', 07:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:42 INFO - 'PWD': '/builds/slave/test', 07:29:42 INFO - 'SHELL': '/bin/bash', 07:29:42 INFO - 'SHLVL': '1', 07:29:42 INFO - 'TERM': 'linux', 07:29:42 INFO - 'TMOUT': '86400', 07:29:42 INFO - 'USER': 'cltbld', 07:29:42 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:42 INFO - '_': '/tools/buildbot/bin/python'} 07:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:42 INFO - Downloading/unpacking jsonschema==2.5.1 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:44 INFO - warning: no files found matching '*.txt' 07:29:44 INFO - no previously-included directories found matching 'build' 07:29:44 INFO - no previously-included directories found matching 'dist' 07:29:44 INFO - no previously-included directories found matching '.git*' 07:29:44 INFO - Installing collected packages: jsonschema, functools32 07:29:44 INFO - Running setup.py install for functools32 07:29:45 INFO - warning: no files found matching '*.txt' 07:29:45 INFO - no previously-included directories found matching 'build' 07:29:45 INFO - no previously-included directories found matching 'dist' 07:29:45 INFO - no previously-included directories found matching '.git*' 07:29:45 INFO - Successfully installed jsonschema functools32 07:29:45 INFO - Cleaning up... 07:29:45 INFO - Return code: 0 07:29:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:45 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:29:45 INFO - Using env: {'DISPLAY': ':0', 07:29:45 INFO - 'HOME': '/home/cltbld', 07:29:45 INFO - 'LANG': 'en_US.UTF-8', 07:29:45 INFO - 'LANGUAGE': 'en_US:en', 07:29:45 INFO - 'LOGNAME': 'cltbld', 07:29:45 INFO - 'MAIL': '/var/mail/cltbld', 07:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:45 INFO - 'MOZ_NO_REMOTE': '1', 07:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:45 INFO - 'NO_EM_RESTART': '1', 07:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:45 INFO - 'PWD': '/builds/slave/test', 07:29:45 INFO - 'SHELL': '/bin/bash', 07:29:45 INFO - 'SHLVL': '1', 07:29:45 INFO - 'TERM': 'linux', 07:29:45 INFO - 'TMOUT': '86400', 07:29:45 INFO - 'USER': 'cltbld', 07:29:45 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:45 INFO - '_': '/tools/buildbot/bin/python'} 07:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:29:45 INFO - Cleaning up... 07:29:45 INFO - Return code: 0 07:29:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:45 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:29:45 INFO - Using env: {'DISPLAY': ':0', 07:29:45 INFO - 'HOME': '/home/cltbld', 07:29:45 INFO - 'LANG': 'en_US.UTF-8', 07:29:45 INFO - 'LANGUAGE': 'en_US:en', 07:29:45 INFO - 'LOGNAME': 'cltbld', 07:29:45 INFO - 'MAIL': '/var/mail/cltbld', 07:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:45 INFO - 'MOZ_NO_REMOTE': '1', 07:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:45 INFO - 'NO_EM_RESTART': '1', 07:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:45 INFO - 'PWD': '/builds/slave/test', 07:29:45 INFO - 'SHELL': '/bin/bash', 07:29:45 INFO - 'SHLVL': '1', 07:29:45 INFO - 'TERM': 'linux', 07:29:45 INFO - 'TMOUT': '86400', 07:29:45 INFO - 'USER': 'cltbld', 07:29:45 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:45 INFO - '_': '/tools/buildbot/bin/python'} 07:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:48 INFO - Downloading docopt-0.6.1.tar.gz 07:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:48 INFO - Running setup.py install for blobuploader 07:29:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:48 INFO - Running setup.py install for requests 07:29:48 INFO - Running setup.py install for docopt 07:29:48 INFO - Successfully installed blobuploader requests docopt 07:29:48 INFO - Cleaning up... 07:29:48 INFO - Return code: 0 07:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:48 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:48 INFO - Using env: {'DISPLAY': ':0', 07:29:48 INFO - 'HOME': '/home/cltbld', 07:29:48 INFO - 'LANG': 'en_US.UTF-8', 07:29:48 INFO - 'LANGUAGE': 'en_US:en', 07:29:48 INFO - 'LOGNAME': 'cltbld', 07:29:48 INFO - 'MAIL': '/var/mail/cltbld', 07:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:48 INFO - 'MOZ_NO_REMOTE': '1', 07:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:48 INFO - 'NO_EM_RESTART': '1', 07:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:48 INFO - 'PWD': '/builds/slave/test', 07:29:48 INFO - 'SHELL': '/bin/bash', 07:29:48 INFO - 'SHLVL': '1', 07:29:48 INFO - 'TERM': 'linux', 07:29:48 INFO - 'TMOUT': '86400', 07:29:48 INFO - 'USER': 'cltbld', 07:29:48 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:48 INFO - '_': '/tools/buildbot/bin/python'} 07:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:49 INFO - Running setup.py (path:/tmp/pip-KZA4bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:49 INFO - Running setup.py (path:/tmp/pip-JoRV2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:49 INFO - Running setup.py (path:/tmp/pip-hWhm5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:49 INFO - Running setup.py (path:/tmp/pip-Y__Yjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:49 INFO - Running setup.py (path:/tmp/pip-HT2Tg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:49 INFO - Running setup.py (path:/tmp/pip-3Gdf9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:49 INFO - Running setup.py (path:/tmp/pip-Q71U9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:49 INFO - Running setup.py (path:/tmp/pip-u7nnrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:49 INFO - Running setup.py (path:/tmp/pip-Y6QnBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:49 INFO - Running setup.py (path:/tmp/pip-7c9R0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:49 INFO - Running setup.py (path:/tmp/pip-Zu3IRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:49 INFO - Running setup.py (path:/tmp/pip-ZW3vI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:50 INFO - Running setup.py (path:/tmp/pip-ICAo7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:50 INFO - Running setup.py (path:/tmp/pip-DkgmEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:50 INFO - Running setup.py (path:/tmp/pip-MxdRGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:50 INFO - Running setup.py (path:/tmp/pip-1C48TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:50 INFO - Running setup.py (path:/tmp/pip-D90VNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:50 INFO - Running setup.py install for manifestparser 07:29:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozcrash 07:29:50 INFO - Running setup.py install for mozdebug 07:29:50 INFO - Running setup.py install for mozdevice 07:29:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozfile 07:29:50 INFO - Running setup.py install for mozhttpd 07:29:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozinfo 07:29:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozInstall 07:29:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozleak 07:29:51 INFO - Running setup.py install for mozlog 07:29:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for moznetwork 07:29:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozprocess 07:29:51 INFO - Running setup.py install for mozprofile 07:29:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozrunner 07:29:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozscreenshot 07:29:52 INFO - Running setup.py install for moztest 07:29:52 INFO - Running setup.py install for mozversion 07:29:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:52 INFO - Cleaning up... 07:29:52 INFO - Return code: 0 07:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:52 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:52 INFO - Using env: {'DISPLAY': ':0', 07:29:52 INFO - 'HOME': '/home/cltbld', 07:29:52 INFO - 'LANG': 'en_US.UTF-8', 07:29:52 INFO - 'LANGUAGE': 'en_US:en', 07:29:52 INFO - 'LOGNAME': 'cltbld', 07:29:52 INFO - 'MAIL': '/var/mail/cltbld', 07:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:52 INFO - 'MOZ_NO_REMOTE': '1', 07:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:52 INFO - 'NO_EM_RESTART': '1', 07:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:52 INFO - 'PWD': '/builds/slave/test', 07:29:52 INFO - 'SHELL': '/bin/bash', 07:29:52 INFO - 'SHLVL': '1', 07:29:52 INFO - 'TERM': 'linux', 07:29:52 INFO - 'TMOUT': '86400', 07:29:52 INFO - 'USER': 'cltbld', 07:29:52 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:52 INFO - '_': '/tools/buildbot/bin/python'} 07:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:52 INFO - Running setup.py (path:/tmp/pip-veqROP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:52 INFO - Running setup.py (path:/tmp/pip-9Sro4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:52 INFO - Running setup.py (path:/tmp/pip-7j6n_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:52 INFO - Running setup.py (path:/tmp/pip-GccL9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:52 INFO - Running setup.py (path:/tmp/pip-Mt5lk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:52 INFO - Running setup.py (path:/tmp/pip-Ixj_R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:52 INFO - Running setup.py (path:/tmp/pip-91d6Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:52 INFO - Running setup.py (path:/tmp/pip-Zh_QQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:53 INFO - Running setup.py (path:/tmp/pip-dYwJXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:53 INFO - Running setup.py (path:/tmp/pip-5uzf9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:53 INFO - Running setup.py (path:/tmp/pip-aBGAnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:53 INFO - Running setup.py (path:/tmp/pip-3H9XCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:53 INFO - Running setup.py (path:/tmp/pip-0XxGhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:53 INFO - Running setup.py (path:/tmp/pip-5yGrgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:53 INFO - Running setup.py (path:/tmp/pip-bwVG5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:53 INFO - Running setup.py (path:/tmp/pip-Y3whNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:53 INFO - Running setup.py (path:/tmp/pip-6e2OSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:55 INFO - Downloading blessings-1.6.tar.gz 07:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:55 INFO - Installing collected packages: blessings 07:29:55 INFO - Running setup.py install for blessings 07:29:55 INFO - Successfully installed blessings 07:29:55 INFO - Cleaning up... 07:29:55 INFO - Return code: 0 07:29:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:56 INFO - Reading from file tmpfile_stdout 07:29:56 INFO - Current package versions: 07:29:56 INFO - argparse == 1.2.1 07:29:56 INFO - blessings == 1.6 07:29:56 INFO - blobuploader == 1.2.4 07:29:56 INFO - docopt == 0.6.1 07:29:56 INFO - functools32 == 3.2.3-2 07:29:56 INFO - jsonschema == 2.5.1 07:29:56 INFO - manifestparser == 1.1 07:29:56 INFO - mozInstall == 1.12 07:29:56 INFO - mozcrash == 1.0 07:29:56 INFO - mozdebug == 0.1 07:29:56 INFO - mozdevice == 0.49 07:29:56 INFO - mozfile == 1.2 07:29:56 INFO - mozhttpd == 0.7 07:29:56 INFO - mozinfo == 0.9 07:29:56 INFO - mozleak == 0.1 07:29:56 INFO - mozlog == 3.4 07:29:56 INFO - moznetwork == 0.27 07:29:56 INFO - mozprocess == 0.23 07:29:56 INFO - mozprofile == 0.28 07:29:56 INFO - mozrunner == 6.13 07:29:56 INFO - mozscreenshot == 0.1 07:29:56 INFO - mozsystemmonitor == 0.3 07:29:56 INFO - moztest == 0.7 07:29:56 INFO - mozversion == 1.4 07:29:56 INFO - psutil == 3.1.1 07:29:56 INFO - requests == 1.2.3 07:29:56 INFO - wsgiref == 0.1.2 07:29:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:56 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:56 INFO - Using env: {'DISPLAY': ':0', 07:29:56 INFO - 'HOME': '/home/cltbld', 07:29:56 INFO - 'LANG': 'en_US.UTF-8', 07:29:56 INFO - 'LANGUAGE': 'en_US:en', 07:29:56 INFO - 'LOGNAME': 'cltbld', 07:29:56 INFO - 'MAIL': '/var/mail/cltbld', 07:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:56 INFO - 'MOZ_NO_REMOTE': '1', 07:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:56 INFO - 'NO_EM_RESTART': '1', 07:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:56 INFO - 'PWD': '/builds/slave/test', 07:29:56 INFO - 'SHELL': '/bin/bash', 07:29:56 INFO - 'SHLVL': '1', 07:29:56 INFO - 'TERM': 'linux', 07:29:56 INFO - 'TMOUT': '86400', 07:29:56 INFO - 'USER': 'cltbld', 07:29:56 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:56 INFO - '_': '/tools/buildbot/bin/python'} 07:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:29:56 INFO - Cleaning up... 07:29:56 INFO - Return code: 0 07:29:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:56 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 0x7fe329343e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', '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 07:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:29:56 INFO - Using env: {'DISPLAY': ':0', 07:29:56 INFO - 'HOME': '/home/cltbld', 07:29:56 INFO - 'LANG': 'en_US.UTF-8', 07:29:56 INFO - 'LANGUAGE': 'en_US:en', 07:29:56 INFO - 'LOGNAME': 'cltbld', 07:29:56 INFO - 'MAIL': '/var/mail/cltbld', 07:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:56 INFO - 'MOZ_NO_REMOTE': '1', 07:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:56 INFO - 'NO_EM_RESTART': '1', 07:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:56 INFO - 'PWD': '/builds/slave/test', 07:29:56 INFO - 'SHELL': '/bin/bash', 07:29:56 INFO - 'SHLVL': '1', 07:29:56 INFO - 'TERM': 'linux', 07:29:56 INFO - 'TMOUT': '86400', 07:29:56 INFO - 'USER': 'cltbld', 07:29:56 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:56 INFO - '_': '/tools/buildbot/bin/python'} 07:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:56 INFO - Cleaning up... 07:29:56 INFO - Return code: 0 07:29:56 INFO - Running post-action listener: _resource_record_post_action 07:29:56 INFO - Running post-action listener: _start_resource_monitoring 07:29:56 INFO - Starting resource monitoring. 07:29:56 INFO - [mozharness: 2016-12-09 15:29:56.675061Z] Finished create-virtualenv step (success) 07:29:56 INFO - [mozharness: 2016-12-09 15:29:56.675530Z] Running install step. 07:29:56 INFO - Running pre-action listener: _resource_record_pre_action 07:29:56 INFO - Running main action method: install 07:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:56 INFO - Reading from file tmpfile_stdout 07:29:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:56 INFO - Reading from file tmpfile_stdout 07:29:56 INFO - Output received: 07:29:56 INFO - Usage: mozinstall [options] installer 07:29:56 INFO - Options: 07:29:56 INFO - -h, --help show this help message and exit 07:29:56 INFO - -d DEST, --destination=DEST 07:29:56 INFO - Directory to install application into. [default: 07:29:56 INFO - "/builds/slave/test"] 07:29:56 INFO - --app=APP Application being installed. [default: firefox] 07:29:56 INFO - mkdir: /builds/slave/test/build/application 07:29:56 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'] 07:29:56 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 07:30:13 INFO - Reading from file tmpfile_stdout 07:30:13 INFO - Output received: 07:30:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:13 INFO - Running post-action listener: _resource_record_post_action 07:30:13 INFO - [mozharness: 2016-12-09 15:30:13.158397Z] Finished install step (success) 07:30:13 INFO - [mozharness: 2016-12-09 15:30:13.158641Z] Running run-tests step. 07:30:13 INFO - Running pre-action listener: _resource_record_pre_action 07:30:13 INFO - Running main action method: run_tests 07:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:13 INFO - Python 2.7.3 07:30:13 INFO - Return code: 0 07:30:13 INFO - grabbing minidump binary from tooltool 07:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x208df20>, '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 0x1ffac20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:30:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:30:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:30:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:13 INFO - Return code: 0 07:30:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:13 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/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:30:13 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/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 07:30:13 INFO - Using env: {'DISPLAY': ':0', 07:30:13 INFO - 'HOME': '/home/cltbld', 07:30:13 INFO - 'LANG': 'en_US.UTF-8', 07:30:13 INFO - 'LANGUAGE': 'en_US:en', 07:30:13 INFO - 'LOGNAME': 'cltbld', 07:30:13 INFO - 'MAIL': '/var/mail/cltbld', 07:30:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:13 INFO - 'MOZ_NO_REMOTE': '1', 07:30:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:13 INFO - 'NO_EM_RESTART': '1', 07:30:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:13 INFO - 'PWD': '/builds/slave/test', 07:30:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:13 INFO - 'SHELL': '/bin/bash', 07:30:13 INFO - 'SHLVL': '1', 07:30:13 INFO - 'TERM': 'linux', 07:30:13 INFO - 'TMOUT': '86400', 07:30:13 INFO - 'USER': 'cltbld', 07:30:13 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318', 07:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:13 INFO - '_': '/tools/buildbot/bin/python'} 07:30:13 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/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:30:13 INFO - mozversion application_buildid: 20161209062651 07:30:13 INFO - mozversion application_changeset: 383de455893c1511918b04c72191893877bd0b5e 07:30:13 INFO - mozversion application_display_name: Nightly 07:30:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:13 INFO - mozversion application_name: Firefox 07:30:13 INFO - mozversion application_remotingname: firefox 07:30:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:30:13 INFO - mozversion application_vendor: Mozilla 07:30:13 INFO - mozversion application_version: 53.0a1 07:30:13 INFO - mozversion platform_buildid: 20161209062651 07:30:13 INFO - mozversion platform_changeset: 383de455893c1511918b04c72191893877bd0b5e 07:30:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:30:13 INFO - mozversion platform_version: 53.0a1 07:30:13 INFO - using testdate: 1481297413 07:30:13 INFO - actual date: 1481297413 07:30:13 INFO - starting webserver on 'localhost:39597' 07:30:13 INFO - SUITE-START | Running 2 tests 07:30:13 INFO - TEST-START | dromaeo_css 07:30:13 INFO - operating with platform_type : linux_ 07:30:13 INFO - Initialising browser for dromaeo_css test... 07:30:13 INFO - TEST-INFO | started process 31396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv9NZci/profile http://localhost:39597/getInfo.html) 07:30:17 INFO - PROCESS | 31396 | __metrics Screen width/height:1600/1200 07:30:17 INFO - PROCESS | 31396 | colorDepth:24 07:30:17 INFO - PROCESS | 31396 | Browser inner width/height: 1024/697 07:30:17 INFO - PROCESS | 31396 | __metrics 07:30:18 INFO - PROCESS | 31396 | 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" 07:30:18 INFO - PROCESS | 31396 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:19 INFO - PROCESS | 31396 | console.error: PushService: 07:30:19 INFO - PROCESS | 31396 | stateChangeProcessEnqueue: Error transitioning state 07:30:19 INFO - PROCESS | 31396 | UnknownError 07:30:19 INFO - TEST-INFO | 31396: exit 0 07:30:19 INFO - Browser initialized. 07:30:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:19 INFO - TEST-INFO | started process 31478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv9NZci/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:32 INFO - PROCESS | 31478 | RSS: Main: 173236224 07:30:32 INFO - PROCESS | 31478 | 07:31:23 INFO - PROCESS | 31478 | 1481297483076 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] 07:33:37 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:39597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39597/tests/dromaeo/cssquery-ext.html) 07:33:40 INFO - PROCESS | 31478 | RSS: Main: 419328000 07:33:40 INFO - PROCESS | 31478 | 07:36:42 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:39597/tests/dromaeo/cssquery-ext.html (next: http://localhost:39597/tests/dromaeo/cssquery-jquery.html) 07:36:43 INFO - PROCESS | 31478 | RSS: Main: 288169984 07:36:43 INFO - PROCESS | 31478 | 07:39:46 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:39597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39597/tests/dromaeo/cssquery-mootools.html) 07:39:46 INFO - PROCESS | 31478 | RSS: Main: 220975104 07:39:46 INFO - PROCESS | 31478 | 07:42:49 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:39597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39597/tests/dromaeo/cssquery-prototype.html) 07:42:49 INFO - PROCESS | 31478 | RSS: Main: 227581952 07:42:49 INFO - PROCESS | 31478 | 07:45:52 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:39597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39597/tests/dromaeo/cssquery-yui.html) 07:45:53 INFO - PROCESS | 31478 | RSS: Main: 227692544 07:45:53 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | Cycle 1(1): loaded http://localhost:39597/tests/dromaeo/cssquery-yui.html (next: http://localhost:39597/tests/dromaeo/cssquery-dojo.html) 07:48:56 INFO - PROCESS | 31478 | RSS: Main: 317464576 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | __start_tp_report 07:48:56 INFO - PROCESS | 31478 | _x_x_mozilla_page_load 07:48:56 INFO - PROCESS | 31478 | _x_x_mozilla_page_load_details 07:48:56 INFO - PROCESS | 31478 | |i|pagename|runs| 07:48:56 INFO - PROCESS | 31478 | |0;dojo.html;2533.8479691218527;2600.635910972463;2616.110522422377;2624.19961911617;2627.566451535498;4511.887202819931;4572.291294849296;4575.816967321307;4622.468416132146;4638.605718513931;4549.339491085755;4551.658625603085;4557.08858228354;4561.7491037992895;4562.589366956973;4198.916021679573;4218.093109981353;4228.851990180345;4243.321068629005;4270.615644591986;4304.483461984566;4313.266744653416;4334.45819272591;4335.544767799383;4342.1532801103795;4224.302990006645;4237.936430953523;4260.70175087744;4270.1459708058355;4295.72077814941;4293.48478182617;4299.054208074219;4305.63402110821;4312.82748690052;4353.521112677603;4162.708610397273;4193.412922190896;4204.768737719424;4233;4236.4704411948505;4548.795304211319;4587.197240482902;4593.770311484413;4596.3794887690065;4610.008848097642;4892.461829198785;4902.19113846215;4913.2384480405235;4914.238293064581;4933.580645645125;4799.088173247072;4846.975765121187;4898.093852637274;4938.9012219755405;4983.202687569971;4578.381918441034;4589.495155532889;4593.219152744042;4593.311003349524;4602.171609110325;4956.702597844141;5010.849674509771;5014.774335154927;5070.41690205631;5075.6193285502995;4813.95186048135;4816.590589799836;4821.108095002436;4866.026794641086;4873.171560834667;4888.682235654671;4906.435759887588;4908.9263661045115;4915.16442204826;4958.033183529177;4653.208954477747;4765.833195838129;4771.23660214371;4796.8081276749235;4867.075255701406;4777.355057067251;4872.707637541759;4879.853604391874;4882.414110306786;4885.169521181337;4039.5758445362812;4048.0891799344913;4049.0687141957515;4050.25070361984;4058.3912413137673;3582.731295152874;3590.479380489867;3590.8922732318074;3607.9278414432088;3630.09247688078;4135.338345864648;4211.389348544444;4212.747235165839;4240;4270.551592082848;4900.5099490051425;4905.068037072945;4906.509349065065;4924.384451943507;4951.628627852925;4284.207421627009;4286.353912740709;4290.4636920384955;4325.286327755948;4329.437173167468;4284.485861696617;4325.4593175853015;4332.393464914851;4336.956630433719;4350.8042138103865;4663.253879379418;4669;4669.089527542097;4670.929936050894;4672.7429991349445;4866.197077482318;4918.114739346809;4920.753962301799;4924.778384972757;4926.531979461945;4643.8374656886845;4660.231061874752;4660.836870709509;4694.577488026094;4699.412573428322;4762.071396077731;4842.297866809364;4844.854654360375;4852.102361063215;4862.635302352409;4831.347768051268;4913.213885778258;4917.680350777188;4931.876703082452;4937.407511098691;4743.810247590196;4765.070811191785;4765.523447655345;4769.141554520081;4819.421669399554;4726.905461890812;4732.47942726293;4735.431748190239;4738.224061107564;4783.1868582341785;4608.032313214262;4641.327007583814;4658;4710.26990816424;4715.575598196178;4789.209780386197;4796.2805579163405;4809.5430934061205;4809.615230781459;4810.59109975656;4663.20725476663;4668.696534725232;4691.953080469151;4710;4756.857294281177 07:48:56 INFO - PROCESS | 31478 | |1;ext.html;522.1254398881873;535.8472835241956;537.2156651289117;563.5604228701612;568.9900426742535;27074.86462567687;29076.127716168496;29112.854435727793;29115.41769164618;29138.85430572844;37553.624463755354;38631.42052869209;38828.223435531276;42117.36823947643;42133.78933105338;7407.296306850867;7566.659500322498;7569.924300757005;7570.356519695805;7571.4321425893;7303.452241081914;7435.739749108782;7510;7519.511231769945;7523.924760752378;7194.928050719504;9496.715098547054;9750.658726944559;9757.804843903117;10053.49732513375;9515.381500202499;9586.904130958706;9593.808123837483;9595.23238140954;9601.567929443121;9505.5722492488;9574.617015319378;9577.760555986157;9577.856332155023;9582.616695332179;36244.63755362439;36682.266354673025;36683.63316366829;36687.26625467502;36737.448938265945;3064.0960916529675;3166.3508980658908;3255.230913297901;3344.8160351180677;3669.6880765134997;27471.45057098867;27599.724002759915;27730.722692773015;27822.165335039983;27900.72099279022;3328;3400.5409269748516;3555.6977656899194;3564.3405969895653;3564.3584154852115;241199;242024;242810;243959;244256.77871610707;50713;50999.74500127476;51209;51222.23166652503;51244.743776281626;52644.210336844975;53199;53279;53296.46703532915;53326.73336633292;12421.875781242252;12644.367781610883;12699.492020319269;12700.047496437805;12701.618951431472;9380.812383752287;9559.283053770994;9560.665376711782;9588.424694518211;9589.90410095904;13639.522616708367;13880.514182003782;14034.508792192224;15335.539933801781;15996.120213388376;5995.340512543617;6339.461145802658;6342.763161183617;6344.206974128234;6378.152604020885;820.429801288099;871.4379225399582;917.9862302065475;921.576075005505;964.3394274921561;25899;26482.86758566195;26945.461090778073;26971.595426068623;27196.32009199786;922.2852289475576;930.0885132570119;959.7696552827272;961.3174646001418;973.3186769261546;13318.733625327439;13982.580522584136;14014.318281806249;14352.856471435362;14606.05060671053;341967;345052;345151;346297;350336;40115.79942100271;40359;40401.76785857124;40425.595744042184;40435.7978210107;1107.5293000474767;1165.9008984236266;1174.541928647828;1175.371176420645;1189.4409627475072;23713.762862371157;24216.156033162955;24862.875685621457;25010.3747406309;25039.374015649028;36082;36399;36473.817630911675;36522;36547.45178822373;315709;316061;316223;318297;318976;21972.670409943545;22377.888110559343;22485.550288994455;22487.10051597918;22552;34451.827740862136;35462.82268588744;35751.28497430089;35810.462843057896;35942.460863086555;29273.268168295963;30067.548986764778;30313.696863031088;30348.84825575858;30397.696023039487;30027.849860750557;30068.54897176588;30667;30916;30986;29624.40751184921;29997.4000519984;30105.397892042474;30725.23186920345;30764;26478;27682.723172768016;27719.86140069287;27852.60736963103;27872.16383508498;21707.782922170576;21795.673064903724;21867.453313667287;22003.669944951158;22153.335399938027 07:48:56 INFO - PROCESS | 31478 | |2;jquery.html;340.8687655252727;342.6299596435848;359.87404408457036;366.91560940983584;385.25837762307566;12364.381780910951;15563.455279065234;15617.453389131382;16093.356265749357;16376.75434868475;15953.282102305395;15996.800239981989;16191.83808161918;16304.673906521892;16429.096399698014;4786.928196077061;4808;4876.244182151772;4905.190643543811;5018.5232402921665;4790.425148982127;4843.58829499493;4845.442774080991;4856.732879691615;4858.392700912386;3498.107982464468;3701.24124554467;5403.756830942617;5657.1514272858985;5667.518260947824;5556.9444305556835;5749.396313387076;5755.798547050854;5758.74085666146;5763.366029736705;4878.268259761029;4900.877478063041;4912.403468872595;4915.901681966377;4918.409790825088;18664.813351866444;19152.521186970298;19190;19288;19302.806971930382;1907.9154054444887;2034.2778313698573;2105.157936825267;2216.5788500184913;2344.6283923904534;11163.944180279128;11687.240329378648;12101.697457563543;12230.816537751942;12713.300768457731;1689.0963334616044;1722.1647500962024;1727.2141175765123;1733.566608347913;1774.7604073450048;62463;62741.68629156871;64104.3589564103;65502.67248663726;65599.3440065598;9217.76955576116;9374.265995672142;9475.573599188054;9716.805663886682;9751.853722194173;13011;13026;13041.673958151123;13055.28195949213;13058.738825223443;6396.936030639634;6546.639934803631;6735.797926062226;6766.28953959837;6770.796876093725;6128.785492507741;6152.907706384408;6288.622682639057;6295.087212354275;6299.842503937347;3858.479105320802;4022.939655905164;4125.195586860594;4209.768462734518;4270.7864606769535;1652.7108855093047;1736.7221244600803;1789.1412122181425;1793.8564914806784;1821.963560728778;775.6548335990431;810.3922058456158;815.7267315449272;842.7302067976335;849.2738708404225;15173.317200725773;16047.277872495766;16116.838831611769;16190.919045404698;16797.244124014447;824.5341382119084;830.7092517618785;831.5177197225595;836.7071524966213;846.3736834742369;8605.827883442296;9293.953530232306;9334.486603236886;9453.291003174789;9546;318731;350847;355393;359877;360221;63114.68442657849;64369.35630643727;71908.64045679738;73261.63369183226;73765;916.4684482999844;920.7053742802373;953.1469334945185;963.9807203855884;970.5244430229137;14988;15068.397264109752;15610.45363412275;15770.842291577397;15862.841371586137;33699;33704.66295337015;34711.305773883876;34810.47784283187;35105.29789404249;47037;48558.5144148554;48794.75602621964;48964.510354895996;49409;6803.829904252235;6816.250212476524;7096.716131354688;7135.6432178391915;7264.382527485011;7950.284474397332;10465.9476702616;10793.082587979796;11194.552217911518;11768.588099416822;9406.764830879283;9551.808963820824;9628.75928101803;10017.649382271586;10038.1467575254;9767.560459779184;9768.951155244178;9904.851427228741;10101.5454304555;10139.138173255062;9606.51967401641;9963.701088967342;10078.143357814668;10102.24233182529;10582.407310209048;7110.715571377087;7126.8218294540975;7173.892391614026;7183;7242.891356629761;6883.724651014104;7167.7132914682825;7271.963640181765;7444.069491313586;7506.849863002819 07:48:56 INFO - PROCESS | 31478 | |3;mootools.html;1227.8956288715458;1338.8661133886612;1340.758663440581;1422.7083447893183;1660.8422199891013;6446.709898054587;7049.612271325075;7193.6762845672;7281.52670076446;7396.297351751575;7226.421886249101;7230.891536626955;7244.927550724491;7259.6370181490975;7266.527675701076;1786.6873297172942;1861.0973677766272;2072.077925323228;2117.587070521249;2117.851750377474;2067.8345732341377;2137.978620213801;2160.330297607739;2166.04693934669;2181.6509358502644;2039.8368130549595;2067.720857684216;2068.9586208275828;2071.2129390831465;2086.822620077295;2063.711080448731;2072.336852207294;2073.409078412645;2076;2078.314156328408;2000.959980800376;2069.3998740365278;2087.3424871165685;2087.77034526202;2103.621348157331;6944.1666999959825;6972.546784459045;6979.546329488618;7029.402500787439;7065.4700897432895;4298.247806633826;4378.934315985262;4390.517043125254;4393;4399.36209249657;2743.067357098576;2784.0673374419594;2840.5029119903934;2840.5597132444504;2841.1476557032806;856.618804631939;884.4339622641514;909.5497728624307;922.4695799915008;928.6749637626776;9525.57134928923;9577.138057574852;9588.95205523975;9613;9686.32195746298;3759.398496240643;3932.2135572885536;3988.4216788565495;4023;4024.657904078186;8440.62017209227;8453.450525715809;8459.703910363107;8461.111583283666;8466.407351485337;4385.978070109629;4403.911921761611;4414.55854414556;4414.690971631955;4420.027593929331;3400.9659903401143;3513.0690367052753;3864.478295430137;3985.06351007513;3999.8200080996426;3291.325278317939;3301.5047742838287;3373.9662603373654;3403.812790296508;3408.9147771305916;1070.4701172919454;1116.6705821782593;1118.7762447510368;1126.3748619516248;1143.7255058785831;818.4189225649856;841.2092632925153;846.5640195299303;863.6027427383474;878.3280790195505;5034.446210916796;5065.9746701266995;5079.6698214615935;5276.709780962084;5300.072487314705;378.0642908800696;378.2963687541171;381.15574003582196;384.61538461538464;397.888591194466;3442.4492081266876;3602.6397360263763;3724.944125838115;3759.4548790425233;3767.2653832502947;8329.583520823935;8345.749627511184;8480.660773568989;8546;8665.653373865101;8489.575521223915;8489.660413583511;8571.742847714579;8619.267362274151;8639.438436501607;6533.901991470132;6715.194176698729;6735.158105236846;6750.493712971449;6754.6284954327;5034.84895453137;5041.117804384291;5058.140116180185;5064.848054558369;5081.8475445736685;7781.494202876795;7847.254510821463;7873.763787086396;7874.803129921569;7928.048634163937;8004.199580041949;8052.033755949324;8086.555239461651;8112.59437028158;8181.754547363588;5662;6190.628562286277;6252.499800016079;6286.434220919956;6288.308286088618;6365.204349456318;6494.220693516808;6494.772682956074;6496.285408604956;6500.577462464925;6191.535634827316;6387.105805187371;6440.25937017249;6446.645434501147;6619.602823830585;6070.119832624333;6087.147799308012;6140.600860944024;6167.599106058092;6196.132541444292;5915.792947246826;5994.460498555151;6019.608725432833;6021.518278537619;6032.939670603238;4424.800883960165;4550.203714349909;4554.726716397026;4597.402337696078;4602.6986506746625;4372.213001659732;4432.246518091868;4467.553244675506;4533.863984080483;4535.841245556389 07:48:56 INFO - PROCESS | 31478 | |4;prototype.html;336.90229833348326;339.5484006271659;345.3645292661503;353.46097201767316;353.94336906095015;4647.488776234612;4651.418572678415;4663.743494107823;4687.71873687579;4726.929096063557;4612.423447069116;4627;4627.167109920221;4651.232546629802;4690.835820746274;3616.119617798743;3634.2368102698397;3725.4784330193793;3732.4774531565604;3757.1170774867883;3751.8874433767032;3778.2065766188994;3783;3787.4697542344093;3799.734018618698;3731.738778285521;3754.3617585010616;3764.5106136202257;3765.585785563586;3768.4158955361963;3508.6317135549903;3632.291703117893;3659.2864391443677;3728.322254985254;3732.42147467143;3329.716974057208;3345.2640419107756;3367.3433680432327;3370.399060446293;3375.1562109472634;4508.752018638974;4518.977405112986;4532.954670453286;4535.841245556423;4540.364348991144;4116.403121547359;4262.552431994627;4282;4295.978520107411;4306.676999225039;4857;4858.416989961192;4867.853964381075;4877.244027175793;4893.804247830082;3635.94546081809;3646.2835187785004;3648.252108317815;3653.7442379033478;3681.3925702259094;5066.923996140061;5074.213496907985;5087.618428617869;5088.185890257578;5089.211172268304;3339.4990751387486;3487.843047062888;3490.965090349064;3508.491268766066;3744.43833424983;3544.627814079536;3555.7866528008403;3556.270964452281;3563.483294922222;3563.5901871284614;4067.7355971861734;4074.8166332515107;4077.89805254871;4086.346184610448;4096.235041347139;4577.178056322941;4825.9758701206265;4849.732235632691;4850.6362022848425;4856.878578035577;1210.4431961297726;1210.8062709966364;1220.6826225181517;1222.2422098298935;1222.706550427891;812.8496228197803;832.6919039955255;837.8282452097305;843.3759018326394;843.8143608406141;4237.300845360481;4306.181825453154;4367.213901497761;4437.400950871655;4450.599446049806;5016.613785694642;5060.468650791688;5069.935313584188;5070.6957582545165;5081.822136225214;4425;4431.534688857688;4435.562439109652;4437.911241775147;4439.62263207631;2542.427953710437;2557.4271822828828;2567.4608332250436;2583.405816662178;2591.4298854252033;4618.2841659542155;4625.7455839929125;4642.814287428532;4651.86044418668;4653.115907977541;4962.8759281018265;4964.528369804862;4991.825286114969;4999.975000124976;5006.523075692679;4462.3752674625575;4615.14619795339;4623.6822505586415;4641.976790116028;4664.183767840682;4855.271709243641;4861.781219845187;4866.416030076413;4876.853694389174;4884.877878053077;4759.595434388116;4777.904441911072;4793.185158523129;4799.544043315879;4814.109389762905;4434.645228381657;4619.884502887455;4754.786034628381;4785.6171506278715;4793.784279707352;3534.081138903852;3536.1513236823494;3577.678008979204;3600.819959001987;3609.5488063992;5096.241796580174;5103.642745007963;5104.749336412603;5106.463821298858;5121.411037730709;4718.31584420264;4929.186684197068;4955.603551715926;4961.479044700254;4964.553190212898;4939.802407903788;4941.975290123526;4949.57928576075;4949.752512374439;4957.3059771632725;4883.536064073907;4896.4858689838475;4898.142825005681;4898.387701537308;4919.434265059564;4885.415078283732;4886.486918873609;4960.652754307164;4984.551390374883;4997.300377947017;4779.928301075556;4781.832635857728;4797.424309082932;4854.5873600744335;4858.352198051999 07:48:56 INFO - PROCESS | 31478 | |5;yui.html;621.8258887511498;623.7692053940043;628.4846425930739;637.4358692557087;733.4572416411853;12196.085293602982;12766.744665106693;13277.800832987514;13438.193708377505;13531.797023044663;11680.357580333079;11810.468528916197;12248.26510409376;12360.072994525424;12376.257424554511;778.217891019526;792.8295416485455;792.9088154862206;793.488200110931;793.8134538383475;620.0637038072498;649.5355820588278;749.3181205103357;785.6307535458326;791.1574173505198;800.9639566219505;801.5190885468701;802.9718959836407;803.2048272210528;803.5259197073725;794.7417089445895;795.3517882925455;796.6415113199025;796.8326651403183;796.8366484870617;477.2697772408221;495.52924721514705;568.377626498983;593.7892048322869;597.5518361229078;13591.32043397836;13597.252151131685;13598.252096134807;13616.319184040858;13624.795628065587;12292.877071229263;12341.876581234163;12477.126601137834;12777.488900443972;12798.232106073665;10155.136813370873;10418.68743937683;10483.213758968031;11928.972074747313;11929.582464613784;4060.5127384714024;4062.695297852673;4066.1054567994993;4070.75575465473;4077.2253271878544;55289.72355138198;56824.14763778546;57061.71469142628;57452.71273643605;58881.41118588845;9907.504624768877;10051.246156538142;10058.798824023625;10213.080822725842;10350.53422595985;17764.045954944944;17789.644207115784;17927.910360448375;17931.013794241182;18325.083745812655;6487.513436492282;6654.73381064752;6676.499262555328;6724.428423583952;6908.827279318058;3510.5962814276686;3558.3594952908725;3572.8392222350058;3597.982010089985;3694.9445758313645;2655.1636234586044;2713.511567917794;2721.129238643615;2755.655543057118;2827.8444685542495;469.1742533141695;469.6407248454935;475.55060467857544;477.1173329340761;480.46188269138787;467.8081986385566;486.5815398757066;530.3158924986724;554.4510934175219;557.584599473395;7199.71201151948;7275.308845659654;7365;7428.73999410018;7429.956761890523;448.1552273963602;466.86694292126583;467.8152129908667;492.99921160045164;539.0862488082662;3228.4188846007946;3406.42090844557;3438.638942910958;3440.8451619677176;3754.568224654145;63026.369736302964;64967.67516162389;64985.35014649887;68352.3164768356;68754.65622671855;57168.428315717145;58008.709956449944;60262;60536;60602;42511;52369.47630523722;52657.473425265256;52726;53698.46301537013;8331.50010999342;8839.779005524913;8937.687180948635;9046.683366082156;9120.908790912006;32371.028869133963;33265.50305236222;34219.65780342164;34399.82800085984;34972.825135874155;41034;46071.76964115158;46513.302300466195;46517;46529;10575.382952240649;10599.89400105989;10752.76322283767;10775.299605525615;11169;12042.698932526406;12212.473440819898;12328.691782705504;12629.747405051663;13114;11116.61091861781;11239.60661376848;11240.437978101227;11283.943580282046;11593.072554195813;11550.768984620428;12016.63950081499;12051.457684404048;12101.933023691003;12377.566785162477;11813.350265735467;11948.283103013848;11952.64142075739;12021.398930053287;12105.273683578662;9759.9024009759;9855.556499957376;9969.950150249493;10049.497525123861;10604.787904242026;10194.592216311265;10369.222308326755;10497.895021049691;10584.994425529563;10697.51861166265 07:48:56 INFO - PROCESS | 31478 | __end_tp_report 07:48:56 INFO - PROCESS | 31478 | __start_cc_report 07:48:56 INFO - PROCESS | 31478 | _x_x_mozilla_cycle_collect,2820 07:48:56 INFO - PROCESS | 31478 | __end_cc_report 07:48:56 INFO - PROCESS | 31478 | __startTimestamp1481298536767__endTimestamp 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | ------- Summary: start ------- 07:48:56 INFO - PROCESS | 31478 | Number of tests: 6 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | [#0] dojo.html Cycles:165 Average:4531.93 Median:4663.21 stddev:466.48 (10.0%) stddev-sans-first:440.79 07:48:56 INFO - PROCESS | 31478 | Values: 2533.8 2600.6 2616.1 2624.2 2627.6 4511.9 4572.3 4575.8 4622.5 4638.6 4549.3 4551.7 4557.1 4561.7 4562.6 4198.9 4218.1 4228.9 4243.3 4270.6 4304.5 4313.3 4334.5 4335.5 4342.2 4224.3 4237.9 4260.7 4270.1 4295.7 4293.5 4299.1 4305.6 4312.8 4353.5 4162.7 4193.4 4204.8 4233.0 4236.5 4548.8 4587.2 4593.8 4596.4 4610.0 4892.5 4902.2 4913.2 4914.2 4933.6 4799.1 4847.0 4898.1 4938.9 4983.2 4578.4 4589.5 4593.2 4593.3 4602.2 4956.7 5010.8 5014.8 5070.4 5075.6 4814.0 4816.6 4821.1 4866.0 4873.2 4888.7 4906.4 4908.9 4915.2 4958.0 4653.2 4765.8 4771.2 4796.8 4867.1 4777.4 4872.7 4879.9 4882.4 4885.2 4039.6 4048.1 4049.1 4050.3 4058.4 3582.7 3590.5 3590.9 3607.9 3630.1 4135.3 4211.4 4212.7 4240.0 4270.6 4900.5 4905.1 4906.5 4924.4 4951.6 4284.2 4286.4 4290.5 4325.3 4329.4 4284.5 4325.5 4332.4 4337.0 4350.8 4663.3 4669.0 4669.1 4670.9 4672.7 4866.2 4918.1 4920.8 4924.8 4926.5 4643.8 4660.2 4660.8 4694.6 4699.4 4762.1 4842.3 4844.9 4852.1 4862.6 4831.3 4913.2 4917.7 4931.9 4937.4 4743.8 4765.1 4765.5 4769.1 4819.4 4726.9 4732.5 4735.4 4738.2 4783.2 4608.0 4641.3 4658.0 4710.3 4715.6 4789.2 4796.3 4809.5 4809.6 4810.6 4663.2 4668.7 4692.0 4710.0 4756.9 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | [#1] ext.html Cycles:180 Average:43881.40 Median:345724.00 stddev:80297.41 (23.2%) stddev-sans-first:80456.67 07:48:56 INFO - PROCESS | 31478 | Values: 522.1 535.8 537.2 563.6 569.0 27074.9 29076.1 29112.9 29115.4 29138.9 37553.6 38631.4 38828.2 42117.4 42133.8 7407.3 7566.7 7569.9 7570.4 7571.4 7303.5 7435.7 7510.0 7519.5 7523.9 7194.9 9496.7 9750.7 9757.8 10053.5 9515.4 9586.9 9593.8 9595.2 9601.6 9505.6 9574.6 9577.8 9577.9 9582.6 36244.6 36682.3 36683.6 36687.3 36737.4 3064.1 3166.4 3255.2 3344.8 3669.7 27471.5 27599.7 27730.7 27822.2 27900.7 3328.0 3400.5 3555.7 3564.3 3564.4 241199.0 242024.0 242810.0 243959.0 244256.8 50713.0 50999.7 51209.0 51222.2 51244.7 52644.2 53199.0 53279.0 53296.5 53326.7 12421.9 12644.4 12699.5 12700.0 12701.6 9380.8 9559.3 9560.7 9588.4 9589.9 13639.5 13880.5 14034.5 15335.5 15996.1 5995.3 6339.5 6342.8 6344.2 6378.2 820.4 871.4 918.0 921.6 964.3 25899.0 26482.9 26945.5 26971.6 27196.3 922.3 930.1 959.8 961.3 973.3 13318.7 13982.6 14014.3 14352.9 14606.1 341967.0 345052.0 345151.0 346297.0 350336.0 40115.8 40359.0 40401.8 40425.6 40435.8 1107.5 1165.9 1174.5 1175.4 1189.4 23713.8 24216.2 24862.9 25010.4 25039.4 36082.0 36399.0 36473.8 36522.0 36547.5 315709.0 316061.0 316223.0 318297.0 318976.0 21972.7 22377.9 22485.6 22487.1 22552.0 34451.8 35462.8 35751.3 35810.5 35942.5 29273.3 30067.5 30313.7 30348.8 30397.7 30027.8 30068.5 30667.0 30916.0 30986.0 29624.4 29997.4 30105.4 30725.2 30764.0 26478.0 27682.7 27719.9 27852.6 27872.2 21707.8 21795.7 21867.5 22003.7 22153.3 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | [#2] jquery.html Cycles:180 Average:22316.99 Median:4857.56 stddev:57712.68 (1188.1%) stddev-sans-first:57850.99 07:48:56 INFO - PROCESS | 31478 | Values: 340.9 342.6 359.9 366.9 385.3 12364.4 15563.5 15617.5 16093.4 16376.8 15953.3 15996.8 16191.8 16304.7 16429.1 4786.9 4808.0 4876.2 4905.2 5018.5 4790.4 4843.6 4845.4 4856.7 4858.4 3498.1 3701.2 5403.8 5657.2 5667.5 5556.9 5749.4 5755.8 5758.7 5763.4 4878.3 4900.9 4912.4 4915.9 4918.4 18664.8 19152.5 19190.0 19288.0 19302.8 1907.9 2034.3 2105.2 2216.6 2344.6 11163.9 11687.2 12101.7 12230.8 12713.3 1689.1 1722.2 1727.2 1733.6 1774.8 62463.0 62741.7 64104.4 65502.7 65599.3 9217.8 9374.3 9475.6 9716.8 9751.9 13011.0 13026.0 13041.7 13055.3 13058.7 6396.9 6546.6 6735.8 6766.3 6770.8 6128.8 6152.9 6288.6 6295.1 6299.8 3858.5 4022.9 4125.2 4209.8 4270.8 1652.7 1736.7 1789.1 1793.9 1822.0 775.7 810.4 815.7 842.7 849.3 15173.3 16047.3 16116.8 16190.9 16797.2 824.5 830.7 831.5 836.7 846.4 8605.8 9294.0 9334.5 9453.3 9546.0 318731.0 350847.0 355393.0 359877.0 360221.0 63114.7 64369.4 71908.6 73261.6 73765.0 916.5 920.7 953.1 964.0 970.5 14988.0 15068.4 15610.5 15770.8 15862.8 33699.0 33704.7 34711.3 34810.5 35105.3 47037.0 48558.5 48794.8 48964.5 49409.0 6803.8 6816.3 7096.7 7135.6 7264.4 7950.3 10465.9 10793.1 11194.6 11768.6 9406.8 9551.8 9628.8 10017.6 10038.1 9767.6 9769.0 9904.9 10101.5 10139.1 9606.5 9963.7 10078.1 10102.2 10582.4 7110.7 7126.8 7173.9 7183.0 7242.9 6883.7 7167.7 7272.0 7444.1 7506.8 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | [#3] mootools.html Cycles:180 Average:4742.28 Median:5072.82 stddev:2573.60 (50.7%) stddev-sans-first:2567.26 07:48:56 INFO - PROCESS | 31478 | Values: 1227.9 1338.9 1340.8 1422.7 1660.8 6446.7 7049.6 7193.7 7281.5 7396.3 7226.4 7230.9 7244.9 7259.6 7266.5 1786.7 1861.1 2072.1 2117.6 2117.9 2067.8 2138.0 2160.3 2166.0 2181.7 2039.8 2067.7 2069.0 2071.2 2086.8 2063.7 2072.3 2073.4 2076.0 2078.3 2001.0 2069.4 2087.3 2087.8 2103.6 6944.2 6972.5 6979.5 7029.4 7065.5 4298.2 4378.9 4390.5 4393.0 4399.4 2743.1 2784.1 2840.5 2840.6 2841.1 856.6 884.4 909.5 922.5 928.7 9525.6 9577.1 9589.0 9613.0 9686.3 3759.4 3932.2 3988.4 4023.0 4024.7 8440.6 8453.5 8459.7 8461.1 8466.4 4386.0 4403.9 4414.6 4414.7 4420.0 3401.0 3513.1 3864.5 3985.1 3999.8 3291.3 3301.5 3374.0 3403.8 3408.9 1070.5 1116.7 1118.8 1126.4 1143.7 818.4 841.2 846.6 863.6 878.3 5034.4 5066.0 5079.7 5276.7 5300.1 378.1 378.3 381.2 384.6 397.9 3442.4 3602.6 3724.9 3759.5 3767.3 8329.6 8345.7 8480.7 8546.0 8665.7 8489.6 8489.7 8571.7 8619.3 8639.4 6533.9 6715.2 6735.2 6750.5 6754.6 5034.8 5041.1 5058.1 5064.8 5081.8 7781.5 7847.3 7873.8 7874.8 7928.0 8004.2 8052.0 8086.6 8112.6 8181.8 5662.0 6190.6 6252.5 6286.4 6288.3 6365.2 6494.2 6494.8 6496.3 6500.6 6191.5 6387.1 6440.3 6446.6 6619.6 6070.1 6087.1 6140.6 6167.6 6196.1 5915.8 5994.5 6019.6 6021.5 6032.9 4424.8 4550.2 4554.7 4597.4 4602.7 4372.2 4432.2 4467.6 4533.9 4535.8 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | [#4] prototype.html Cycles:180 Average:4068.17 Median:4619.08 stddev:1165.83 (25.2%) stddev-sans-first:1134.96 07:48:56 INFO - PROCESS | 31478 | Values: 336.9 339.5 345.4 353.5 353.9 4647.5 4651.4 4663.7 4687.7 4726.9 4612.4 4627.0 4627.2 4651.2 4690.8 3616.1 3634.2 3725.5 3732.5 3757.1 3751.9 3778.2 3783.0 3787.5 3799.7 3731.7 3754.4 3764.5 3765.6 3768.4 3508.6 3632.3 3659.3 3728.3 3732.4 3329.7 3345.3 3367.3 3370.4 3375.2 4508.8 4519.0 4533.0 4535.8 4540.4 4116.4 4262.6 4282.0 4296.0 4306.7 4857.0 4858.4 4867.9 4877.2 4893.8 3635.9 3646.3 3648.3 3653.7 3681.4 5066.9 5074.2 5087.6 5088.2 5089.2 3339.5 3487.8 3491.0 3508.5 3744.4 3544.6 3555.8 3556.3 3563.5 3563.6 4067.7 4074.8 4077.9 4086.3 4096.2 4577.2 4826.0 4849.7 4850.6 4856.9 1210.4 1210.8 1220.7 1222.2 1222.7 812.8 832.7 837.8 843.4 843.8 4237.3 4306.2 4367.2 4437.4 4450.6 5016.6 5060.5 5069.9 5070.7 5081.8 4425.0 4431.5 4435.6 4437.9 4439.6 2542.4 2557.4 2567.5 2583.4 2591.4 4618.3 4625.7 4642.8 4651.9 4653.1 4962.9 4964.5 4991.8 5000.0 5006.5 4462.4 4615.1 4623.7 4642.0 4664.2 4855.3 4861.8 4866.4 4876.9 4884.9 4759.6 4777.9 4793.2 4799.5 4814.1 4434.6 4619.9 4754.8 4785.6 4793.8 3534.1 3536.2 3577.7 3600.8 3609.5 5096.2 5103.6 5104.7 5106.5 5121.4 4718.3 4929.2 4955.6 4961.5 4964.6 4939.8 4942.0 4949.6 4949.8 4957.3 4883.5 4896.5 4898.1 4898.4 4919.4 4885.4 4886.5 4960.7 4984.6 4997.3 4779.9 4781.8 4797.4 4854.6 4858.4 07:48:56 INFO - PROCESS | 31478 | 07:48:56 INFO - PROCESS | 31478 | [#5] yui.html Cycles:180 Average:14563.36 Median:22555.61 stddev:18036.22 (80.0%) stddev-sans-first:18056.43 07:48:56 INFO - PROCESS | 31478 | Values: 621.8 623.8 628.5 637.4 733.5 12196.1 12766.7 13277.8 13438.2 13531.8 11680.4 11810.5 12248.3 12360.1 12376.3 778.2 792.8 792.9 793.5 793.8 620.1 649.5 749.3 785.6 791.2 801.0 801.5 803.0 803.2 803.5 794.7 795.4 796.6 796.8 796.8 477.3 495.5 568.4 593.8 597.6 13591.3 13597.3 13598.3 13616.3 13624.8 12292.9 12341.9 12477.1 12777.5 12798.2 10155.1 10418.7 10483.2 11929.0 11929.6 4060.5 4062.7 4066.1 4070.8 4077.2 55289.7 56824.1 57061.7 57452.7 58881.4 9907.5 10051.2 10058.8 10213.1 10350.5 17764.0 17789.6 17927.9 17931.0 18325.1 6487.5 6654.7 6676.5 6724.4 6908.8 3510.6 3558.4 3572.8 3598.0 3694.9 2655.2 2713.5 2721.1 2755.7 2827.8 469.2 469.6 475.6 477.1 480.5 467.8 486.6 530.3 554.5 557.6 7199.7 7275.3 7365.0 7428.7 7430.0 448.2 466.9 467.8 493.0 539.1 3228.4 3406.4 3438.6 3440.8 3754.6 63026.4 64967.7 64985.4 68352.3 68754.7 57168.4 58008.7 60262.0 60536.0 60602.0 42511.0 52369.5 52657.5 52726.0 53698.5 8331.5 8839.8 8937.7 9046.7 9120.9 32371.0 33265.5 34219.7 34399.8 34972.8 41034.0 46071.8 46513.3 46517.0 46529.0 10575.4 10599.9 10752.8 10775.3 11169.0 12042.7 12212.5 12328.7 12629.7 13114.0 11116.6 11239.6 11240.4 11283.9 11593.1 11550.8 12016.6 12051.5 12101.9 12377.6 11813.4 11948.3 11952.6 12021.4 12105.3 9759.9 9855.6 9970.0 10049.5 10604.8 10194.6 10369.2 10497.9 10585.0 10697.5 07:48:56 INFO - PROCESS | 31478 | -------- Summary: end -------- 07:48:56 INFO - PROCESS | 31478 | 07:48:57 INFO - TEST-INFO | 31478: exit 0 07:48:57 INFO - TEST-OK | dromaeo_css | took 1124351ms 07:48:57 INFO - TEST-START | kraken 07:48:57 INFO - operating with platform_type : linux_ 07:48:57 INFO - Initialising browser for kraken test... 07:48:57 INFO - TEST-INFO | started process 31815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfEKRd/profile http://localhost:39597/getInfo.html) 07:49:02 INFO - PROCESS | 31815 | __metrics Screen width/height:1600/1200 07:49:02 INFO - PROCESS | 31815 | colorDepth:24 07:49:02 INFO - PROCESS | 31815 | Browser inner width/height: 1024/697 07:49:02 INFO - PROCESS | 31815 | __metrics 07:49:02 INFO - PROCESS | 31815 | 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" 07:49:02 INFO - PROCESS | 31815 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:04 INFO - TEST-INFO | 31815: exit 0 07:49:04 INFO - Browser initialized. 07:49:04 INFO - Running cycle 1/1 for kraken test... 07:49:04 INFO - TEST-INFO | started process 31900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDfEKRd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:16 INFO - PROCESS | 31900 | RSS: Main: 173375488 07:49:16 INFO - PROCESS | 31900 | 07:49:19 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39597/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:20 INFO - PROCESS | 31900 | RSS: Main: 239828992 07:49:20 INFO - PROCESS | 31900 | 07:49:22 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39597/tests/kraken/driver.html?testName=audio-dft) 07:49:23 INFO - PROCESS | 31900 | RSS: Main: 218144768 07:49:23 INFO - PROCESS | 31900 | 07:49:26 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39597/tests/kraken/driver.html?testName=audio-fft) 07:49:27 INFO - PROCESS | 31900 | RSS: Main: 300253184 07:49:27 INFO - PROCESS | 31900 | 07:49:29 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39597/tests/kraken/driver.html?testName=audio-oscillator) 07:49:30 INFO - PROCESS | 31900 | RSS: Main: 209743872 07:49:30 INFO - PROCESS | 31900 | 07:49:32 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:32 INFO - PROCESS | 31900 | RSS: Main: 214110208 07:49:32 INFO - PROCESS | 31900 | 07:49:36 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39597/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:36 INFO - PROCESS | 31900 | RSS: Main: 253456384 07:49:36 INFO - PROCESS | 31900 | 07:49:40 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39597/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:40 INFO - PROCESS | 31900 | RSS: Main: 253296640 07:49:40 INFO - PROCESS | 31900 | 07:49:43 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39597/tests/kraken/driver.html?testName=json-parse-financial) 07:49:44 INFO - PROCESS | 31900 | RSS: Main: 252379136 07:49:44 INFO - PROCESS | 31900 | 07:49:46 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:46 INFO - PROCESS | 31900 | RSS: Main: 214339584 07:49:46 INFO - PROCESS | 31900 | 07:49:48 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:49 INFO - PROCESS | 31900 | RSS: Main: 221593600 07:49:49 INFO - PROCESS | 31900 | 07:49:51 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:52 INFO - PROCESS | 31900 | RSS: Main: 226250752 07:49:52 INFO - PROCESS | 31900 | 07:49:55 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:55 INFO - PROCESS | 31900 | RSS: Main: 224890880 07:49:55 INFO - PROCESS | 31900 | 07:49:58 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:59 INFO - PROCESS | 31900 | RSS: Main: 227430400 07:49:59 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | Cycle 1(1): loaded http://localhost:39597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39597/tests/kraken/driver.html?testName=ai-astar) 07:50:01 INFO - PROCESS | 31900 | RSS: Main: 280621056 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | __start_tp_report 07:50:01 INFO - PROCESS | 31900 | _x_x_mozilla_page_load 07:50:01 INFO - PROCESS | 31900 | _x_x_mozilla_page_load_details 07:50:01 INFO - PROCESS | 31900 | |i|pagename|runs| 07:50:01 INFO - PROCESS | 31900 | |0;ai-astar;106;115;116;117;114;116;114;115;115;116 07:50:01 INFO - PROCESS | 31900 | |1;audio-beat-detection;152;128;131;169;129;133;130;128;153;133 07:50:01 INFO - PROCESS | 31900 | |2;audio-dft;162;161;164;163;162;160;162;162;161;161 07:50:01 INFO - PROCESS | 31900 | |3;audio-fft;77;76;76;110;78;78;78;76;90;77 07:50:01 INFO - PROCESS | 31900 | |4;audio-oscillator;86;87;107;85;85;85;99;85;85;113 07:50:01 INFO - PROCESS | 31900 | |5;imaging-gaussian-blur;127;126;127;127;126;128;128;129;129;127 07:50:01 INFO - PROCESS | 31900 | |6;imaging-darkroom;146;146;147;146;147;146;147;147;147;146 07:50:01 INFO - PROCESS | 31900 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 07:50:01 INFO - PROCESS | 31900 | |8;json-parse-financial;66;66;65;66;68;69;68;67;67;66 07:50:01 INFO - PROCESS | 31900 | |9;json-stringify-tinderbox;66;66;66;66;66;66;66;67;70;66 07:50:01 INFO - PROCESS | 31900 | |10;stanford-crypto-aes;91;90;96;97;89;89;90;94;120;90 07:50:01 INFO - PROCESS | 31900 | |11;stanford-crypto-ccm;149;142;139;140;137;139;140;140;151;149 07:50:01 INFO - PROCESS | 31900 | |12;stanford-crypto-pbkdf2;184;188;184;183;185;182;186;183;183;182 07:50:01 INFO - PROCESS | 31900 | |13;stanford-crypto-sha256-iterative;70;68;69;69;78;73;71;69;68;67 07:50:01 INFO - PROCESS | 31900 | __end_tp_report 07:50:01 INFO - PROCESS | 31900 | __start_cc_report 07:50:01 INFO - PROCESS | 31900 | _x_x_mozilla_cycle_collect,1913 07:50:01 INFO - PROCESS | 31900 | __end_cc_report 07:50:01 INFO - PROCESS | 31900 | __startTimestamp1481298601543__endTimestamp 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | ------- Summary: start ------- 07:50:01 INFO - PROCESS | 31900 | Number of tests: 14 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.50 stddev:3.10 (2.7%) stddev-sans-first:1.00 07:50:01 INFO - PROCESS | 31900 | Values: 106.0 115.0 116.0 117.0 114.0 116.0 114.0 115.0 115.0 116.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:133.00 stddev:14.23 (10.7%) stddev-sans-first:14.24 07:50:01 INFO - PROCESS | 31900 | Values: 152.0 128.0 131.0 169.0 129.0 133.0 130.0 128.0 153.0 133.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 07:50:01 INFO - PROCESS | 31900 | Values: 162.0 161.0 164.0 163.0 162.0 160.0 162.0 162.0 161.0 161.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.50 stddev:10.81 (14.0%) stddev-sans-first:11.34 07:50:01 INFO - PROCESS | 31900 | Values: 77.0 76.0 76.0 110.0 78.0 78.0 78.0 76.0 90.0 77.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:85.00 stddev:10.65 (12.5%) stddev-sans-first:11.09 07:50:01 INFO - PROCESS | 31900 | Values: 86.0 87.0 107.0 85.0 85.0 85.0 99.0 85.0 85.0 113.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#5] imaging-gaussian-blur Cycles:10 Average:127.40 Median:127.50 stddev:1.07 (0.8%) stddev-sans-first:1.13 07:50:01 INFO - PROCESS | 31900 | Values: 127.0 126.0 127.0 127.0 126.0 128.0 128.0 129.0 129.0 127.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:50:01 INFO - PROCESS | 31900 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:50:01 INFO - PROCESS | 31900 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 07:50:01 INFO - PROCESS | 31900 | Values: 66.0 66.0 65.0 66.0 68.0 69.0 68.0 67.0 67.0 66.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 07:50:01 INFO - PROCESS | 31900 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 70.0 66.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:90.50 stddev:9.38 (10.4%) stddev-sans-first:9.86 07:50:01 INFO - PROCESS | 31900 | Values: 91.0 90.0 96.0 97.0 89.0 89.0 90.0 94.0 120.0 90.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:141.00 stddev:5.06 (3.6%) stddev-sans-first:4.81 07:50:01 INFO - PROCESS | 31900 | Values: 149.0 142.0 139.0 140.0 137.0 139.0 140.0 140.0 151.0 149.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:184.00 stddev:1.89 (1.0%) stddev-sans-first:2.00 07:50:01 INFO - PROCESS | 31900 | Values: 184.0 188.0 184.0 183.0 185.0 182.0 186.0 183.0 183.0 182.0 07:50:01 INFO - PROCESS | 31900 | 07:50:01 INFO - PROCESS | 31900 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:3.22 (4.6%) stddev-sans-first:3.42 07:50:01 INFO - PROCESS | 31900 | Values: 70.0 68.0 69.0 69.0 78.0 73.0 71.0 69.0 68.0 67.0 07:50:01 INFO - PROCESS | 31900 | -------- Summary: end -------- 07:50:01 INFO - PROCESS | 31900 | 07:50:02 INFO - TEST-INFO | 31900: exit 0 07:50:02 INFO - TEST-OK | kraken | took 65087ms 07:50:02 INFO - SUITE-END | took 1189s 07:50:03 INFO - Completed test suite (00:19:49) 07:50:03 INFO - javascript benchmark 07:50:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2533.8479691218527, 2600.635910972463, 2616.110522422377, 2624.19961911617, 2627.566451535498, 4511.887202819931, 4572.291294849296, 4575.816967321307, 4622.468416132146, 4638.605718513931, 4549.339491085755, 4551.658625603085, 4557.08858228354, 4561.7491037992895, 4562.589366956973, 4198.916021679573, 4218.093109981353, 4228.851990180345, 4243.321068629005, 4270.615644591986, 4304.483461984566, 4313.266744653416, 4334.45819272591, 4335.544767799383, 4342.1532801103795, 4224.302990006645, 4237.936430953523, 4260.70175087744, 4270.1459708058355, 4295.72077814941, 4293.48478182617, 4299.054208074219, 4305.63402110821, 4312.82748690052, 4353.521112677603, 4162.708610397273, 4193.412922190896, 4204.768737719424, 4233.0, 4236.4704411948505, 4548.795304211319, 4587.197240482902, 4593.770311484413, 4596.3794887690065, 4610.008848097642, 4892.461829198785, 4902.19113846215, 4913.2384480405235, 4914.238293064581, 4933.580645645125, 4799.088173247072, 4846.975765121187, 4898.093852637274, 4938.9012219755405, 4983.202687569971, 4578.381918441034, 4589.495155532889, 4593.219152744042, 4593.311003349524, 4602.171609110325, 4956.702597844141, 5010.849674509771, 5014.774335154927, 5070.41690205631, 5075.6193285502995, 4813.95186048135, 4816.590589799836, 4821.108095002436, 4866.026794641086, 4873.171560834667, 4888.682235654671, 4906.435759887588, 4908.9263661045115, 4915.16442204826, 4958.033183529177, 4653.208954477747, 4765.833195838129, 4771.23660214371, 4796.8081276749235, 4867.075255701406, 4777.355057067251, 4872.707637541759, 4879.853604391874, 4882.414110306786, 4885.169521181337, 4039.5758445362812, 4048.0891799344913, 4049.0687141957515, 4050.25070361984, 4058.3912413137673, 3582.731295152874, 3590.479380489867, 3590.8922732318074, 3607.9278414432088, 3630.09247688078, 4135.338345864648, 4211.389348544444, 4212.747235165839, 4240.0, 4270.551592082848, 4900.5099490051425, 4905.068037072945, 4906.509349065065, 4924.384451943507, 4951.628627852925, 4284.207421627009, 4286.353912740709, 4290.4636920384955, 4325.286327755948, 4329.437173167468, 4284.485861696617, 4325.4593175853015, 4332.393464914851, 4336.956630433719, 4350.8042138103865, 4663.253879379418, 4669.0, 4669.089527542097, 4670.929936050894, 4672.7429991349445, 4866.197077482318, 4918.114739346809, 4920.753962301799, 4924.778384972757, 4926.531979461945, 4643.8374656886845, 4660.231061874752, 4660.836870709509, 4694.577488026094, 4699.412573428322, 4762.071396077731, 4842.297866809364, 4844.854654360375, 4852.102361063215, 4862.635302352409, 4831.347768051268, 4913.213885778258, 4917.680350777188, 4931.876703082452, 4937.407511098691, 4743.810247590196, 4765.070811191785, 4765.523447655345, 4769.141554520081, 4819.421669399554, 4726.905461890812, 4732.47942726293, 4735.431748190239, 4738.224061107564, 4783.1868582341785, 4608.032313214262, 4641.327007583814, 4658.0, 4710.26990816424, 4715.575598196178, 4789.209780386197, 4796.2805579163405, 4809.5430934061205, 4809.615230781459, 4810.59109975656, 4663.20725476663, 4668.696534725232, 4691.953080469151, 4710.0, 4756.857294281177], "value": 4502.660895674193, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.1254398881873, 535.8472835241956, 537.2156651289117, 563.5604228701612, 568.9900426742535, 27074.86462567687, 29076.127716168496, 29112.854435727793, 29115.41769164618, 29138.85430572844, 37553.624463755354, 38631.42052869209, 38828.223435531276, 42117.36823947643, 42133.78933105338, 7407.296306850867, 7566.659500322498, 7569.924300757005, 7570.356519695805, 7571.4321425893, 7303.452241081914, 7435.739749108782, 7510.0, 7519.511231769945, 7523.924760752378, 7194.928050719504, 9496.715098547054, 9750.658726944559, 9757.804843903117, 10053.49732513375, 9515.381500202499, 9586.904130958706, 9593.808123837483, 9595.23238140954, 9601.567929443121, 9505.5722492488, 9574.617015319378, 9577.760555986157, 9577.856332155023, 9582.616695332179, 36244.63755362439, 36682.266354673025, 36683.63316366829, 36687.26625467502, 36737.448938265945, 3064.0960916529675, 3166.3508980658908, 3255.230913297901, 3344.8160351180677, 3669.6880765134997, 27471.45057098867, 27599.724002759915, 27730.722692773015, 27822.165335039983, 27900.72099279022, 3328.0, 3400.5409269748516, 3555.6977656899194, 3564.3405969895653, 3564.3584154852115, 241199.0, 242024.0, 242810.0, 243959.0, 244256.77871610707, 50713.0, 50999.74500127476, 51209.0, 51222.23166652503, 51244.743776281626, 52644.210336844975, 53199.0, 53279.0, 53296.46703532915, 53326.73336633292, 12421.875781242252, 12644.367781610883, 12699.492020319269, 12700.047496437805, 12701.618951431472, 9380.812383752287, 9559.283053770994, 9560.665376711782, 9588.424694518211, 9589.90410095904, 13639.522616708367, 13880.514182003782, 14034.508792192224, 15335.539933801781, 15996.120213388376, 5995.340512543617, 6339.461145802658, 6342.763161183617, 6344.206974128234, 6378.152604020885, 820.429801288099, 871.4379225399582, 917.9862302065475, 921.576075005505, 964.3394274921561, 25899.0, 26482.86758566195, 26945.461090778073, 26971.595426068623, 27196.32009199786, 922.2852289475576, 930.0885132570119, 959.7696552827272, 961.3174646001418, 973.3186769261546, 13318.733625327439, 13982.580522584136, 14014.318281806249, 14352.856471435362, 14606.05060671053, 341967.0, 345052.0, 345151.0, 346297.0, 350336.0, 40115.79942100271, 40359.0, 40401.76785857124, 40425.595744042184, 40435.7978210107, 1107.5293000474767, 1165.9008984236266, 1174.541928647828, 1175.371176420645, 1189.4409627475072, 23713.762862371157, 24216.156033162955, 24862.875685621457, 25010.3747406309, 25039.374015649028, 36082.0, 36399.0, 36473.817630911675, 36522.0, 36547.45178822373, 315709.0, 316061.0, 316223.0, 318297.0, 318976.0, 21972.670409943545, 22377.888110559343, 22485.550288994455, 22487.10051597918, 22552.0, 34451.827740862136, 35462.82268588744, 35751.28497430089, 35810.462843057896, 35942.460863086555, 29273.268168295963, 30067.548986764778, 30313.696863031088, 30348.84825575858, 30397.696023039487, 30027.849860750557, 30068.54897176588, 30667.0, 30916.0, 30986.0, 29624.40751184921, 29997.4000519984, 30105.397892042474, 30725.23186920345, 30764.0, 26478.0, 27682.723172768016, 27719.86140069287, 27852.60736963103, 27872.16383508498, 21707.782922170576, 21795.673064903724, 21867.453313667287, 22003.669944951158, 22153.335399938027], "value": 16359.14982566175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.8687655252727, 342.6299596435848, 359.87404408457036, 366.91560940983584, 385.25837762307566, 12364.381780910951, 15563.455279065234, 15617.453389131382, 16093.356265749357, 16376.75434868475, 15953.282102305395, 15996.800239981989, 16191.83808161918, 16304.673906521892, 16429.096399698014, 4786.928196077061, 4808.0, 4876.244182151772, 4905.190643543811, 5018.5232402921665, 4790.425148982127, 4843.58829499493, 4845.442774080991, 4856.732879691615, 4858.392700912386, 3498.107982464468, 3701.24124554467, 5403.756830942617, 5657.1514272858985, 5667.518260947824, 5556.9444305556835, 5749.396313387076, 5755.798547050854, 5758.74085666146, 5763.366029736705, 4878.268259761029, 4900.877478063041, 4912.403468872595, 4915.901681966377, 4918.409790825088, 18664.813351866444, 19152.521186970298, 19190.0, 19288.0, 19302.806971930382, 1907.9154054444887, 2034.2778313698573, 2105.157936825267, 2216.5788500184913, 2344.6283923904534, 11163.944180279128, 11687.240329378648, 12101.697457563543, 12230.816537751942, 12713.300768457731, 1689.0963334616044, 1722.1647500962024, 1727.2141175765123, 1733.566608347913, 1774.7604073450048, 62463.0, 62741.68629156871, 64104.3589564103, 65502.67248663726, 65599.3440065598, 9217.76955576116, 9374.265995672142, 9475.573599188054, 9716.805663886682, 9751.853722194173, 13011.0, 13026.0, 13041.673958151123, 13055.28195949213, 13058.738825223443, 6396.936030639634, 6546.639934803631, 6735.797926062226, 6766.28953959837, 6770.796876093725, 6128.785492507741, 6152.907706384408, 6288.622682639057, 6295.087212354275, 6299.842503937347, 3858.479105320802, 4022.939655905164, 4125.195586860594, 4209.768462734518, 4270.7864606769535, 1652.7108855093047, 1736.7221244600803, 1789.1412122181425, 1793.8564914806784, 1821.963560728778, 775.6548335990431, 810.3922058456158, 815.7267315449272, 842.7302067976335, 849.2738708404225, 15173.317200725773, 16047.277872495766, 16116.838831611769, 16190.919045404698, 16797.244124014447, 824.5341382119084, 830.7092517618785, 831.5177197225595, 836.7071524966213, 846.3736834742369, 8605.827883442296, 9293.953530232306, 9334.486603236886, 9453.291003174789, 9546.0, 318731.0, 350847.0, 355393.0, 359877.0, 360221.0, 63114.68442657849, 64369.35630643727, 71908.64045679738, 73261.63369183226, 73765.0, 916.4684482999844, 920.7053742802373, 953.1469334945185, 963.9807203855884, 970.5244430229137, 14988.0, 15068.397264109752, 15610.45363412275, 15770.842291577397, 15862.841371586137, 33699.0, 33704.66295337015, 34711.305773883876, 34810.47784283187, 35105.29789404249, 47037.0, 48558.5144148554, 48794.75602621964, 48964.510354895996, 49409.0, 6803.829904252235, 6816.250212476524, 7096.716131354688, 7135.6432178391915, 7264.382527485011, 7950.284474397332, 10465.9476702616, 10793.082587979796, 11194.552217911518, 11768.588099416822, 9406.764830879283, 9551.808963820824, 9628.75928101803, 10017.649382271586, 10038.1467575254, 9767.560459779184, 9768.951155244178, 9904.851427228741, 10101.5454304555, 10139.138173255062, 9606.51967401641, 9963.701088967342, 10078.143357814668, 10102.24233182529, 10582.407310209048, 7110.715571377087, 7126.8218294540975, 7173.892391614026, 7183.0, 7242.891356629761, 6883.724651014104, 7167.7132914682825, 7271.963640181765, 7444.069491313586, 7506.849863002819], "value": 7789.948146417429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.8956288715458, 1338.8661133886612, 1340.758663440581, 1422.7083447893183, 1660.8422199891013, 6446.709898054587, 7049.612271325075, 7193.6762845672, 7281.52670076446, 7396.297351751575, 7226.421886249101, 7230.891536626955, 7244.927550724491, 7259.6370181490975, 7266.527675701076, 1786.6873297172942, 1861.0973677766272, 2072.077925323228, 2117.587070521249, 2117.851750377474, 2067.8345732341377, 2137.978620213801, 2160.330297607739, 2166.04693934669, 2181.6509358502644, 2039.8368130549595, 2067.720857684216, 2068.9586208275828, 2071.2129390831465, 2086.822620077295, 2063.711080448731, 2072.336852207294, 2073.409078412645, 2076.0, 2078.314156328408, 2000.959980800376, 2069.3998740365278, 2087.3424871165685, 2087.77034526202, 2103.621348157331, 6944.1666999959825, 6972.546784459045, 6979.546329488618, 7029.402500787439, 7065.4700897432895, 4298.247806633826, 4378.934315985262, 4390.517043125254, 4393.0, 4399.36209249657, 2743.067357098576, 2784.0673374419594, 2840.5029119903934, 2840.5597132444504, 2841.1476557032806, 856.618804631939, 884.4339622641514, 909.5497728624307, 922.4695799915008, 928.6749637626776, 9525.57134928923, 9577.138057574852, 9588.95205523975, 9613.0, 9686.32195746298, 3759.398496240643, 3932.2135572885536, 3988.4216788565495, 4023.0, 4024.657904078186, 8440.62017209227, 8453.450525715809, 8459.703910363107, 8461.111583283666, 8466.407351485337, 4385.978070109629, 4403.911921761611, 4414.55854414556, 4414.690971631955, 4420.027593929331, 3400.9659903401143, 3513.0690367052753, 3864.478295430137, 3985.06351007513, 3999.8200080996426, 3291.325278317939, 3301.5047742838287, 3373.9662603373654, 3403.812790296508, 3408.9147771305916, 1070.4701172919454, 1116.6705821782593, 1118.7762447510368, 1126.3748619516248, 1143.7255058785831, 818.4189225649856, 841.2092632925153, 846.5640195299303, 863.6027427383474, 878.3280790195505, 5034.446210916796, 5065.9746701266995, 5079.6698214615935, 5276.709780962084, 5300.072487314705, 378.0642908800696, 378.2963687541171, 381.15574003582196, 384.61538461538464, 397.888591194466, 3442.4492081266876, 3602.6397360263763, 3724.944125838115, 3759.4548790425233, 3767.2653832502947, 8329.583520823935, 8345.749627511184, 8480.660773568989, 8546.0, 8665.653373865101, 8489.575521223915, 8489.660413583511, 8571.742847714579, 8619.267362274151, 8639.438436501607, 6533.901991470132, 6715.194176698729, 6735.158105236846, 6750.493712971449, 6754.6284954327, 5034.84895453137, 5041.117804384291, 5058.140116180185, 5064.848054558369, 5081.8475445736685, 7781.494202876795, 7847.254510821463, 7873.763787086396, 7874.803129921569, 7928.048634163937, 8004.199580041949, 8052.033755949324, 8086.555239461651, 8112.59437028158, 8181.754547363588, 5662.0, 6190.628562286277, 6252.499800016079, 6286.434220919956, 6288.308286088618, 6365.204349456318, 6494.220693516808, 6494.772682956074, 6496.285408604956, 6500.577462464925, 6191.535634827316, 6387.105805187371, 6440.25937017249, 6446.645434501147, 6619.602823830585, 6070.119832624333, 6087.147799308012, 6140.600860944024, 6167.599106058092, 6196.132541444292, 5915.792947246826, 5994.460498555151, 6019.608725432833, 6021.518278537619, 6032.939670603238, 4424.800883960165, 4550.203714349909, 4554.726716397026, 4597.402337696078, 4602.6986506746625, 4372.213001659732, 4432.246518091868, 4467.553244675506, 4533.863984080483, 4535.841245556389], "value": 3802.6267155360097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.90229833348326, 339.5484006271659, 345.3645292661503, 353.46097201767316, 353.94336906095015, 4647.488776234612, 4651.418572678415, 4663.743494107823, 4687.71873687579, 4726.929096063557, 4612.423447069116, 4627.0, 4627.167109920221, 4651.232546629802, 4690.835820746274, 3616.119617798743, 3634.2368102698397, 3725.4784330193793, 3732.4774531565604, 3757.1170774867883, 3751.8874433767032, 3778.2065766188994, 3783.0, 3787.4697542344093, 3799.734018618698, 3731.738778285521, 3754.3617585010616, 3764.5106136202257, 3765.585785563586, 3768.4158955361963, 3508.6317135549903, 3632.291703117893, 3659.2864391443677, 3728.322254985254, 3732.42147467143, 3329.716974057208, 3345.2640419107756, 3367.3433680432327, 3370.399060446293, 3375.1562109472634, 4508.752018638974, 4518.977405112986, 4532.954670453286, 4535.841245556423, 4540.364348991144, 4116.403121547359, 4262.552431994627, 4282.0, 4295.978520107411, 4306.676999225039, 4857.0, 4858.416989961192, 4867.853964381075, 4877.244027175793, 4893.804247830082, 3635.94546081809, 3646.2835187785004, 3648.252108317815, 3653.7442379033478, 3681.3925702259094, 5066.923996140061, 5074.213496907985, 5087.618428617869, 5088.185890257578, 5089.211172268304, 3339.4990751387486, 3487.843047062888, 3490.965090349064, 3508.491268766066, 3744.43833424983, 3544.627814079536, 3555.7866528008403, 3556.270964452281, 3563.483294922222, 3563.5901871284614, 4067.7355971861734, 4074.8166332515107, 4077.89805254871, 4086.346184610448, 4096.235041347139, 4577.178056322941, 4825.9758701206265, 4849.732235632691, 4850.6362022848425, 4856.878578035577, 1210.4431961297726, 1210.8062709966364, 1220.6826225181517, 1222.2422098298935, 1222.706550427891, 812.8496228197803, 832.6919039955255, 837.8282452097305, 843.3759018326394, 843.8143608406141, 4237.300845360481, 4306.181825453154, 4367.213901497761, 4437.400950871655, 4450.599446049806, 5016.613785694642, 5060.468650791688, 5069.935313584188, 5070.6957582545165, 5081.822136225214, 4425.0, 4431.534688857688, 4435.562439109652, 4437.911241775147, 4439.62263207631, 2542.427953710437, 2557.4271822828828, 2567.4608332250436, 2583.405816662178, 2591.4298854252033, 4618.2841659542155, 4625.7455839929125, 4642.814287428532, 4651.86044418668, 4653.115907977541, 4962.8759281018265, 4964.528369804862, 4991.825286114969, 4999.975000124976, 5006.523075692679, 4462.3752674625575, 4615.14619795339, 4623.6822505586415, 4641.976790116028, 4664.183767840682, 4855.271709243641, 4861.781219845187, 4866.416030076413, 4876.853694389174, 4884.877878053077, 4759.595434388116, 4777.904441911072, 4793.185158523129, 4799.544043315879, 4814.109389762905, 4434.645228381657, 4619.884502887455, 4754.786034628381, 4785.6171506278715, 4793.784279707352, 3534.081138903852, 3536.1513236823494, 3577.678008979204, 3600.819959001987, 3609.5488063992, 5096.241796580174, 5103.642745007963, 5104.749336412603, 5106.463821298858, 5121.411037730709, 4718.31584420264, 4929.186684197068, 4955.603551715926, 4961.479044700254, 4964.553190212898, 4939.802407903788, 4941.975290123526, 4949.57928576075, 4949.752512374439, 4957.3059771632725, 4883.536064073907, 4896.4858689838475, 4898.142825005681, 4898.387701537308, 4919.434265059564, 4885.415078283732, 4886.486918873609, 4960.652754307164, 4984.551390374883, 4997.300377947017, 4779.928301075556, 4781.832635857728, 4797.424309082932, 4854.5873600744335, 4858.352198051999], "value": 3710.121628251788, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.8258887511498, 623.7692053940043, 628.4846425930739, 637.4358692557087, 733.4572416411853, 12196.085293602982, 12766.744665106693, 13277.800832987514, 13438.193708377505, 13531.797023044663, 11680.357580333079, 11810.468528916197, 12248.26510409376, 12360.072994525424, 12376.257424554511, 778.217891019526, 792.8295416485455, 792.9088154862206, 793.488200110931, 793.8134538383475, 620.0637038072498, 649.5355820588278, 749.3181205103357, 785.6307535458326, 791.1574173505198, 800.9639566219505, 801.5190885468701, 802.9718959836407, 803.2048272210528, 803.5259197073725, 794.7417089445895, 795.3517882925455, 796.6415113199025, 796.8326651403183, 796.8366484870617, 477.2697772408221, 495.52924721514705, 568.377626498983, 593.7892048322869, 597.5518361229078, 13591.32043397836, 13597.252151131685, 13598.252096134807, 13616.319184040858, 13624.795628065587, 12292.877071229263, 12341.876581234163, 12477.126601137834, 12777.488900443972, 12798.232106073665, 10155.136813370873, 10418.68743937683, 10483.213758968031, 11928.972074747313, 11929.582464613784, 4060.5127384714024, 4062.695297852673, 4066.1054567994993, 4070.75575465473, 4077.2253271878544, 55289.72355138198, 56824.14763778546, 57061.71469142628, 57452.71273643605, 58881.41118588845, 9907.504624768877, 10051.246156538142, 10058.798824023625, 10213.080822725842, 10350.53422595985, 17764.045954944944, 17789.644207115784, 17927.910360448375, 17931.013794241182, 18325.083745812655, 6487.513436492282, 6654.73381064752, 6676.499262555328, 6724.428423583952, 6908.827279318058, 3510.5962814276686, 3558.3594952908725, 3572.8392222350058, 3597.982010089985, 3694.9445758313645, 2655.1636234586044, 2713.511567917794, 2721.129238643615, 2755.655543057118, 2827.8444685542495, 469.1742533141695, 469.6407248454935, 475.55060467857544, 477.1173329340761, 480.46188269138787, 467.8081986385566, 486.5815398757066, 530.3158924986724, 554.4510934175219, 557.584599473395, 7199.71201151948, 7275.308845659654, 7365.0, 7428.73999410018, 7429.956761890523, 448.1552273963602, 466.86694292126583, 467.8152129908667, 492.99921160045164, 539.0862488082662, 3228.4188846007946, 3406.42090844557, 3438.638942910958, 3440.8451619677176, 3754.568224654145, 63026.369736302964, 64967.67516162389, 64985.35014649887, 68352.3164768356, 68754.65622671855, 57168.428315717145, 58008.709956449944, 60262.0, 60536.0, 60602.0, 42511.0, 52369.47630523722, 52657.473425265256, 52726.0, 53698.46301537013, 8331.50010999342, 8839.779005524913, 8937.687180948635, 9046.683366082156, 9120.908790912006, 32371.028869133963, 33265.50305236222, 34219.65780342164, 34399.82800085984, 34972.825135874155, 41034.0, 46071.76964115158, 46513.302300466195, 46517.0, 46529.0, 10575.382952240649, 10599.89400105989, 10752.76322283767, 10775.299605525615, 11169.0, 12042.698932526406, 12212.473440819898, 12328.691782705504, 12629.747405051663, 13114.0, 11116.61091861781, 11239.60661376848, 11240.437978101227, 11283.943580282046, 11593.072554195813, 11550.768984620428, 12016.63950081499, 12051.457684404048, 12101.933023691003, 12377.566785162477, 11813.350265735467, 11948.283103013848, 11952.64142075739, 12021.398930053287, 12105.273683578662, 9759.9024009759, 9855.556499957376, 9969.950150249493, 10049.497525123861, 10604.787904242026, 10194.592216311265, 10369.222308326755, 10497.895021049691, 10584.994425529563, 10697.51861166265], "value": 6110.843794026033, "unit": "score"}], "name": "dromaeo_css", "value": 6058.960119416448, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 116.0, 117.0, 114.0, 116.0, 114.0, 115.0, 115.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 131.0, 169.0, 129.0, 133.0, 130.0, 128.0, 153.0, 133.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 163.0, 162.0, 160.0, 162.0, 162.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 110.0, 78.0, 78.0, 78.0, 76.0, 90.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 107.0, 85.0, 85.0, 85.0, 99.0, 85.0, 85.0, 113.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 127.0, 127.0, 126.0, 128.0, 128.0, 129.0, 129.0, 127.0], "value": 127.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 68.0, 69.0, 68.0, 67.0, 67.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 70.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 96.0, 97.0, 89.0, 89.0, 90.0, 94.0, 120.0, 90.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 142.0, 139.0, 140.0, 137.0, 139.0, 140.0, 140.0, 151.0, 149.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 184.0, 183.0, 185.0, 182.0, 186.0, 183.0, 183.0, 182.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 78.0, 73.0, 71.0, 69.0, 68.0, 67.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1581.8999999999999, "alertThreshold": 2.0}]} 07:50:03 INFO - Return code: 0 07:50:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:03 INFO - # TBPL SUCCESS # 07:50:03 INFO - Running post-action listener: _resource_record_post_action 07:50:03 INFO - [mozharness: 2016-12-09 15:50:03.371688Z] Finished run-tests step (success) 07:50:03 INFO - Running post-run listener: _resource_record_post_run 07:50:03 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 2240512; Write bytes: 397463552; Read time: 908; Write time: 302616 07:50:03 INFO - TinderboxPrint: CPU usage
13.2% 07:50:03 INFO - TinderboxPrint: I/O read bytes / time
2,240,512 / 908 07:50:03 INFO - TinderboxPrint: I/O write bytes / time
397,463,552 / 302,616 07:50:03 INFO - TinderboxPrint: CPU idle
8,354.1 (86.8%) 07:50:03 INFO - TinderboxPrint: CPU user
1,215.3 (12.6%) 07:50:03 INFO - TinderboxPrint: Swap in / out
0 / 0 07:50:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106184704; Read time: 0; Write time: 111388 07:50:03 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 2240512; Write bytes: 291278848; Read time: 908; Write time: 191228 07:50:04 INFO - Running post-run listener: _upload_blobber_files 07:50:04 INFO - Blob upload gear active. 07:50:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:50:04 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'] 07:50:04 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 07:50:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:50:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:50:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:05 INFO - (blobuploader) - INFO - Done attempting. 07:50:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:50:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:50:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:06 INFO - (blobuploader) - INFO - Done attempting. 07:50:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:09 INFO - (blobuploader) - INFO - Done attempting. 07:50:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:09 INFO - Return code: 0 07:50:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef474597248ca0b29820aa2045bd5b9ddaa0a2fbed56c585eacd6802be64222d6e9feefbae49a5b22c334d5f612b9587bbe45acc8ee9795a5e2c65dba8695f44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a4b4af2c7df21c5d9dbab6b84b870d40426fc0726320bfbd0a91fb09b133bd28ab443f942553a5f61271393eb3e15459f892f1ef5eb74e67dcb06e53c4eab47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4fa2104040c77e54729ad05e5b09c00e32871d50f32bec5097435b4ac86e6c8debbdae573ee02a736ab68ef1cffb39e4dc6fa2716bb519612b2151370c63970"} 07:50:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:09 INFO - Contents: 07:50:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef474597248ca0b29820aa2045bd5b9ddaa0a2fbed56c585eacd6802be64222d6e9feefbae49a5b22c334d5f612b9587bbe45acc8ee9795a5e2c65dba8695f44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a4b4af2c7df21c5d9dbab6b84b870d40426fc0726320bfbd0a91fb09b133bd28ab443f942553a5f61271393eb3e15459f892f1ef5eb74e67dcb06e53c4eab47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4fa2104040c77e54729ad05e5b09c00e32871d50f32bec5097435b4ac86e6c8debbdae573ee02a736ab68ef1cffb39e4dc6fa2716bb519612b2151370c63970"} 07:50:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:09 INFO - Copying logs to upload dir... 07:50:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.004064 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-12-09 07:50:08.924513) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 07:50:08.928406) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318 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/ef474597248ca0b29820aa2045bd5b9ddaa0a2fbed56c585eacd6802be64222d6e9feefbae49a5b22c334d5f612b9587bbe45acc8ee9795a5e2c65dba8695f44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a4b4af2c7df21c5d9dbab6b84b870d40426fc0726320bfbd0a91fb09b133bd28ab443f942553a5f61271393eb3e15459f892f1ef5eb74e67dcb06e53c4eab47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4fa2104040c77e54729ad05e5b09c00e32871d50f32bec5097435b4ac86e6c8debbdae573ee02a736ab68ef1cffb39e4dc6fa2716bb519612b2151370c63970"} build_url:https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011713 build_url: 'https://queue.taskcluster.net/v1/task/YBAwL8W0Q8mIq_1hxPz9jA/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/ef474597248ca0b29820aa2045bd5b9ddaa0a2fbed56c585eacd6802be64222d6e9feefbae49a5b22c334d5f612b9587bbe45acc8ee9795a5e2c65dba8695f44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a4b4af2c7df21c5d9dbab6b84b870d40426fc0726320bfbd0a91fb09b133bd28ab443f942553a5f61271393eb3e15459f892f1ef5eb74e67dcb06e53c4eab47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4fa2104040c77e54729ad05e5b09c00e32871d50f32bec5097435b4ac86e6c8debbdae573ee02a736ab68ef1cffb39e4dc6fa2716bb519612b2151370c63970"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 07:50:08.953841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:50:08.954176) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1481297358.162833-1271543318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:50:09.040014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 07:50:09.040323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 07:50:09.040610) ========= ========= Total master_lag: 0.15 =========