builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1474631049.28 results: success (0) buildid: 20160923031600 builduid: e2fc4e3a37754f49ac5cb2334e42155c revision: 60cc643978c7020926fe4145761e26945fcd5c37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.280307) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.280756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.281039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.307396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.307671) ========= 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=920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 04:44:09-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.9M=0.001s 2016-09-23 04:44:09 (20.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143767 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.465742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.466028) ========= 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=920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:09.515194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-23 04:44:09.515530) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60cc643978c7020926fe4145761e26945fcd5c37 --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 60cc643978c7020926fe4145761e26945fcd5c37 --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=920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 04:44:10,042 truncating revision to first 12 chars 2016-09-23 04:44:10,042 Setting DEBUG logging. 2016-09-23 04:44:10,042 attempt 1/10 2016-09-23 04:44:10,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60cc643978c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 04:44:11,315 unpacking tar archive at: mozilla-central-60cc643978c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.995678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-23 04:44:11.528625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:11.529258) ========= script_repo_revision: 60cc643978c7020926fe4145761e26945fcd5c37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:11.530200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:11.530767) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 04:44:11.541759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-23 04:44:11.542304) ========= /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=920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:12 INFO - MultiFileLogger online at 20160923 04:44:12 in /builds/slave/test 04:44:12 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 04:44:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:12 INFO - {'append_to_log': False, 04:44:12 INFO - 'base_work_dir': '/builds/slave/test', 04:44:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:44:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:12 INFO - 'branch': 'Firefox-Non-PGO', 04:44:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:12 INFO - 'config_files': ('talos/linux_config.py',), 04:44:12 INFO - 'default_actions': ('clobber', 04:44:12 INFO - 'read-buildbot-config', 04:44:12 INFO - 'download-and-extract', 04:44:12 INFO - 'populate-webroot', 04:44:12 INFO - 'create-virtualenv', 04:44:12 INFO - 'install', 04:44:12 INFO - 'run-tests'), 04:44:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:12 INFO - 'download_minidump_stackwalk': True, 04:44:12 INFO - 'download_symbols': 'ondemand', 04:44:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:12 INFO - 'installer_path': 'installer.exe', 04:44:12 INFO - 'log_level': 'info', 04:44:12 INFO - 'log_name': 'talos', 04:44:12 INFO - 'log_to_console': True, 04:44:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:12 INFO - 'opt_config_files': (), 04:44:12 INFO - 'pip_index': False, 04:44:12 INFO - 'sps_profile': False, 04:44:12 INFO - 'sps_profile_interval': 0, 04:44:12 INFO - 'suite': 'dromaeojs', 04:44:12 INFO - 'system_bits': '32', 04:44:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:12 INFO - 'title': 'talos-linux64-ix-053', 04:44:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:12 INFO - 'use_talos_json': True, 04:44:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:12 INFO - 'work_dir': 'build'} 04:44:12 INFO - [mozharness: 2016-09-23 11:44:12.161044Z] Running clobber step. 04:44:12 INFO - Running pre-action listener: _resource_record_pre_action 04:44:12 INFO - Running main action method: clobber 04:44:12 INFO - rmtree: /builds/slave/test/build 04:44:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:12 INFO - Running post-action listener: _resource_record_post_action 04:44:12 INFO - [mozharness: 2016-09-23 11:44:12.622164Z] Finished clobber step (success) 04:44:12 INFO - [mozharness: 2016-09-23 11:44:12.622265Z] Running read-buildbot-config step. 04:44:12 INFO - Running pre-action listener: _resource_record_pre_action 04:44:12 INFO - Running main action method: read_buildbot_config 04:44:12 INFO - Using buildbot properties: 04:44:12 INFO - { 04:44:12 INFO - "project": "", 04:44:12 INFO - "product": "firefox", 04:44:12 INFO - "script_repo_revision": "production", 04:44:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:44:12 INFO - "repository": "", 04:44:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:44:12 INFO - "buildid": "20160923031600", 04:44:12 INFO - "pgo_build": "False", 04:44:12 INFO - "basedir": "/builds/slave/test", 04:44:12 INFO - "buildnumber": 755, 04:44:12 INFO - "slavename": "talos-linux64-ix-053", 04:44:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:44:12 INFO - "platform": "ubuntu64_hw", 04:44:12 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:44:12 INFO - "branch": "mozilla-central", 04:44:12 INFO - "repo_path": "mozilla-central", 04:44:12 INFO - "revision": "60cc643978c7020926fe4145761e26945fcd5c37", 04:44:12 INFO - "stage_platform": "linux64", 04:44:12 INFO - "builduid": "e2fc4e3a37754f49ac5cb2334e42155c", 04:44:12 INFO - "slavebuilddir": "test" 04:44:12 INFO - } 04:44:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:44:12 INFO - Running post-action listener: _resource_record_post_action 04:44:12 INFO - [mozharness: 2016-09-23 11:44:12.624705Z] Finished read-buildbot-config step (success) 04:44:12 INFO - [mozharness: 2016-09-23 11:44:12.624794Z] Running download-and-extract step. 04:44:12 INFO - Running pre-action listener: _resource_record_pre_action 04:44:12 INFO - Running main action method: download_and_extract 04:44:12 INFO - mkdir: /builds/slave/test/build/tests 04:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:12 INFO - trying https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:44:12 INFO - Downloading https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:44:13 INFO - Downloaded 1361 bytes. 04:44:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:44:13 INFO - Using the following test package requirements: 04:44:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:44:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:44:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'jsshell-linux-x86_64.zip'], 04:44:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:44:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:44:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:44:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:44:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:44:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:44:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:44:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:13 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:44:13 INFO - Expected file size: 20376797 04:44:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:44:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:44:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:18 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:44:18 INFO - Expected file size: 20376797 04:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:44:23 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:44:23 INFO - Expected file size: 14414059 04:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:24 INFO - trying https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:44:24 INFO - Downloading https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:44:26 INFO - Downloaded 55728393 bytes. 04:44:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:44:26 INFO - mkdir: /builds/slave/test/properties 04:44:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:26 INFO - Contents: 04:44:26 INFO - build_url:https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:44:27 INFO - Running post-action listener: _resource_record_post_action 04:44:27 INFO - Running post-action listener: set_extra_try_arguments 04:44:27 INFO - [mozharness: 2016-09-23 11:44:27.382750Z] Finished download-and-extract step (success) 04:44:27 INFO - [mozharness: 2016-09-23 11:44:27.382980Z] Running populate-webroot step. 04:44:27 INFO - Running pre-action listener: _resource_record_pre_action 04:44:27 INFO - Running main action method: populate_webroot 04:44:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:27 INFO - '--tppagecycles', 04:44:27 INFO - '7'], 04:44:27 INFO - 'tests': ['tsvgm']}}, 04:44:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['damp', 'tps']}, 04:44:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'tests': ['damp', 'tps']}, 04:44:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['dromaeo_dom']}, 04:44:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['basic_compositor_video']}, 04:44:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['a11yr', 04:44:27 INFO - 'ts_paint', 04:44:27 INFO - 'tpaint', 04:44:27 INFO - 'sessionrestore', 04:44:27 INFO - 'sessionrestore_no_auto_restore', 04:44:27 INFO - 'tabpaint']}, 04:44:27 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:27 INFO - 'ts_paint', 04:44:27 INFO - 'tpaint', 04:44:27 INFO - 'sessionrestore', 04:44:27 INFO - 'sessionrestore_no_auto_restore', 04:44:27 INFO - 'tabpaint']}, 04:44:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:27 INFO - 'ts_paint', 04:44:27 INFO - 'tpaint', 04:44:27 INFO - 'sessionrestore', 04:44:27 INFO - 'sessionrestore_no_auto_restore', 04:44:27 INFO - 'tabpaint']}, 04:44:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:27 INFO - 'ts_paint', 04:44:27 INFO - 'tpaint', 04:44:27 INFO - 'sessionrestore', 04:44:27 INFO - 'sessionrestore_no_auto_restore', 04:44:27 INFO - 'tabpaint']}, 04:44:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['a11yr', 04:44:27 INFO - 'ts_paint', 04:44:27 INFO - 'tpaint', 04:44:27 INFO - 'sessionrestore', 04:44:27 INFO - 'sessionrestore_no_auto_restore', 04:44:27 INFO - 'tabpaint']}, 04:44:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['a11yr', 04:44:27 INFO - 'ts_paint', 04:44:27 INFO - 'tpaint', 04:44:27 INFO - 'sessionrestore', 04:44:27 INFO - 'sessionrestore_no_auto_restore', 04:44:27 INFO - 'tabpaint']}, 04:44:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['tsvgx', 04:44:27 INFO - 'tsvgr_opacity', 04:44:27 INFO - 'tart', 04:44:27 INFO - 'tscrollx', 04:44:27 INFO - 'cart']}, 04:44:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:27 INFO - 'tsvgr_opacity', 04:44:27 INFO - 'tart', 04:44:27 INFO - 'tscrollx', 04:44:27 INFO - 'cart']}, 04:44:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'talos_options': ['--disable-e10s'], 04:44:27 INFO - 'tests': ['tp5o']}, 04:44:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'tests': ['tp5o']}, 04:44:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'talos_options': ['--disable-e10s', 04:44:27 INFO - '--xperf_path', 04:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:27 INFO - 'tests': ['tp5n']}, 04:44:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:27 INFO - 'talos_options': ['--xperf_path', 04:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:27 INFO - 'tests': ['tp5n']}}, 04:44:27 INFO - 'talos.zip': {'path': '', 04:44:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:27 INFO - Running post-action listener: _resource_record_post_action 04:44:27 INFO - [mozharness: 2016-09-23 11:44:27.405630Z] Finished populate-webroot step (success) 04:44:27 INFO - [mozharness: 2016-09-23 11:44:27.405727Z] Running create-virtualenv step. 04:44:27 INFO - Running pre-action listener: _resource_record_pre_action 04:44:27 INFO - Running main action method: create_virtualenv 04:44:27 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:44:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:27 INFO - Using real prefix '/usr' 04:44:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:29 INFO - Installing pip.................done. 04:44:29 INFO - Return code: 0 04:44:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:29 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 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:44:29 INFO - Using env: {'DISPLAY': ':0', 04:44:29 INFO - 'HOME': '/home/cltbld', 04:44:29 INFO - 'LANG': 'en_US.UTF-8', 04:44:30 INFO - 'LANGUAGE': 'en_US:en', 04:44:30 INFO - 'LOGNAME': 'cltbld', 04:44:30 INFO - 'MAIL': '/var/mail/cltbld', 04:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:30 INFO - 'MOZ_NO_REMOTE': '1', 04:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:30 INFO - 'NO_EM_RESTART': '1', 04:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:30 INFO - 'PWD': '/builds/slave/test', 04:44:30 INFO - 'SHELL': '/bin/bash', 04:44:30 INFO - 'SHLVL': '1', 04:44:30 INFO - 'TERM': 'linux', 04:44:30 INFO - 'TMOUT': '86400', 04:44:30 INFO - 'USER': 'cltbld', 04:44:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:30 INFO - '_': '/tools/buildbot/bin/python'} 04:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:44:30 INFO - Cleaning up... 04:44:30 INFO - Return code: 0 04:44:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:30 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 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:44:30 INFO - Using env: {'DISPLAY': ':0', 04:44:30 INFO - 'HOME': '/home/cltbld', 04:44:30 INFO - 'LANG': 'en_US.UTF-8', 04:44:30 INFO - 'LANGUAGE': 'en_US:en', 04:44:30 INFO - 'LOGNAME': 'cltbld', 04:44:30 INFO - 'MAIL': '/var/mail/cltbld', 04:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:30 INFO - 'MOZ_NO_REMOTE': '1', 04:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:30 INFO - 'NO_EM_RESTART': '1', 04:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:30 INFO - 'PWD': '/builds/slave/test', 04:44:30 INFO - 'SHELL': '/bin/bash', 04:44:30 INFO - 'SHLVL': '1', 04:44:30 INFO - 'TERM': 'linux', 04:44:30 INFO - 'TMOUT': '86400', 04:44:30 INFO - 'USER': 'cltbld', 04:44:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:30 INFO - '_': '/tools/buildbot/bin/python'} 04:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:30 INFO - Downloading/unpacking psutil>=3.1.1 04:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:32 INFO - Installing collected packages: psutil 04:44:32 INFO - Running setup.py install for psutil 04:44:32 INFO - building 'psutil._psutil_linux' extension 04:44:32 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 04:44:32 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 04:44:32 INFO - building 'psutil._psutil_posix' extension 04:44:32 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 04:44:32 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 04:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:32 INFO - Successfully installed psutil 04:44:32 INFO - Cleaning up... 04:44:32 INFO - Return code: 0 04:44:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:44:32 INFO - Using env: {'DISPLAY': ':0', 04:44:32 INFO - 'HOME': '/home/cltbld', 04:44:32 INFO - 'LANG': 'en_US.UTF-8', 04:44:32 INFO - 'LANGUAGE': 'en_US:en', 04:44:32 INFO - 'LOGNAME': 'cltbld', 04:44:32 INFO - 'MAIL': '/var/mail/cltbld', 04:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:32 INFO - 'MOZ_NO_REMOTE': '1', 04:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:32 INFO - 'NO_EM_RESTART': '1', 04:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:32 INFO - 'PWD': '/builds/slave/test', 04:44:32 INFO - 'SHELL': '/bin/bash', 04:44:32 INFO - 'SHLVL': '1', 04:44:32 INFO - 'TERM': 'linux', 04:44:32 INFO - 'TMOUT': '86400', 04:44:32 INFO - 'USER': 'cltbld', 04:44:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:32 INFO - '_': '/tools/buildbot/bin/python'} 04:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:35 INFO - Installing collected packages: mozsystemmonitor 04:44:35 INFO - Running setup.py install for mozsystemmonitor 04:44:35 INFO - Successfully installed mozsystemmonitor 04:44:35 INFO - Cleaning up... 04:44:35 INFO - Return code: 0 04:44:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:44:35 INFO - Using env: {'DISPLAY': ':0', 04:44:35 INFO - 'HOME': '/home/cltbld', 04:44:35 INFO - 'LANG': 'en_US.UTF-8', 04:44:35 INFO - 'LANGUAGE': 'en_US:en', 04:44:35 INFO - 'LOGNAME': 'cltbld', 04:44:35 INFO - 'MAIL': '/var/mail/cltbld', 04:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:35 INFO - 'MOZ_NO_REMOTE': '1', 04:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:35 INFO - 'NO_EM_RESTART': '1', 04:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:35 INFO - 'PWD': '/builds/slave/test', 04:44:35 INFO - 'SHELL': '/bin/bash', 04:44:35 INFO - 'SHLVL': '1', 04:44:35 INFO - 'TERM': 'linux', 04:44:35 INFO - 'TMOUT': '86400', 04:44:35 INFO - 'USER': 'cltbld', 04:44:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:35 INFO - '_': '/tools/buildbot/bin/python'} 04:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:35 INFO - Downloading/unpacking jsonschema==2.5.1 04:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:37 INFO - warning: no files found matching '*.txt' 04:44:37 INFO - no previously-included directories found matching 'build' 04:44:37 INFO - no previously-included directories found matching 'dist' 04:44:37 INFO - no previously-included directories found matching '.git*' 04:44:37 INFO - Installing collected packages: jsonschema, functools32 04:44:37 INFO - Running setup.py install for functools32 04:44:38 INFO - warning: no files found matching '*.txt' 04:44:38 INFO - no previously-included directories found matching 'build' 04:44:38 INFO - no previously-included directories found matching 'dist' 04:44:38 INFO - no previously-included directories found matching '.git*' 04:44:38 INFO - Successfully installed jsonschema functools32 04:44:38 INFO - Cleaning up... 04:44:38 INFO - Return code: 0 04:44:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:44:38 INFO - Using env: {'DISPLAY': ':0', 04:44:38 INFO - 'HOME': '/home/cltbld', 04:44:38 INFO - 'LANG': 'en_US.UTF-8', 04:44:38 INFO - 'LANGUAGE': 'en_US:en', 04:44:38 INFO - 'LOGNAME': 'cltbld', 04:44:38 INFO - 'MAIL': '/var/mail/cltbld', 04:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:38 INFO - 'MOZ_NO_REMOTE': '1', 04:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:38 INFO - 'NO_EM_RESTART': '1', 04:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:38 INFO - 'PWD': '/builds/slave/test', 04:44:38 INFO - 'SHELL': '/bin/bash', 04:44:38 INFO - 'SHLVL': '1', 04:44:38 INFO - 'TERM': 'linux', 04:44:38 INFO - 'TMOUT': '86400', 04:44:38 INFO - 'USER': 'cltbld', 04:44:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:38 INFO - '_': '/tools/buildbot/bin/python'} 04:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:38 INFO - Cleaning up... 04:44:38 INFO - Return code: 0 04:44:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:38 INFO - Using env: {'DISPLAY': ':0', 04:44:38 INFO - 'HOME': '/home/cltbld', 04:44:38 INFO - 'LANG': 'en_US.UTF-8', 04:44:38 INFO - 'LANGUAGE': 'en_US:en', 04:44:38 INFO - 'LOGNAME': 'cltbld', 04:44:38 INFO - 'MAIL': '/var/mail/cltbld', 04:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:38 INFO - 'MOZ_NO_REMOTE': '1', 04:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:38 INFO - 'NO_EM_RESTART': '1', 04:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:38 INFO - 'PWD': '/builds/slave/test', 04:44:38 INFO - 'SHELL': '/bin/bash', 04:44:38 INFO - 'SHLVL': '1', 04:44:38 INFO - 'TERM': 'linux', 04:44:38 INFO - 'TMOUT': '86400', 04:44:38 INFO - 'USER': 'cltbld', 04:44:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:38 INFO - '_': '/tools/buildbot/bin/python'} 04:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:41 INFO - Downloading docopt-0.6.1.tar.gz 04:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:41 INFO - Running setup.py install for blobuploader 04:44:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:41 INFO - Running setup.py install for requests 04:44:41 INFO - Running setup.py install for docopt 04:44:41 INFO - Successfully installed blobuploader requests docopt 04:44:41 INFO - Cleaning up... 04:44:41 INFO - Return code: 0 04:44:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:41 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 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:41 INFO - Using env: {'DISPLAY': ':0', 04:44:41 INFO - 'HOME': '/home/cltbld', 04:44:41 INFO - 'LANG': 'en_US.UTF-8', 04:44:41 INFO - 'LANGUAGE': 'en_US:en', 04:44:41 INFO - 'LOGNAME': 'cltbld', 04:44:41 INFO - 'MAIL': '/var/mail/cltbld', 04:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:41 INFO - 'MOZ_NO_REMOTE': '1', 04:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:41 INFO - 'NO_EM_RESTART': '1', 04:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:41 INFO - 'PWD': '/builds/slave/test', 04:44:41 INFO - 'SHELL': '/bin/bash', 04:44:41 INFO - 'SHLVL': '1', 04:44:41 INFO - 'TERM': 'linux', 04:44:41 INFO - 'TMOUT': '86400', 04:44:41 INFO - 'USER': 'cltbld', 04:44:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:41 INFO - '_': '/tools/buildbot/bin/python'} 04:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:42 INFO - Running setup.py (path:/tmp/pip-Kx9cMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:42 INFO - Running setup.py (path:/tmp/pip-IgP1mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:42 INFO - Running setup.py (path:/tmp/pip-Q2D9K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:42 INFO - Running setup.py (path:/tmp/pip-Ga5cBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:42 INFO - Running setup.py (path:/tmp/pip-irXNFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:42 INFO - Running setup.py (path:/tmp/pip-KDWq84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:42 INFO - Running setup.py (path:/tmp/pip-vNFHqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:42 INFO - Running setup.py (path:/tmp/pip-7nkBHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:42 INFO - Running setup.py (path:/tmp/pip-eYk9ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:42 INFO - Running setup.py (path:/tmp/pip-CjLTRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:42 INFO - Running setup.py (path:/tmp/pip-yVlGVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:42 INFO - Running setup.py (path:/tmp/pip-vZSjZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:42 INFO - Running setup.py (path:/tmp/pip-EvvIH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:42 INFO - Running setup.py (path:/tmp/pip-F1sEw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:43 INFO - Running setup.py (path:/tmp/pip-7wMr3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:43 INFO - Running setup.py (path:/tmp/pip-zWrKTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:43 INFO - Running setup.py (path:/tmp/pip-BdphOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:43 INFO - Running setup.py install for manifestparser 04:44:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:43 INFO - Running setup.py install for mozcrash 04:44:43 INFO - Running setup.py install for mozdebug 04:44:43 INFO - Running setup.py install for mozdevice 04:44:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:43 INFO - Running setup.py install for mozfile 04:44:43 INFO - Running setup.py install for mozhttpd 04:44:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:43 INFO - Running setup.py install for mozinfo 04:44:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:43 INFO - Running setup.py install for mozInstall 04:44:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Running setup.py install for mozleak 04:44:44 INFO - Running setup.py install for mozlog 04:44:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Running setup.py install for moznetwork 04:44:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Running setup.py install for mozprocess 04:44:44 INFO - Running setup.py install for mozprofile 04:44:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Running setup.py install for mozrunner 04:44:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:44 INFO - Running setup.py install for mozscreenshot 04:44:44 INFO - Running setup.py install for moztest 04:44:44 INFO - Running setup.py install for mozversion 04:44:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:45 INFO - Cleaning up... 04:44:45 INFO - Return code: 0 04:44:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:45 INFO - Using env: {'DISPLAY': ':0', 04:44:45 INFO - 'HOME': '/home/cltbld', 04:44:45 INFO - 'LANG': 'en_US.UTF-8', 04:44:45 INFO - 'LANGUAGE': 'en_US:en', 04:44:45 INFO - 'LOGNAME': 'cltbld', 04:44:45 INFO - 'MAIL': '/var/mail/cltbld', 04:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:45 INFO - 'MOZ_NO_REMOTE': '1', 04:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:45 INFO - 'NO_EM_RESTART': '1', 04:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:45 INFO - 'PWD': '/builds/slave/test', 04:44:45 INFO - 'SHELL': '/bin/bash', 04:44:45 INFO - 'SHLVL': '1', 04:44:45 INFO - 'TERM': 'linux', 04:44:45 INFO - 'TMOUT': '86400', 04:44:45 INFO - 'USER': 'cltbld', 04:44:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:45 INFO - '_': '/tools/buildbot/bin/python'} 04:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:45 INFO - Running setup.py (path:/tmp/pip-sA8RJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:45 INFO - Running setup.py (path:/tmp/pip-lNBZ5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:45 INFO - Running setup.py (path:/tmp/pip-zb6ePm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:45 INFO - Running setup.py (path:/tmp/pip-MBR7aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:45 INFO - Running setup.py (path:/tmp/pip-OEsyVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:45 INFO - Running setup.py (path:/tmp/pip-7KuKA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:45 INFO - Running setup.py (path:/tmp/pip-x4bfxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:45 INFO - Running setup.py (path:/tmp/pip-csXudK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:45 INFO - Running setup.py (path:/tmp/pip-Kce7cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:45 INFO - Running setup.py (path:/tmp/pip-h7CZXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:46 INFO - Running setup.py (path:/tmp/pip-h71jSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:46 INFO - Running setup.py (path:/tmp/pip-FuyHVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:46 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)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:46 INFO - Running setup.py (path:/tmp/pip-3vBbf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:46 INFO - Running setup.py (path:/tmp/pip-tnweJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:46 INFO - Running setup.py (path:/tmp/pip-zn6D_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:46 INFO - Running setup.py (path:/tmp/pip-Qsg54X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:46 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)) 04:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:46 INFO - Running setup.py (path:/tmp/pip-YfvnkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:48 INFO - Downloading blessings-1.6.tar.gz 04:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:48 INFO - Installing collected packages: blessings 04:44:48 INFO - Running setup.py install for blessings 04:44:48 INFO - Successfully installed blessings 04:44:48 INFO - Cleaning up... 04:44:48 INFO - Return code: 0 04:44:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:48 INFO - Reading from file tmpfile_stdout 04:44:48 INFO - Current package versions: 04:44:48 INFO - argparse == 1.2.1 04:44:48 INFO - blessings == 1.6 04:44:48 INFO - blobuploader == 1.2.4 04:44:48 INFO - docopt == 0.6.1 04:44:48 INFO - functools32 == 3.2.3-2 04:44:48 INFO - jsonschema == 2.5.1 04:44:48 INFO - manifestparser == 1.1 04:44:48 INFO - mozInstall == 1.12 04:44:48 INFO - mozcrash == 0.17 04:44:48 INFO - mozdebug == 0.1 04:44:48 INFO - mozdevice == 0.48 04:44:48 INFO - mozfile == 1.2 04:44:48 INFO - mozhttpd == 0.7 04:44:48 INFO - mozinfo == 0.9 04:44:48 INFO - mozleak == 0.1 04:44:48 INFO - mozlog == 3.4 04:44:48 INFO - moznetwork == 0.27 04:44:48 INFO - mozprocess == 0.23 04:44:48 INFO - mozprofile == 0.28 04:44:48 INFO - mozrunner == 6.12 04:44:48 INFO - mozscreenshot == 0.1 04:44:48 INFO - mozsystemmonitor == 0.3 04:44:48 INFO - moztest == 0.7 04:44:48 INFO - mozversion == 1.4 04:44:48 INFO - psutil == 3.1.1 04:44:48 INFO - requests == 1.2.3 04:44:48 INFO - wsgiref == 0.1.2 04:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:48 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 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:48 INFO - Using env: {'DISPLAY': ':0', 04:44:48 INFO - 'HOME': '/home/cltbld', 04:44:48 INFO - 'LANG': 'en_US.UTF-8', 04:44:48 INFO - 'LANGUAGE': 'en_US:en', 04:44:48 INFO - 'LOGNAME': 'cltbld', 04:44:48 INFO - 'MAIL': '/var/mail/cltbld', 04:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:48 INFO - 'MOZ_NO_REMOTE': '1', 04:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:48 INFO - 'NO_EM_RESTART': '1', 04:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:48 INFO - 'PWD': '/builds/slave/test', 04:44:48 INFO - 'SHELL': '/bin/bash', 04:44:48 INFO - 'SHLVL': '1', 04:44:48 INFO - 'TERM': 'linux', 04:44:48 INFO - 'TMOUT': '86400', 04:44:48 INFO - 'USER': 'cltbld', 04:44:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:48 INFO - '_': '/tools/buildbot/bin/python'} 04:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:49 INFO - Cleaning up... 04:44:49 INFO - Return code: 0 04:44:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:49 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 0x7f502b460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, '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': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', '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 04:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:49 INFO - Using env: {'DISPLAY': ':0', 04:44:49 INFO - 'HOME': '/home/cltbld', 04:44:49 INFO - 'LANG': 'en_US.UTF-8', 04:44:49 INFO - 'LANGUAGE': 'en_US:en', 04:44:49 INFO - 'LOGNAME': 'cltbld', 04:44:49 INFO - 'MAIL': '/var/mail/cltbld', 04:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:49 INFO - 'MOZ_NO_REMOTE': '1', 04:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:49 INFO - 'NO_EM_RESTART': '1', 04:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:49 INFO - 'PWD': '/builds/slave/test', 04:44:49 INFO - 'SHELL': '/bin/bash', 04:44:49 INFO - 'SHLVL': '1', 04:44:49 INFO - 'TERM': 'linux', 04:44:49 INFO - 'TMOUT': '86400', 04:44:49 INFO - 'USER': 'cltbld', 04:44:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:49 INFO - '_': '/tools/buildbot/bin/python'} 04:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:49 INFO - Cleaning up... 04:44:49 INFO - Return code: 0 04:44:49 INFO - Running post-action listener: _resource_record_post_action 04:44:49 INFO - Running post-action listener: _start_resource_monitoring 04:44:49 INFO - Starting resource monitoring. 04:44:49 INFO - [mozharness: 2016-09-23 11:44:49.335818Z] Finished create-virtualenv step (success) 04:44:49 INFO - [mozharness: 2016-09-23 11:44:49.336264Z] Running install step. 04:44:49 INFO - Running pre-action listener: _resource_record_pre_action 04:44:49 INFO - Running main action method: install 04:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:49 INFO - Reading from file tmpfile_stdout 04:44:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:49 INFO - Reading from file tmpfile_stdout 04:44:49 INFO - Output received: 04:44:49 INFO - Usage: mozinstall [options] installer 04:44:49 INFO - Options: 04:44:49 INFO - -h, --help show this help message and exit 04:44:49 INFO - -d DEST, --destination=DEST 04:44:49 INFO - Directory to install application into. [default: 04:44:49 INFO - "/builds/slave/test"] 04:44:49 INFO - --app=APP Application being installed. [default: firefox] 04:44:49 INFO - mkdir: /builds/slave/test/build/application 04:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:45:06 INFO - Reading from file tmpfile_stdout 04:45:06 INFO - Output received: 04:45:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:06 INFO - Running post-action listener: _resource_record_post_action 04:45:06 INFO - [mozharness: 2016-09-23 11:45:06.474004Z] Finished install step (success) 04:45:06 INFO - [mozharness: 2016-09-23 11:45:06.474247Z] Running run-tests step. 04:45:06 INFO - Running pre-action listener: _resource_record_pre_action 04:45:06 INFO - Running main action method: run_tests 04:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:06 INFO - Python 2.7.3 04:45:06 INFO - Return code: 0 04:45:06 INFO - grabbing minidump binary from tooltool 04:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:06 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 0x19a3f60>, '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 0x19a4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:06 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 04:45:06 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 04:45:06 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 04:45:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:06 INFO - Return code: 0 04:45:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:06 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/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 04:45:06 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/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 04:45:06 INFO - Using env: {'DISPLAY': ':0', 04:45:06 INFO - 'HOME': '/home/cltbld', 04:45:06 INFO - 'LANG': 'en_US.UTF-8', 04:45:06 INFO - 'LANGUAGE': 'en_US:en', 04:45:06 INFO - 'LOGNAME': 'cltbld', 04:45:06 INFO - 'MAIL': '/var/mail/cltbld', 04:45:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:06 INFO - 'MOZ_NO_REMOTE': '1', 04:45:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:06 INFO - 'NO_EM_RESTART': '1', 04:45:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:06 INFO - 'PWD': '/builds/slave/test', 04:45:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:06 INFO - 'SHELL': '/bin/bash', 04:45:06 INFO - 'SHLVL': '1', 04:45:06 INFO - 'TERM': 'linux', 04:45:06 INFO - 'TMOUT': '86400', 04:45:06 INFO - 'USER': 'cltbld', 04:45:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902', 04:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:06 INFO - '_': '/tools/buildbot/bin/python'} 04:45:06 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/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 04:45:06 INFO - mozversion application_buildid: 20160923031600 04:45:06 INFO - mozversion application_changeset: 60cc643978c7020926fe4145761e26945fcd5c37 04:45:06 INFO - mozversion application_display_name: Nightly 04:45:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:06 INFO - mozversion application_name: Firefox 04:45:06 INFO - mozversion application_remotingname: firefox 04:45:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:45:06 INFO - mozversion application_vendor: Mozilla 04:45:06 INFO - mozversion application_version: 52.0a1 04:45:06 INFO - mozversion platform_buildid: 20160923031600 04:45:06 INFO - mozversion platform_changeset: 60cc643978c7020926fe4145761e26945fcd5c37 04:45:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:45:06 INFO - mozversion platform_version: 52.0a1 04:45:06 INFO - using testdate: 1474631106 04:45:06 INFO - actual date: 1474631106 04:45:06 INFO - starting webserver on 'localhost:44759' 04:45:06 INFO - SUITE-START | Running 2 tests 04:45:06 INFO - TEST-START | dromaeo_css 04:45:06 INFO - operating with platform_type : linux_ 04:45:06 INFO - Initialising browser for dromaeo_css test... 04:45:06 INFO - TEST-INFO | started process 10441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvORHP/profile http://localhost:44759/getInfo.html) 04:45:11 INFO - PROCESS | 10441 | __metrics Screen width/height:1600/1200 04:45:11 INFO - PROCESS | 10441 | colorDepth:24 04:45:11 INFO - PROCESS | 10441 | Browser inner width/height: 1024/697 04:45:11 INFO - PROCESS | 10441 | __metrics 04:45:12 INFO - PROCESS | 10441 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:45:12 INFO - PROCESS | 10441 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:12 INFO - PROCESS | 10441 | console.error: PushService: 04:45:12 INFO - PROCESS | 10441 | stateChangeProcessEnqueue: Error transitioning state 04:45:12 INFO - PROCESS | 10441 | UnknownError 04:45:13 INFO - TEST-INFO | 10441: exit 0 04:45:13 INFO - Browser initialized. 04:45:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:13 INFO - TEST-INFO | started process 10522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvORHP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:25 INFO - PROCESS | 10522 | RSS: Main: 175157248 04:45:25 INFO - PROCESS | 10522 | 04:46:16 INFO - PROCESS | 10522 | 1474631176607 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] 04:48:30 INFO - PROCESS | 10522 | Cycle 1(1): loaded http://localhost:44759/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44759/tests/dromaeo/cssquery-ext.html) 04:48:31 INFO - PROCESS | 10522 | RSS: Main: 298147840 04:48:31 INFO - PROCESS | 10522 | 04:51:34 INFO - PROCESS | 10522 | Cycle 1(1): loaded http://localhost:44759/tests/dromaeo/cssquery-ext.html (next: http://localhost:44759/tests/dromaeo/cssquery-jquery.html) 04:51:34 INFO - PROCESS | 10522 | RSS: Main: 281423872 04:51:34 INFO - PROCESS | 10522 | 04:54:37 INFO - PROCESS | 10522 | Cycle 1(1): loaded http://localhost:44759/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44759/tests/dromaeo/cssquery-mootools.html) 04:54:37 INFO - PROCESS | 10522 | RSS: Main: 219951104 04:54:37 INFO - PROCESS | 10522 | 04:57:39 INFO - PROCESS | 10522 | Cycle 1(1): loaded http://localhost:44759/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44759/tests/dromaeo/cssquery-prototype.html) 04:57:40 INFO - PROCESS | 10522 | RSS: Main: 219652096 04:57:40 INFO - PROCESS | 10522 | 05:00:43 INFO - PROCESS | 10522 | Cycle 1(1): loaded http://localhost:44759/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44759/tests/dromaeo/cssquery-yui.html) 05:00:44 INFO - PROCESS | 10522 | RSS: Main: 219062272 05:00:44 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | Cycle 1(1): loaded http://localhost:44759/tests/dromaeo/cssquery-yui.html (next: http://localhost:44759/tests/dromaeo/cssquery-dojo.html) 05:03:47 INFO - PROCESS | 10522 | RSS: Main: 310919168 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | __start_tp_report 05:03:47 INFO - PROCESS | 10522 | _x_x_mozilla_page_load 05:03:47 INFO - PROCESS | 10522 | _x_x_mozilla_page_load_details 05:03:47 INFO - PROCESS | 10522 | |i|pagename|runs| 05:03:47 INFO - PROCESS | 10522 | |0;dojo.html;2618.685757709075;2654.7477989590984;2673.05106687126;2680.1021657744654;2698.5007773561906;4607.562281583253;4683.4379874415035;4693.601043911267;4802.543758342952;4878.658493905428;4722.881927951803;4769.928451073237;4780.259059845729;4841.56425921667;4895.388076490439;4344.956550434486;4346.369776382423;4392.472903251598;4429.424174857264;4435.512093669694;4416.447944006999;4454.376387305763;4456.643468522527;4457.643388528926;4502.77486125694;4332.0469496710675;4380.452443444569;4400.339949007643;4434.135343607998;4507.1211113832815;4359.12817436514;4359.738415695068;4393.6704747144095;4428.977855110736;4442.533533978918;4375.628071613916;4395.362672412514;4421.668374871865;4442.600165985044;4445.888852778674;4712.528747125294;4754.976225118852;4772.928406073912;4783.712977221343;4837.927431088501;4953.455119936804;5016.147254966664;5124.590032797368;5135.306733590992;5141.511556402136;5107.387113546361;5134.5378915897745;5148.510891465305;5182.896342073137;5243.056249875021;4789.880252993703;4791.6645834791925;4795.352627395327;4821.855344339676;4844.006978569385;5037.974810125999;5279.630425870152;5286.418493965661;5287.70917599528;5293.047251494768;4887.095887260868;4907.656464047483;4936.605071594264;4951.801927922843;4969.503049695001;5019.247112933089;5028.79884804611;5030.89938201234;5102.617303702237;5167.423935699648;5010.198368261061;5039.193729003415;5055.646104772631;5062.316587260746;5117.923231151536;4800.687955282895;4889.48660390661;4891.241857512091;4954.702717836942;4961.181405068123;4325.891852703708;4328.069465064963;4329.28566786483;4367.126574685012;4382.05785756064;3769.1330993871015;3782.5650050244026;3782.583915769263;3822.7897465639658;3823.808809559511;4312.849050283225;4335.82656693735;4344.630706389929;4351.238533256667;4370.104128653618;5024.899502010013;5084.13569693153;5098.34885859351;5127.410347809975;5145.151050076695;4374.978125109354;4383.912321753547;4384.693071484965;4385.890352741207;4436.911261774746;4527.275635898241;4612.0545288215835;4618.745968971739;4623.283391074388;4665.440147182359;4752.097101550694;4763.928541071956;4793.712377257376;4795.976020119877;4863.659543831898;5051.191809310492;5064.620153488577;5069.518395752545;5070.188769796815;5134.409542902465;4713.670043097088;4784.832530861403;4802.087603355351;4802.111609352281;4803.207470767285;4936.827211047596;5011.523905228997;5032.27032080339;5075.492450754895;5139.229115632685;5148.073346797612;5156.690598564098;5157.613179011514;5163.845084647466;5165.380154381498;4988.55103040728;5025.84922452327;5029.27075574047;5031.9245211322595;5080.441151473409;4845.709257444564;4856.417229932431;4895.339129217653;4902.01959608087;4981.676191047571;4808.230683090689;4843.24929635907;4860.562549370574;4914.901701966012;4919.016196760591;4774.665773395829;4918.2868484068895;4933.112039832865;4935.481774413778;4993.600511958962;4698.083873644743;4768.737719425465;4796.20862557688;4839.104765618372;4845.5881250094135 05:03:47 INFO - PROCESS | 10522 | |1;ext.html;563.5632384901702;566.4109326300647;570.640496487213;575.071259915237;576.21346861534;27742.306442338926;37270.627293727055;38814.611853881484;38905.22189556207;43520.347194792026;40494.79752601233;40771.59228407715;40820;40891.79554102226;40893.59106408942;7612.847743045149;7761.728339508119;7804.336631386339;7806.687732490694;7809.3752499799875;7699.076110866704;7781.8832717509285;7789.688412463523;7791.259830316111;7793.259640334188;7709.884351734729;7749.380049596019;7812.765617031499;7816.413768967322;7816.765497035098;7744.883826742604;7795.766127016199;7802.843943121105;7805.141434442206;7808.960955195188;7718.266764657405;7772.300492955661;7780.649870755829;7788.727394541221;7789.844203115906;38087.61912380896;38392;38470;38500.229995400216;38514.614853851665;3121.687831216883;3140.5132204508336;3221.597300337458;3316.369889720945;3407.897763067087;27904.162875113576;28332.15003549897;28864.567031494546;28869.278268043257;28956.710432895612;3305.652906444837;3367.764256502046;3444.2422667013216;3474.322507111114;3518.20840310928;244903;247001.82495437577;247822;248008;249945;49667.25499117516;49673.75163124161;49920.0015999678;49999.25001124986;50204;32091.35817283641;32669.836650816593;32751.50872736911;34576.135596610286;34621.30757384838;13850.584482465541;13934.024618276826;13937;14061.156330619991;14092.295385230698;10527.736806579744;10582.312149710244;10602.310849794738;10604;10607.628732994308;17267;17424.825751742574;17425.390111346296;17495.125243737763;17497.650046999242;6674.866502669919;6845.010615711252;6884.827879303058;6964.686589103502;7006.369426751617;770.9267619576132;797.6849144587856;838.7399906029151;938.648006997376;968.5544649461327;25699.61450578243;27647.447051058865;27903.30241743932;27996.72003279941;28282;916.4776077635684;931.1898648175995;965.9420434773936;1029.7322696099068;1060.390275591538;13737.519186828613;14571.489997850025;14801.703965920622;14803.629909252355;14835.342846747135;391579;398849;399359;400042;400898;48938.51061489339;49609.75195124074;49641.255381169314;49661.75169124203;49669;982.9852552211722;1166.2128063557066;1177.2818580665787;1196.0192642033624;1196.9760604787855;25890.22329330123;26433.33916652022;26636.467270654866;27146.32134196661;27287.863560682068;40914.36342546384;41619.167616648105;41632.791836040626;41637.79181104196;41661.375079373225;356923;358175;359007;359404;359666;24625.13812016571;24812.25563233106;25233.11684091048;25243.368915777253;25303.87348063248;40912.79543602263;41327.793361033;41917.79041104775;42213;42819.5718042828;34694;35321.823390882884;36455.45316820303;36549.634503654626;37139.257214856094;35009.29981400307;35191.824040879634;35356.823215883756;35482.29035419226;35544.82227588846;33882.141250562105;34751;34887.825560872036;35591.82204088963;35605.28789424249;30373.392532149675;32198.678013219567;32323.838380807945;32715.41984122177;32813;23917.880410597834;24950.62574061354;25159.74840251574;25347.239582812545;25460.872695636404 05:03:47 INFO - PROCESS | 10522 | |2;jquery.html;351.37279955279797;363.4203445504421;371.3983346977896;375.4255988337843;393.71849127873566;12544.43550040248;13415.46338146473;14018.369173387196;16476.01143931362;17041.57396065099;15971.520854374357;16405.261763220653;16524.75212871805;16689.91655041726;17299.048552329616;4707.45864225615;5116.974415127919;5143.022825663131;5144.3826740791155;5148.948510514884;3442.4664177052473;5097.490250974892;5177.094008548508;5179.404368497614;5203.531682148606;3563.501109844624;3795.69634429245;6033.306169790487;6116.08258761185;6144.5084393248435;5110.8466745997675;6046.6069705469445;6093.878122437526;6095.817125486243;6112.235970503665;5190.506901844319;5307.787688492455;5312.335958005249;5319.175527793198;5320.547753440962;12141.514339426412;12374.690632734164;17663.5584110397;20198.46526857794;20363.287284944956;1766.5318690547015;1799.5321216483678;1881.444973732752;1884.0862181841933;1942.77658069321;8902.376833621649;8905.109489051109;9068.501232432214;9305.302102342284;9535.2371810255;1726.4820553833924;1752.3341130370504;1771.4685594321652;1772.0519522055638;1778.6531626332871;64619;65049.67475162594;66911.66544167248;68390.65804670945;71512.64243678801;9738.367006144577;9922.50387480623;9937.552810123561;10089.646862359783;10269.7432564185;13658.726825463435;13747;13812.723745525032;13822.06491091248;13839.723205535833;6799.4900382471515;6864.21061577925;6977.33715297046;7283.089613798275;7301.160366557914;6652.800415987528;6677.76627818024;6728.6635668216395;6933.2720064393525;6951.2353641099435;4238.682098842537;4243.257429949746;4252.362145678111;4268.167707297047;4360.716553424018;1816.0465755478479;1831.7252412138018;1832.7709036370454;1844.8893066416058;1865.225931238548;799.3924617290785;871.3464901324007;891.5675897189858;921.295209164976;952.1620973543376;15974.086348844607;16036.679266414607;17082.145892705565;17494.57348868526;17687.115644217738;846.7121178799238;846.7375113714768;852.7868032991752;854.3080105114877;872.1017352127319;9198.49408282551;9235.630574776933;9900.356476829127;9970.302078854556;10054.849177262347;362951;364005;364813;366175;367696;49457.50542494601;49849;81765.59117204376;82824.58587707023;83093.58453207696;894.7941973346167;915.697819719491;934.4019827310527;937.3438592984802;943.2831048403126;15117.16855572954;15177.392904283704;15686.843131568994;15919;16019.759703604688;34310.08364288964;35626.64373356337;36493.45259821158;38067.80966095152;39540.2091958165;48416.27375589439;51491.227631586306;52181.21728174156;52555.27002569787;53199;5604.047311957059;6730.764423245163;6795.3204679531655;6894.655267236518;7625.923740762521;8892.599833007402;11835.940820296188;11974.70063248391;12006.75986480248;12662.176958497668;9713.9028609713;9834.311598188058;9963.850542241727;10217.33587316822;11014.889851101387;9727.07592778685;9807.460589667637;9892.554835032297;10057.145142662663;10180.796384072426;10627.202959777893;10761.730956726144;10798.892011080103;10995.230333876552;11108;6895.724171033103;6962.756303529352;6985.895211571728;7142.214356420894;7256.310650488195;8950.462972221687;10265.692029239135;10279.434631095062;10392;10436.791264174826 05:03:47 INFO - PROCESS | 10522 | |3;mootools.html;1158.5713286084151;1342.5703774792064;1396.3995481942763;1439.6544829240986;1670.766092747015;6922.342377474139;7632.961835190823;7889.329407000405;7891.0530736311575;8051.91948080519;7976.042874855011;8055.959720201406;8064.153263907293;8064.637091330889;8069.919300806991;2183.0612836480345;2215.1139544182374;2218.7559368469456;2221.4113259986116;2224.5106076663187;2134.7331583552054;2188.1575593396497;2192.331338941622;2215.9335219943346;2219.7891200335944;2148.516583768655;2148.677698345245;2164.6211912915255;2169.9566008679894;2198.0987795004053;2146.1415433826514;2152.461884528868;2152.5910077085305;2155.4180371299817;2155.8490905636613;2118.7245658064508;2134.103676455892;2138.4119367173994;2138.8395870309632;2139.711138996231;7718.266764657348;7875.291223789829;7927.3658107351275;7937.087234967995;7941.801454963615;4450.866474005785;4648.930266046012;4650.697704649221;4652.418447694038;4664.440267167927;2755.779537636984;2847.8433686147255;2890.2051935717636;2900.9846553706243;2911.839848808315;926.754410081329;939.4222553129845;949.7910459698855;955.8327292723815;964.9469279189642;10652.573897044109;10684.305520141166;10696.197785166143;10778.784424311549;10810.135189184846;4018.0758425562285;4160.2303573838935;4162.250794856895;4264.808083636244;4476.194285028726;8466.74599762008;8509.531975741394;8548.743537693756;8557.700480483154;8569.571521423904;4701.200795864711;4710.175719249186;4737.6683632146105;4737.692050016738;4750.429948406213;3753.9061523462133;3848.9615103848605;4181.184668989578;4415.337699345059;4419.204543182193;3386.7967921924765;3387.0516255448515;3534.505169276303;3542.433210686278;3561.786292822439;1040.5941682743735;1078.3799315393524;1087.4127970895627;1089.4008295437477;1090.51472094917;754.528419737664;758.8861670749432;778.6029125146216;779.9649015794303;786.6145588661515;4714.764261786897;4793.041391721669;4832.589229915427;4931.926021109686;4935.185694360463;391;403.2157453752482;406.2829106626806;413.981370838307;415.4433059699956;3156.731677807412;3173.3494633600517;3219.8229097399867;3286;3394.253264281854;9322.766930826649;9885.901140988643;9920;9942.105210531086;9949.154321882575;9654.903450965541;9924.652637157666;9956.800863982824;9961.157185920629;10005.44970026641;7309.342159205591;7483.214262502468;7553.093628764584;7553.169151393342;7573.2805383488485;4671;4699.718016918996;4753.382060332135;4823.927641085456;5010.423801262901;8950.194482496607;9086.90913090887;9144.177024067865;9169.954150229207;9225.677101301422;9208.079192080739;9349.859752103588;9361.344705870524;9453.763655908657;9517.52412379392;6285.402886725754;6294.213223347082;6385.457236134795;6393.552451328363;6460.612363258219;7542.057242844645;7574.280443357872;7618.085829700472;7620.314171724572;7623.123340815877;6636.568623039487;6833.555818871758;6886;6896.27589103137;6967.338102880219;6672.032555279555;6686.465082793267;6749.763758268437;6766.221884483348;6775.695093720696;6345.079963405373;6347.5239357047485;6406.679666016587;6408.967955160194;6416.422521972858;4186.81159347824;4198.748075115503;4299.161663475717;4300.8709738707885;4379.0585024219945;4314.9784251078545;4435.445569303837;4449.666275029451;4456.197884380843;4458.531854155267 05:03:47 INFO - PROCESS | 10522 | |4;prototype.html;283.3850544318828;284.6555667642153;296.36873459531193;298.2052829210155;302.0380089415211;4883.413990321162;4892.070506603747;4899.240617704261;4910.41075070992;4911.754412279385;4810.975945120278;4825.155597770385;4844.781984810683;4854.524192661742;4863.878403039926;3585.45825295123;3703.9258615001754;3715.702743780491;3733.7946412947276;3734.439834024891;3688.3729765939856;3717.364359681745;3761.078535758743;3799.297130030953;3804.657580817726;3779.489768881207;3792.5259342582176;3796.9430458543143;3798.126430920876;3804.809759512027;3496.947545786815;3718.1262403335195;3774.2451509698035;3786.734928555002;3793.468914351979;3249.6262929763143;3251.8861839835727;3261.9836900815344;3264.853081611333;3268.9019329419916;4658.1848176568965;4670.412059899651;4673.953260467386;4691.507391723888;4711.646626503026;4067.3288907330552;4153.279601860756;4192.748435093904;4193.475815523059;4214.894627634303;4963.032208719301;4971.483697472269;4974.602031837444;4982.750862456863;5005.424376196747;3534.3108093921696;3539.3629146753574;3548.2193917338404;3550.7692000019915;3558.9110272243142;5128.615353848439;5205.141151709963;5254.737263136866;5293.894122117575;5328.866778330534;3574.6782789549065;3600.4419315006216;3602.7838329700303;3607.8196090195383;3611.995342584838;3653.689436397936;3664.358737220976;3673.853045878135;3677.5770786359913;3686.4286035664513;4230.978845105817;4243.108947121077;4245.97877010613;4249.192653395845;4252.831056161318;4900.785324620823;4929.137400954819;5008.6744361616375;5014.373203349582;5050.6464547482055;1251.4118364368733;1252.8684488128797;1258.6098309524077;1267.7781388257017;1270.8625779926913;769.4344656677449;800.3077338102615;806.7737039699624;808.5472135604081;810.8824220487996;4260.701750877409;4309.547497512779;4380.255356589388;4419.18245124653;4463.174312752151;5156.974215128976;5160.277561141444;5183.45573714762;5188.688678679291;5190.325257716473;4461.754603496774;4474.753888536096;4480.171168333869;4493.820247190076;4498.460184777848;2612.2832254455534;2725.4004119093765;2748.230495461274;2749.66641179028;2753.2841461219828;4902.313676085351;4909.926351104737;4915.655904086751;4924.113659541317;4924.384451943507;5058.418281897629;5260.263563101169;5281.656692314988;5282.2340760589495;5287.9735601321745;4902.534259245366;4903.485134060872;4904.239842824297;4908.159440209921;4916.311716359784;5181.35233095863;5182.196759502283;5189.532942035235;5192.740362981911;5196.376434827845;4939.407271127488;4998.650094493496;5069.214271787879;5083.491650834887;5087.38795455231;4867.63492738039;4910.975445122752;4923.606111510999;4926.556609905126;4939.135651261086;3617.113807117273;3620.873269435557;3632.6024823616285;3647.8176091195865;3648.7810731356203;4944.860013891133;5205.245239440184;5208.697825543614;5213.348331458567;5239.738013099406;5006.449290578106;5012.573931215888;5028.74856257193;5035.194368900959;5052.494750524918;4993.5755460784785;5005.824796132118;5012.924806127984;5037.848864534069;5057.140286151437;4691.976540117277;4966.850994470172;4970.663788019625;4991.151504244214;5010.9248361273885;4851.611871050237;4983.6760610560195;5053.140966035856;5060.493950605058;5086.3896332440345;4789.611012806247;4935.210366341368;4949.455559888337;4957.429895561912;4961.330220420197 05:03:47 INFO - PROCESS | 10522 | |5;yui.html;664.7274617406863;687.0175648822185;696.2967402923047;707.7912015955293;762.6301243896709;12800.871991280084;13878.861211387895;13950.79073813891;13960.162390256592;13983.720325593482;13362.866371336308;13520.526781562647;13533.052686311961;13537.323133843318;13555.11891727037;608.3976862905736;621.0901029991062;749.8875168724694;753.7663324369463;766.5400759544257;766.3868904876077;782.9960850195741;783.3889566138421;785.6700185921926;786.1273985875673;819.3608984991716;819.397742659145;824.7195953375851;825.0429501777938;825.0923983618002;642.0497663458061;661.1009027722293;787.3779714025912;816.4978538199024;816.5713000674634;583.1486030395628;596.8418369132183;597.0804960361039;597.1520440973827;597.8176656119882;13723.725525489433;13775.242361670103;13783.793243101361;13785.241811700353;13803.51687690936;12831.74336513274;13220.6694832629;13462.663433414145;13542.59372218835;13753.174809511462;12343.259404435763;12448;12512.249265044036;12688.619341419771;12726.172798768142;4182.226288136704;4196.489263865006;4217.725847819913;4273.4444522212225;4288.828446862121;65541.344586554;65919;66510.66744666245;67074.66462667656;67089.32910670928;10511.316764410289;10537.315074520131;10599.417032063157;10660.733481663021;10746.408947507962;17181.7422738659;17825.554361140817;19855.205791768458;19855.404337869888;19979.60040799176;6921.411680007256;7075.433965282765;7149.320814522716;7272.963635181896;7314.232005639331;3774.857760780168;3808.143167787281;3871.8644847430205;3917.8628747993685;3942.152437225953;2896.348321627659;2995.610570625848;3011.1719277198945;3023.0779612218485;3024.4555979923384;508.654115201659;509.95155460231217;516.3906590223497;521.2546059135396;522.725569076238;530.8089087928342;589.799468180812;612.041467304627;619.1424876545926;620.0915658560141;8352.64970813578;8519.105493923049;8608;8728.781780455412;8834.337424693174;444.6398417282012;484.7866938547028;537.2934591012805;538.692945021334;581.3140494216865;3873.573906870242;4152.6055024772595;4235.8093885775215;4265.87202383929;4343.869683909487;58387;59905.70047149823;91793;94334.05665943252;106263;66346;66418;67390.66304668445;91762;97399.51300243453;44508.55491445044;59766.402335976956;60396.69801650964;69034;74674.25325746673;7735.613219339123;7980.644517609591;8033.731916884763;8159.34725221969;8258.545779982158;41643.7917810409;42450.78774606107;43283.35074973941;43660;43693.56306436895;58470;63066.36933630605;64596.67701661649;65554;68192.31807682058;11214.55141794319;11609.482934398158;11653.53385864556;11731.824022639497;11948.462319195483;12920.741585168433;13181.868181318065;13209.207447553177;13461.461541538229;14057.226852522801;10794;11551.191416600757;11624.6512604622;11954.940225299166;13328.600141995756;12556.928106862266;12830.166039207796;13168.078234523875;13587.116837405538;13607.387667554785;12033.4584943676;12526.123171377916;12675.429605667583;12994.610161695164;13001.15492492985;9511;9641.886934623311;9648.614055437703;9912.15746661542;10394.636187733393;9074.863877041718;9682.322237443312;9765.169960553432;9771.267154963549;9885.752856178366 05:03:47 INFO - PROCESS | 10522 | __end_tp_report 05:03:47 INFO - PROCESS | 10522 | __start_cc_report 05:03:47 INFO - PROCESS | 10522 | _x_x_mozilla_cycle_collect,1005 05:03:47 INFO - PROCESS | 10522 | __end_cc_report 05:03:47 INFO - PROCESS | 10522 | __startTimestamp1474632227474__endTimestamp 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | ------- Summary: start ------- 05:03:47 INFO - PROCESS | 10522 | Number of tests: 6 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | [#0] dojo.html Cycles:165 Average:4703.50 Median:4803.21 stddev:484.47 (10.1%) stddev-sans-first:457.51 05:03:47 INFO - PROCESS | 10522 | Values: 2618.7 2654.7 2673.1 2680.1 2698.5 4607.6 4683.4 4693.6 4802.5 4878.7 4722.9 4769.9 4780.3 4841.6 4895.4 4345.0 4346.4 4392.5 4429.4 4435.5 4416.4 4454.4 4456.6 4457.6 4502.8 4332.0 4380.5 4400.3 4434.1 4507.1 4359.1 4359.7 4393.7 4429.0 4442.5 4375.6 4395.4 4421.7 4442.6 4445.9 4712.5 4755.0 4772.9 4783.7 4837.9 4953.5 5016.1 5124.6 5135.3 5141.5 5107.4 5134.5 5148.5 5182.9 5243.1 4789.9 4791.7 4795.4 4821.9 4844.0 5038.0 5279.6 5286.4 5287.7 5293.0 4887.1 4907.7 4936.6 4951.8 4969.5 5019.2 5028.8 5030.9 5102.6 5167.4 5010.2 5039.2 5055.6 5062.3 5117.9 4800.7 4889.5 4891.2 4954.7 4961.2 4325.9 4328.1 4329.3 4367.1 4382.1 3769.1 3782.6 3782.6 3822.8 3823.8 4312.8 4335.8 4344.6 4351.2 4370.1 5024.9 5084.1 5098.3 5127.4 5145.2 4375.0 4383.9 4384.7 4385.9 4436.9 4527.3 4612.1 4618.7 4623.3 4665.4 4752.1 4763.9 4793.7 4796.0 4863.7 5051.2 5064.6 5069.5 5070.2 5134.4 4713.7 4784.8 4802.1 4802.1 4803.2 4936.8 5011.5 5032.3 5075.5 5139.2 5148.1 5156.7 5157.6 5163.8 5165.4 4988.6 5025.8 5029.3 5031.9 5080.4 4845.7 4856.4 4895.3 4902.0 4981.7 4808.2 4843.2 4860.6 4914.9 4919.0 4774.7 4918.3 4933.1 4935.5 4993.6 4698.1 4768.7 4796.2 4839.1 4845.6 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | [#1] ext.html Cycles:180 Average:47790.66 Median:358591.00 stddev:89974.55 (25.1%) stddev-sans-first:90157.08 05:03:47 INFO - PROCESS | 10522 | Values: 563.6 566.4 570.6 575.1 576.2 27742.3 37270.6 38814.6 38905.2 43520.3 40494.8 40771.6 40820.0 40891.8 40893.6 7612.8 7761.7 7804.3 7806.7 7809.4 7699.1 7781.9 7789.7 7791.3 7793.3 7709.9 7749.4 7812.8 7816.4 7816.8 7744.9 7795.8 7802.8 7805.1 7809.0 7718.3 7772.3 7780.6 7788.7 7789.8 38087.6 38392.0 38470.0 38500.2 38514.6 3121.7 3140.5 3221.6 3316.4 3407.9 27904.2 28332.2 28864.6 28869.3 28956.7 3305.7 3367.8 3444.2 3474.3 3518.2 244903.0 247001.8 247822.0 248008.0 249945.0 49667.3 49673.8 49920.0 49999.3 50204.0 32091.4 32669.8 32751.5 34576.1 34621.3 13850.6 13934.0 13937.0 14061.2 14092.3 10527.7 10582.3 10602.3 10604.0 10607.6 17267.0 17424.8 17425.4 17495.1 17497.7 6674.9 6845.0 6884.8 6964.7 7006.4 770.9 797.7 838.7 938.6 968.6 25699.6 27647.4 27903.3 27996.7 28282.0 916.5 931.2 965.9 1029.7 1060.4 13737.5 14571.5 14801.7 14803.6 14835.3 391579.0 398849.0 399359.0 400042.0 400898.0 48938.5 49609.8 49641.3 49661.8 49669.0 983.0 1166.2 1177.3 1196.0 1197.0 25890.2 26433.3 26636.5 27146.3 27287.9 40914.4 41619.2 41632.8 41637.8 41661.4 356923.0 358175.0 359007.0 359404.0 359666.0 24625.1 24812.3 25233.1 25243.4 25303.9 40912.8 41327.8 41917.8 42213.0 42819.6 34694.0 35321.8 36455.5 36549.6 37139.3 35009.3 35191.8 35356.8 35482.3 35544.8 33882.1 34751.0 34887.8 35591.8 35605.3 30373.4 32198.7 32323.8 32715.4 32813.0 23917.9 24950.6 25159.7 25347.2 25460.9 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | [#2] jquery.html Cycles:180 Average:23113.52 Median:49653.25 stddev:60355.73 (121.6%) stddev-sans-first:60500.85 05:03:47 INFO - PROCESS | 10522 | Values: 351.4 363.4 371.4 375.4 393.7 12544.4 13415.5 14018.4 16476.0 17041.6 15971.5 16405.3 16524.8 16689.9 17299.0 4707.5 5117.0 5143.0 5144.4 5148.9 3442.5 5097.5 5177.1 5179.4 5203.5 3563.5 3795.7 6033.3 6116.1 6144.5 5110.8 6046.6 6093.9 6095.8 6112.2 5190.5 5307.8 5312.3 5319.2 5320.5 12141.5 12374.7 17663.6 20198.5 20363.3 1766.5 1799.5 1881.4 1884.1 1942.8 8902.4 8905.1 9068.5 9305.3 9535.2 1726.5 1752.3 1771.5 1772.1 1778.7 64619.0 65049.7 66911.7 68390.7 71512.6 9738.4 9922.5 9937.6 10089.6 10269.7 13658.7 13747.0 13812.7 13822.1 13839.7 6799.5 6864.2 6977.3 7283.1 7301.2 6652.8 6677.8 6728.7 6933.3 6951.2 4238.7 4243.3 4252.4 4268.2 4360.7 1816.0 1831.7 1832.8 1844.9 1865.2 799.4 871.3 891.6 921.3 952.2 15974.1 16036.7 17082.1 17494.6 17687.1 846.7 846.7 852.8 854.3 872.1 9198.5 9235.6 9900.4 9970.3 10054.8 362951.0 364005.0 364813.0 366175.0 367696.0 49457.5 49849.0 81765.6 82824.6 83093.6 894.8 915.7 934.4 937.3 943.3 15117.2 15177.4 15686.8 15919.0 16019.8 34310.1 35626.6 36493.5 38067.8 39540.2 48416.3 51491.2 52181.2 52555.3 53199.0 5604.0 6730.8 6795.3 6894.7 7625.9 8892.6 11835.9 11974.7 12006.8 12662.2 9713.9 9834.3 9963.9 10217.3 11014.9 9727.1 9807.5 9892.6 10057.1 10180.8 10627.2 10761.7 10798.9 10995.2 11108.0 6895.7 6962.8 6985.9 7142.2 7256.3 8950.5 10265.7 10279.4 10392.0 10436.8 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | [#3] mootools.html Cycles:180 Average:5098.01 Median:4726.22 stddev:2955.40 (62.5%) stddev-sans-first:2948.87 05:03:47 INFO - PROCESS | 10522 | Values: 1158.6 1342.6 1396.4 1439.7 1670.8 6922.3 7633.0 7889.3 7891.1 8051.9 7976.0 8056.0 8064.2 8064.6 8069.9 2183.1 2215.1 2218.8 2221.4 2224.5 2134.7 2188.2 2192.3 2215.9 2219.8 2148.5 2148.7 2164.6 2170.0 2198.1 2146.1 2152.5 2152.6 2155.4 2155.8 2118.7 2134.1 2138.4 2138.8 2139.7 7718.3 7875.3 7927.4 7937.1 7941.8 4450.9 4648.9 4650.7 4652.4 4664.4 2755.8 2847.8 2890.2 2901.0 2911.8 926.8 939.4 949.8 955.8 964.9 10652.6 10684.3 10696.2 10778.8 10810.1 4018.1 4160.2 4162.3 4264.8 4476.2 8466.7 8509.5 8548.7 8557.7 8569.6 4701.2 4710.2 4737.7 4737.7 4750.4 3753.9 3849.0 4181.2 4415.3 4419.2 3386.8 3387.1 3534.5 3542.4 3561.8 1040.6 1078.4 1087.4 1089.4 1090.5 754.5 758.9 778.6 780.0 786.6 4714.8 4793.0 4832.6 4931.9 4935.2 391.0 403.2 406.3 414.0 415.4 3156.7 3173.3 3219.8 3286.0 3394.3 9322.8 9885.9 9920.0 9942.1 9949.2 9654.9 9924.7 9956.8 9961.2 10005.4 7309.3 7483.2 7553.1 7553.2 7573.3 4671.0 4699.7 4753.4 4823.9 5010.4 8950.2 9086.9 9144.2 9170.0 9225.7 9208.1 9349.9 9361.3 9453.8 9517.5 6285.4 6294.2 6385.5 6393.6 6460.6 7542.1 7574.3 7618.1 7620.3 7623.1 6636.6 6833.6 6886.0 6896.3 6967.3 6672.0 6686.5 6749.8 6766.2 6775.7 6345.1 6347.5 6406.7 6409.0 6416.4 4186.8 4198.7 4299.2 4300.9 4379.1 4315.0 4435.4 4449.7 4456.2 4458.5 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | [#4] prototype.html Cycles:180 Average:4168.06 Median:4853.07 stddev:1223.51 (25.2%) stddev-sans-first:1191.70 05:03:47 INFO - PROCESS | 10522 | Values: 283.4 284.7 296.4 298.2 302.0 4883.4 4892.1 4899.2 4910.4 4911.8 4811.0 4825.2 4844.8 4854.5 4863.9 3585.5 3703.9 3715.7 3733.8 3734.4 3688.4 3717.4 3761.1 3799.3 3804.7 3779.5 3792.5 3796.9 3798.1 3804.8 3496.9 3718.1 3774.2 3786.7 3793.5 3249.6 3251.9 3262.0 3264.9 3268.9 4658.2 4670.4 4674.0 4691.5 4711.6 4067.3 4153.3 4192.7 4193.5 4214.9 4963.0 4971.5 4974.6 4982.8 5005.4 3534.3 3539.4 3548.2 3550.8 3558.9 5128.6 5205.1 5254.7 5293.9 5328.9 3574.7 3600.4 3602.8 3607.8 3612.0 3653.7 3664.4 3673.9 3677.6 3686.4 4231.0 4243.1 4246.0 4249.2 4252.8 4900.8 4929.1 5008.7 5014.4 5050.6 1251.4 1252.9 1258.6 1267.8 1270.9 769.4 800.3 806.8 808.5 810.9 4260.7 4309.5 4380.3 4419.2 4463.2 5157.0 5160.3 5183.5 5188.7 5190.3 4461.8 4474.8 4480.2 4493.8 4498.5 2612.3 2725.4 2748.2 2749.7 2753.3 4902.3 4909.9 4915.7 4924.1 4924.4 5058.4 5260.3 5281.7 5282.2 5288.0 4902.5 4903.5 4904.2 4908.2 4916.3 5181.4 5182.2 5189.5 5192.7 5196.4 4939.4 4998.7 5069.2 5083.5 5087.4 4867.6 4911.0 4923.6 4926.6 4939.1 3617.1 3620.9 3632.6 3647.8 3648.8 4944.9 5205.2 5208.7 5213.3 5239.7 5006.4 5012.6 5028.7 5035.2 5052.5 4993.6 5005.8 5012.9 5037.8 5057.1 4692.0 4966.9 4970.7 4991.2 5010.9 4851.6 4983.7 5053.1 5060.5 5086.4 4789.6 4935.2 4949.5 4957.4 4961.3 05:03:47 INFO - PROCESS | 10522 | 05:03:47 INFO - PROCESS | 10522 | [#5] yui.html Cycles:180 Average:17183.23 Median:509.30 stddev:23407.72 (4596.0%) stddev-sans-first:23440.53 05:03:47 INFO - PROCESS | 10522 | Values: 664.7 687.0 696.3 707.8 762.6 12800.9 13878.9 13950.8 13960.2 13983.7 13362.9 13520.5 13533.1 13537.3 13555.1 608.4 621.1 749.9 753.8 766.5 766.4 783.0 783.4 785.7 786.1 819.4 819.4 824.7 825.0 825.1 642.0 661.1 787.4 816.5 816.6 583.1 596.8 597.1 597.2 597.8 13723.7 13775.2 13783.8 13785.2 13803.5 12831.7 13220.7 13462.7 13542.6 13753.2 12343.3 12448.0 12512.2 12688.6 12726.2 4182.2 4196.5 4217.7 4273.4 4288.8 65541.3 65919.0 66510.7 67074.7 67089.3 10511.3 10537.3 10599.4 10660.7 10746.4 17181.7 17825.6 19855.2 19855.4 19979.6 6921.4 7075.4 7149.3 7273.0 7314.2 3774.9 3808.1 3871.9 3917.9 3942.2 2896.3 2995.6 3011.2 3023.1 3024.5 508.7 510.0 516.4 521.3 522.7 530.8 589.8 612.0 619.1 620.1 8352.6 8519.1 8608.0 8728.8 8834.3 444.6 484.8 537.3 538.7 581.3 3873.6 4152.6 4235.8 4265.9 4343.9 58387.0 59905.7 91793.0 94334.1 106263.0 66346.0 66418.0 67390.7 91762.0 97399.5 44508.6 59766.4 60396.7 69034.0 74674.3 7735.6 7980.6 8033.7 8159.3 8258.5 41643.8 42450.8 43283.4 43660.0 43693.6 58470.0 63066.4 64596.7 65554.0 68192.3 11214.6 11609.5 11653.5 11731.8 11948.5 12920.7 13181.9 13209.2 13461.5 14057.2 10794.0 11551.2 11624.7 11954.9 13328.6 12556.9 12830.2 13168.1 13587.1 13607.4 12033.5 12526.1 12675.4 12994.6 13001.2 9511.0 9641.9 9648.6 9912.2 10394.6 9074.9 9682.3 9765.2 9771.3 9885.8 05:03:47 INFO - PROCESS | 10522 | -------- Summary: end -------- 05:03:47 INFO - PROCESS | 10522 | 05:03:48 INFO - TEST-INFO | 10522: exit 0 05:03:48 INFO - TEST-OK | dromaeo_css | took 1121765ms 05:03:48 INFO - TEST-START | kraken 05:03:48 INFO - operating with platform_type : linux_ 05:03:48 INFO - Initialising browser for kraken test... 05:03:48 INFO - TEST-INFO | started process 10825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8GmFsm/profile http://localhost:44759/getInfo.html) 05:03:53 INFO - PROCESS | 10825 | __metrics Screen width/height:1600/1200 05:03:53 INFO - PROCESS | 10825 | colorDepth:24 05:03:53 INFO - PROCESS | 10825 | Browser inner width/height: 1024/697 05:03:53 INFO - PROCESS | 10825 | __metrics 05:03:53 INFO - PROCESS | 10825 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:03:53 INFO - PROCESS | 10825 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:54 INFO - PROCESS | 10825 | console.error: PushService: 05:03:54 INFO - PROCESS | 10825 | stateChangeProcessEnqueue: Error transitioning state 05:03:54 INFO - PROCESS | 10825 | UnknownError 05:03:55 INFO - TEST-INFO | 10825: exit 0 05:03:55 INFO - Browser initialized. 05:03:55 INFO - Running cycle 1/1 for kraken test... 05:03:55 INFO - TEST-INFO | started process 10908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8GmFsm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:07 INFO - PROCESS | 10908 | RSS: Main: 175378432 05:04:07 INFO - PROCESS | 10908 | 05:04:10 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44759/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:11 INFO - PROCESS | 10908 | RSS: Main: 234098688 05:04:11 INFO - PROCESS | 10908 | 05:04:14 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44759/tests/kraken/driver.html?testName=audio-dft) 05:04:14 INFO - PROCESS | 10908 | RSS: Main: 218877952 05:04:14 INFO - PROCESS | 10908 | 05:04:17 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44759/tests/kraken/driver.html?testName=audio-fft) 05:04:18 INFO - PROCESS | 10908 | RSS: Main: 300572672 05:04:18 INFO - PROCESS | 10908 | 05:04:20 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44759/tests/kraken/driver.html?testName=audio-oscillator) 05:04:21 INFO - PROCESS | 10908 | RSS: Main: 208834560 05:04:21 INFO - PROCESS | 10908 | 05:04:23 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44759/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:24 INFO - PROCESS | 10908 | RSS: Main: 213700608 05:04:24 INFO - PROCESS | 10908 | 05:04:27 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44759/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:28 INFO - PROCESS | 10908 | RSS: Main: 250449920 05:04:28 INFO - PROCESS | 10908 | 05:04:31 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44759/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:32 INFO - PROCESS | 10908 | RSS: Main: 244342784 05:04:32 INFO - PROCESS | 10908 | 05:04:35 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44759/tests/kraken/driver.html?testName=json-parse-financial) 05:04:35 INFO - PROCESS | 10908 | RSS: Main: 247148544 05:04:35 INFO - PROCESS | 10908 | 05:04:37 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44759/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:38 INFO - PROCESS | 10908 | RSS: Main: 210468864 05:04:38 INFO - PROCESS | 10908 | 05:04:39 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:40 INFO - PROCESS | 10908 | RSS: Main: 218456064 05:04:40 INFO - PROCESS | 10908 | 05:04:42 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:43 INFO - PROCESS | 10908 | RSS: Main: 222134272 05:04:43 INFO - PROCESS | 10908 | 05:04:46 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:46 INFO - PROCESS | 10908 | RSS: Main: 223305728 05:04:46 INFO - PROCESS | 10908 | 05:04:49 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:50 INFO - PROCESS | 10908 | RSS: Main: 222240768 05:04:50 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | Cycle 1(1): loaded http://localhost:44759/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44759/tests/kraken/driver.html?testName=ai-astar) 05:04:52 INFO - PROCESS | 10908 | RSS: Main: 272523264 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | __start_tp_report 05:04:52 INFO - PROCESS | 10908 | _x_x_mozilla_page_load 05:04:52 INFO - PROCESS | 10908 | _x_x_mozilla_page_load_details 05:04:52 INFO - PROCESS | 10908 | |i|pagename|runs| 05:04:52 INFO - PROCESS | 10908 | |0;ai-astar;110;113;114;115;114;116;113;114;112;113 05:04:52 INFO - PROCESS | 10908 | |1;audio-beat-detection;149;123;127;164;125;131;131;131;162;135 05:04:52 INFO - PROCESS | 10908 | |2;audio-dft;161;162;162;162;163;162;162;162;162;161 05:04:52 INFO - PROCESS | 10908 | |3;audio-fft;77;76;77;115;77;78;78;78;99;76 05:04:52 INFO - PROCESS | 10908 | |4;audio-oscillator;85;84;129;84;83;83;114;83;83;116 05:04:52 INFO - PROCESS | 10908 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 05:04:52 INFO - PROCESS | 10908 | |6;imaging-darkroom;147;146;146;146;147;146;146;147;147;147 05:04:52 INFO - PROCESS | 10908 | |7;imaging-desaturate;95;95;96;96;95;97;95;95;95;95 05:04:52 INFO - PROCESS | 10908 | |8;json-parse-financial;75;63;62;61;63;65;63;65;63;63 05:04:52 INFO - PROCESS | 10908 | |9;json-stringify-tinderbox;66;67;65;66;66;66;66;66;66;66 05:04:52 INFO - PROCESS | 10908 | |10;stanford-crypto-aes;83;83;84;82;83;82;89;83;83;91 05:04:52 INFO - PROCESS | 10908 | |11;stanford-crypto-ccm;144;132;138;140;132;133;133;131;172;138 05:04:52 INFO - PROCESS | 10908 | |12;stanford-crypto-pbkdf2;171;174;173;171;175;177;170;175;173;170 05:04:52 INFO - PROCESS | 10908 | |13;stanford-crypto-sha256-iterative;69;69;70;69;69;69;69;69;68;67 05:04:52 INFO - PROCESS | 10908 | __end_tp_report 05:04:52 INFO - PROCESS | 10908 | __start_cc_report 05:04:52 INFO - PROCESS | 10908 | _x_x_mozilla_cycle_collect,1956 05:04:52 INFO - PROCESS | 10908 | __end_cc_report 05:04:52 INFO - PROCESS | 10908 | __startTimestamp1474632292425__endTimestamp 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | ------- Summary: start ------- 05:04:52 INFO - PROCESS | 10908 | Number of tests: 14 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.20 05:04:52 INFO - PROCESS | 10908 | Values: 110.0 113.0 114.0 115.0 114.0 116.0 113.0 114.0 112.0 113.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:133.00 stddev:15.07 (11.3%) stddev-sans-first:15.43 05:04:52 INFO - PROCESS | 10908 | Values: 149.0 123.0 127.0 164.0 125.0 131.0 131.0 131.0 162.0 135.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:04:52 INFO - PROCESS | 10908 | Values: 161.0 162.0 162.0 162.0 163.0 162.0 162.0 162.0 162.0 161.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.50 stddev:13.17 (17.0%) stddev-sans-first:13.78 05:04:52 INFO - PROCESS | 10908 | Values: 77.0 76.0 77.0 115.0 77.0 78.0 78.0 78.0 99.0 76.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.00 stddev:17.86 (21.5%) stddev-sans-first:18.62 05:04:52 INFO - PROCESS | 10908 | Values: 85.0 84.0 129.0 84.0 83.0 83.0 114.0 83.0 83.0 116.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:04:52 INFO - PROCESS | 10908 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:04:52 INFO - PROCESS | 10908 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:04:52 INFO - PROCESS | 10908 | Values: 95.0 95.0 96.0 96.0 95.0 97.0 95.0 95.0 95.0 95.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:63.00 stddev:3.95 (6.3%) stddev-sans-first:1.27 05:04:52 INFO - PROCESS | 10908 | Values: 75.0 63.0 62.0 61.0 63.0 65.0 63.0 65.0 63.0 63.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 05:04:52 INFO - PROCESS | 10908 | Values: 66.0 67.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.09 (3.7%) stddev-sans-first:3.24 05:04:52 INFO - PROCESS | 10908 | Values: 83.0 83.0 84.0 82.0 83.0 82.0 89.0 83.0 83.0 91.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:138.00 stddev:12.25 (8.9%) stddev-sans-first:12.87 05:04:52 INFO - PROCESS | 10908 | Values: 144.0 132.0 138.0 140.0 132.0 133.0 133.0 131.0 172.0 138.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.50 stddev:2.38 (1.4%) stddev-sans-first:2.42 05:04:52 INFO - PROCESS | 10908 | Values: 171.0 174.0 173.0 171.0 175.0 177.0 170.0 175.0 173.0 170.0 05:04:52 INFO - PROCESS | 10908 | 05:04:52 INFO - PROCESS | 10908 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 05:04:52 INFO - PROCESS | 10908 | Values: 69.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 68.0 67.0 05:04:52 INFO - PROCESS | 10908 | -------- Summary: end -------- 05:04:52 INFO - PROCESS | 10908 | 05:04:53 INFO - TEST-INFO | 10908: exit 0 05:04:53 INFO - TEST-OK | kraken | took 65242ms 05:04:53 INFO - SUITE-END | took 1187s 05:04:54 INFO - Completed test suite (00:19:47) 05:04:54 INFO - javascript benchmark 05:04:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.685757709075, 2654.7477989590984, 2673.05106687126, 2680.1021657744654, 2698.5007773561906, 4607.562281583253, 4683.4379874415035, 4693.601043911267, 4802.543758342952, 4878.658493905428, 4722.881927951803, 4769.928451073237, 4780.259059845729, 4841.56425921667, 4895.388076490439, 4344.956550434486, 4346.369776382423, 4392.472903251598, 4429.424174857264, 4435.512093669694, 4416.447944006999, 4454.376387305763, 4456.643468522527, 4457.643388528926, 4502.77486125694, 4332.0469496710675, 4380.452443444569, 4400.339949007643, 4434.135343607998, 4507.1211113832815, 4359.12817436514, 4359.738415695068, 4393.6704747144095, 4428.977855110736, 4442.533533978918, 4375.628071613916, 4395.362672412514, 4421.668374871865, 4442.600165985044, 4445.888852778674, 4712.528747125294, 4754.976225118852, 4772.928406073912, 4783.712977221343, 4837.927431088501, 4953.455119936804, 5016.147254966664, 5124.590032797368, 5135.306733590992, 5141.511556402136, 5107.387113546361, 5134.5378915897745, 5148.510891465305, 5182.896342073137, 5243.056249875021, 4789.880252993703, 4791.6645834791925, 4795.352627395327, 4821.855344339676, 4844.006978569385, 5037.974810125999, 5279.630425870152, 5286.418493965661, 5287.70917599528, 5293.047251494768, 4887.095887260868, 4907.656464047483, 4936.605071594264, 4951.801927922843, 4969.503049695001, 5019.247112933089, 5028.79884804611, 5030.89938201234, 5102.617303702237, 5167.423935699648, 5010.198368261061, 5039.193729003415, 5055.646104772631, 5062.316587260746, 5117.923231151536, 4800.687955282895, 4889.48660390661, 4891.241857512091, 4954.702717836942, 4961.181405068123, 4325.891852703708, 4328.069465064963, 4329.28566786483, 4367.126574685012, 4382.05785756064, 3769.1330993871015, 3782.5650050244026, 3782.583915769263, 3822.7897465639658, 3823.808809559511, 4312.849050283225, 4335.82656693735, 4344.630706389929, 4351.238533256667, 4370.104128653618, 5024.899502010013, 5084.13569693153, 5098.34885859351, 5127.410347809975, 5145.151050076695, 4374.978125109354, 4383.912321753547, 4384.693071484965, 4385.890352741207, 4436.911261774746, 4527.275635898241, 4612.0545288215835, 4618.745968971739, 4623.283391074388, 4665.440147182359, 4752.097101550694, 4763.928541071956, 4793.712377257376, 4795.976020119877, 4863.659543831898, 5051.191809310492, 5064.620153488577, 5069.518395752545, 5070.188769796815, 5134.409542902465, 4713.670043097088, 4784.832530861403, 4802.087603355351, 4802.111609352281, 4803.207470767285, 4936.827211047596, 5011.523905228997, 5032.27032080339, 5075.492450754895, 5139.229115632685, 5148.073346797612, 5156.690598564098, 5157.613179011514, 5163.845084647466, 5165.380154381498, 4988.55103040728, 5025.84922452327, 5029.27075574047, 5031.9245211322595, 5080.441151473409, 4845.709257444564, 4856.417229932431, 4895.339129217653, 4902.01959608087, 4981.676191047571, 4808.230683090689, 4843.24929635907, 4860.562549370574, 4914.901701966012, 4919.016196760591, 4774.665773395829, 4918.2868484068895, 4933.112039832865, 4935.481774413778, 4993.600511958962, 4698.083873644743, 4768.737719425465, 4796.20862557688, 4839.104765618372, 4845.5881250094135], "value": 4673.031245558786, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5632384901702, 566.4109326300647, 570.640496487213, 575.071259915237, 576.21346861534, 27742.306442338926, 37270.627293727055, 38814.611853881484, 38905.22189556207, 43520.347194792026, 40494.79752601233, 40771.59228407715, 40820.0, 40891.79554102226, 40893.59106408942, 7612.847743045149, 7761.728339508119, 7804.336631386339, 7806.687732490694, 7809.3752499799875, 7699.076110866704, 7781.8832717509285, 7789.688412463523, 7791.259830316111, 7793.259640334188, 7709.884351734729, 7749.380049596019, 7812.765617031499, 7816.413768967322, 7816.765497035098, 7744.883826742604, 7795.766127016199, 7802.843943121105, 7805.141434442206, 7808.960955195188, 7718.266764657405, 7772.300492955661, 7780.649870755829, 7788.727394541221, 7789.844203115906, 38087.61912380896, 38392.0, 38470.0, 38500.229995400216, 38514.614853851665, 3121.687831216883, 3140.5132204508336, 3221.597300337458, 3316.369889720945, 3407.897763067087, 27904.162875113576, 28332.15003549897, 28864.567031494546, 28869.278268043257, 28956.710432895612, 3305.652906444837, 3367.764256502046, 3444.2422667013216, 3474.322507111114, 3518.20840310928, 244903.0, 247001.82495437577, 247822.0, 248008.0, 249945.0, 49667.25499117516, 49673.75163124161, 49920.0015999678, 49999.25001124986, 50204.0, 32091.35817283641, 32669.836650816593, 32751.50872736911, 34576.135596610286, 34621.30757384838, 13850.584482465541, 13934.024618276826, 13937.0, 14061.156330619991, 14092.295385230698, 10527.736806579744, 10582.312149710244, 10602.310849794738, 10604.0, 10607.628732994308, 17267.0, 17424.825751742574, 17425.390111346296, 17495.125243737763, 17497.650046999242, 6674.866502669919, 6845.010615711252, 6884.827879303058, 6964.686589103502, 7006.369426751617, 770.9267619576132, 797.6849144587856, 838.7399906029151, 938.648006997376, 968.5544649461327, 25699.61450578243, 27647.447051058865, 27903.30241743932, 27996.72003279941, 28282.0, 916.4776077635684, 931.1898648175995, 965.9420434773936, 1029.7322696099068, 1060.390275591538, 13737.519186828613, 14571.489997850025, 14801.703965920622, 14803.629909252355, 14835.342846747135, 391579.0, 398849.0, 399359.0, 400042.0, 400898.0, 48938.51061489339, 49609.75195124074, 49641.255381169314, 49661.75169124203, 49669.0, 982.9852552211722, 1166.2128063557066, 1177.2818580665787, 1196.0192642033624, 1196.9760604787855, 25890.22329330123, 26433.33916652022, 26636.467270654866, 27146.32134196661, 27287.863560682068, 40914.36342546384, 41619.167616648105, 41632.791836040626, 41637.79181104196, 41661.375079373225, 356923.0, 358175.0, 359007.0, 359404.0, 359666.0, 24625.13812016571, 24812.25563233106, 25233.11684091048, 25243.368915777253, 25303.87348063248, 40912.79543602263, 41327.793361033, 41917.79041104775, 42213.0, 42819.5718042828, 34694.0, 35321.823390882884, 36455.45316820303, 36549.634503654626, 37139.257214856094, 35009.29981400307, 35191.824040879634, 35356.823215883756, 35482.29035419226, 35544.82227588846, 33882.141250562105, 34751.0, 34887.825560872036, 35591.82204088963, 35605.28789424249, 30373.392532149675, 32198.678013219567, 32323.838380807945, 32715.41984122177, 32813.0, 23917.880410597834, 24950.62574061354, 25159.74840251574, 25347.239582812545, 25460.872695636404], "value": 17108.19268541855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.37279955279797, 363.4203445504421, 371.3983346977896, 375.4255988337843, 393.71849127873566, 12544.43550040248, 13415.46338146473, 14018.369173387196, 16476.01143931362, 17041.57396065099, 15971.520854374357, 16405.261763220653, 16524.75212871805, 16689.91655041726, 17299.048552329616, 4707.45864225615, 5116.974415127919, 5143.022825663131, 5144.3826740791155, 5148.948510514884, 3442.4664177052473, 5097.490250974892, 5177.094008548508, 5179.404368497614, 5203.531682148606, 3563.501109844624, 3795.69634429245, 6033.306169790487, 6116.08258761185, 6144.5084393248435, 5110.8466745997675, 6046.6069705469445, 6093.878122437526, 6095.817125486243, 6112.235970503665, 5190.506901844319, 5307.787688492455, 5312.335958005249, 5319.175527793198, 5320.547753440962, 12141.514339426412, 12374.690632734164, 17663.5584110397, 20198.46526857794, 20363.287284944956, 1766.5318690547015, 1799.5321216483678, 1881.444973732752, 1884.0862181841933, 1942.77658069321, 8902.376833621649, 8905.109489051109, 9068.501232432214, 9305.302102342284, 9535.2371810255, 1726.4820553833924, 1752.3341130370504, 1771.4685594321652, 1772.0519522055638, 1778.6531626332871, 64619.0, 65049.67475162594, 66911.66544167248, 68390.65804670945, 71512.64243678801, 9738.367006144577, 9922.50387480623, 9937.552810123561, 10089.646862359783, 10269.7432564185, 13658.726825463435, 13747.0, 13812.723745525032, 13822.06491091248, 13839.723205535833, 6799.4900382471515, 6864.21061577925, 6977.33715297046, 7283.089613798275, 7301.160366557914, 6652.800415987528, 6677.76627818024, 6728.6635668216395, 6933.2720064393525, 6951.2353641099435, 4238.682098842537, 4243.257429949746, 4252.362145678111, 4268.167707297047, 4360.716553424018, 1816.0465755478479, 1831.7252412138018, 1832.7709036370454, 1844.8893066416058, 1865.225931238548, 799.3924617290785, 871.3464901324007, 891.5675897189858, 921.295209164976, 952.1620973543376, 15974.086348844607, 16036.679266414607, 17082.145892705565, 17494.57348868526, 17687.115644217738, 846.7121178799238, 846.7375113714768, 852.7868032991752, 854.3080105114877, 872.1017352127319, 9198.49408282551, 9235.630574776933, 9900.356476829127, 9970.302078854556, 10054.849177262347, 362951.0, 364005.0, 364813.0, 366175.0, 367696.0, 49457.50542494601, 49849.0, 81765.59117204376, 82824.58587707023, 83093.58453207696, 894.7941973346167, 915.697819719491, 934.4019827310527, 937.3438592984802, 943.2831048403126, 15117.16855572954, 15177.392904283704, 15686.843131568994, 15919.0, 16019.759703604688, 34310.08364288964, 35626.64373356337, 36493.45259821158, 38067.80966095152, 39540.2091958165, 48416.27375589439, 51491.227631586306, 52181.21728174156, 52555.27002569787, 53199.0, 5604.047311957059, 6730.764423245163, 6795.3204679531655, 6894.655267236518, 7625.923740762521, 8892.599833007402, 11835.940820296188, 11974.70063248391, 12006.75986480248, 12662.176958497668, 9713.9028609713, 9834.311598188058, 9963.850542241727, 10217.33587316822, 11014.889851101387, 9727.07592778685, 9807.460589667637, 9892.554835032297, 10057.145142662663, 10180.796384072426, 10627.202959777893, 10761.730956726144, 10798.892011080103, 10995.230333876552, 11108.0, 6895.724171033103, 6962.756303529352, 6985.895211571728, 7142.214356420894, 7256.310650488195, 8950.462972221687, 10265.692029239135, 10279.434631095062, 10392.0, 10436.791264174826], "value": 7991.952265107837, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1158.5713286084151, 1342.5703774792064, 1396.3995481942763, 1439.6544829240986, 1670.766092747015, 6922.342377474139, 7632.961835190823, 7889.329407000405, 7891.0530736311575, 8051.91948080519, 7976.042874855011, 8055.959720201406, 8064.153263907293, 8064.637091330889, 8069.919300806991, 2183.0612836480345, 2215.1139544182374, 2218.7559368469456, 2221.4113259986116, 2224.5106076663187, 2134.7331583552054, 2188.1575593396497, 2192.331338941622, 2215.9335219943346, 2219.7891200335944, 2148.516583768655, 2148.677698345245, 2164.6211912915255, 2169.9566008679894, 2198.0987795004053, 2146.1415433826514, 2152.461884528868, 2152.5910077085305, 2155.4180371299817, 2155.8490905636613, 2118.7245658064508, 2134.103676455892, 2138.4119367173994, 2138.8395870309632, 2139.711138996231, 7718.266764657348, 7875.291223789829, 7927.3658107351275, 7937.087234967995, 7941.801454963615, 4450.866474005785, 4648.930266046012, 4650.697704649221, 4652.418447694038, 4664.440267167927, 2755.779537636984, 2847.8433686147255, 2890.2051935717636, 2900.9846553706243, 2911.839848808315, 926.754410081329, 939.4222553129845, 949.7910459698855, 955.8327292723815, 964.9469279189642, 10652.573897044109, 10684.305520141166, 10696.197785166143, 10778.784424311549, 10810.135189184846, 4018.0758425562285, 4160.2303573838935, 4162.250794856895, 4264.808083636244, 4476.194285028726, 8466.74599762008, 8509.531975741394, 8548.743537693756, 8557.700480483154, 8569.571521423904, 4701.200795864711, 4710.175719249186, 4737.6683632146105, 4737.692050016738, 4750.429948406213, 3753.9061523462133, 3848.9615103848605, 4181.184668989578, 4415.337699345059, 4419.204543182193, 3386.7967921924765, 3387.0516255448515, 3534.505169276303, 3542.433210686278, 3561.786292822439, 1040.5941682743735, 1078.3799315393524, 1087.4127970895627, 1089.4008295437477, 1090.51472094917, 754.528419737664, 758.8861670749432, 778.6029125146216, 779.9649015794303, 786.6145588661515, 4714.764261786897, 4793.041391721669, 4832.589229915427, 4931.926021109686, 4935.185694360463, 391.0, 403.2157453752482, 406.2829106626806, 413.981370838307, 415.4433059699956, 3156.731677807412, 3173.3494633600517, 3219.8229097399867, 3286.0, 3394.253264281854, 9322.766930826649, 9885.901140988643, 9920.0, 9942.105210531086, 9949.154321882575, 9654.903450965541, 9924.652637157666, 9956.800863982824, 9961.157185920629, 10005.44970026641, 7309.342159205591, 7483.214262502468, 7553.093628764584, 7553.169151393342, 7573.2805383488485, 4671.0, 4699.718016918996, 4753.382060332135, 4823.927641085456, 5010.423801262901, 8950.194482496607, 9086.90913090887, 9144.177024067865, 9169.954150229207, 9225.677101301422, 9208.079192080739, 9349.859752103588, 9361.344705870524, 9453.763655908657, 9517.52412379392, 6285.402886725754, 6294.213223347082, 6385.457236134795, 6393.552451328363, 6460.612363258219, 7542.057242844645, 7574.280443357872, 7618.085829700472, 7620.314171724572, 7623.123340815877, 6636.568623039487, 6833.555818871758, 6886.0, 6896.27589103137, 6967.338102880219, 6672.032555279555, 6686.465082793267, 6749.763758268437, 6766.221884483348, 6775.695093720696, 6345.079963405373, 6347.5239357047485, 6406.679666016587, 6408.967955160194, 6416.422521972858, 4186.81159347824, 4198.748075115503, 4299.161663475717, 4300.8709738707885, 4379.0585024219945, 4314.9784251078545, 4435.445569303837, 4449.666275029451, 4456.197884380843, 4458.531854155267], "value": 3996.9421457236067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.3850544318828, 284.6555667642153, 296.36873459531193, 298.2052829210155, 302.0380089415211, 4883.413990321162, 4892.070506603747, 4899.240617704261, 4910.41075070992, 4911.754412279385, 4810.975945120278, 4825.155597770385, 4844.781984810683, 4854.524192661742, 4863.878403039926, 3585.45825295123, 3703.9258615001754, 3715.702743780491, 3733.7946412947276, 3734.439834024891, 3688.3729765939856, 3717.364359681745, 3761.078535758743, 3799.297130030953, 3804.657580817726, 3779.489768881207, 3792.5259342582176, 3796.9430458543143, 3798.126430920876, 3804.809759512027, 3496.947545786815, 3718.1262403335195, 3774.2451509698035, 3786.734928555002, 3793.468914351979, 3249.6262929763143, 3251.8861839835727, 3261.9836900815344, 3264.853081611333, 3268.9019329419916, 4658.1848176568965, 4670.412059899651, 4673.953260467386, 4691.507391723888, 4711.646626503026, 4067.3288907330552, 4153.279601860756, 4192.748435093904, 4193.475815523059, 4214.894627634303, 4963.032208719301, 4971.483697472269, 4974.602031837444, 4982.750862456863, 5005.424376196747, 3534.3108093921696, 3539.3629146753574, 3548.2193917338404, 3550.7692000019915, 3558.9110272243142, 5128.615353848439, 5205.141151709963, 5254.737263136866, 5293.894122117575, 5328.866778330534, 3574.6782789549065, 3600.4419315006216, 3602.7838329700303, 3607.8196090195383, 3611.995342584838, 3653.689436397936, 3664.358737220976, 3673.853045878135, 3677.5770786359913, 3686.4286035664513, 4230.978845105817, 4243.108947121077, 4245.97877010613, 4249.192653395845, 4252.831056161318, 4900.785324620823, 4929.137400954819, 5008.6744361616375, 5014.373203349582, 5050.6464547482055, 1251.4118364368733, 1252.8684488128797, 1258.6098309524077, 1267.7781388257017, 1270.8625779926913, 769.4344656677449, 800.3077338102615, 806.7737039699624, 808.5472135604081, 810.8824220487996, 4260.701750877409, 4309.547497512779, 4380.255356589388, 4419.18245124653, 4463.174312752151, 5156.974215128976, 5160.277561141444, 5183.45573714762, 5188.688678679291, 5190.325257716473, 4461.754603496774, 4474.753888536096, 4480.171168333869, 4493.820247190076, 4498.460184777848, 2612.2832254455534, 2725.4004119093765, 2748.230495461274, 2749.66641179028, 2753.2841461219828, 4902.313676085351, 4909.926351104737, 4915.655904086751, 4924.113659541317, 4924.384451943507, 5058.418281897629, 5260.263563101169, 5281.656692314988, 5282.2340760589495, 5287.9735601321745, 4902.534259245366, 4903.485134060872, 4904.239842824297, 4908.159440209921, 4916.311716359784, 5181.35233095863, 5182.196759502283, 5189.532942035235, 5192.740362981911, 5196.376434827845, 4939.407271127488, 4998.650094493496, 5069.214271787879, 5083.491650834887, 5087.38795455231, 4867.63492738039, 4910.975445122752, 4923.606111510999, 4926.556609905126, 4939.135651261086, 3617.113807117273, 3620.873269435557, 3632.6024823616285, 3647.8176091195865, 3648.7810731356203, 4944.860013891133, 5205.245239440184, 5208.697825543614, 5213.348331458567, 5239.738013099406, 5006.449290578106, 5012.573931215888, 5028.74856257193, 5035.194368900959, 5052.494750524918, 4993.5755460784785, 5005.824796132118, 5012.924806127984, 5037.848864534069, 5057.140286151437, 4691.976540117277, 4966.850994470172, 4970.663788019625, 4991.151504244214, 5010.9248361273885, 4851.611871050237, 4983.6760610560195, 5053.140966035856, 5060.493950605058, 5086.3896332440345, 4789.611012806247, 4935.210366341368, 4949.455559888337, 4957.429895561912, 4961.330220420197], "value": 3773.276615280902, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.7274617406863, 687.0175648822185, 696.2967402923047, 707.7912015955293, 762.6301243896709, 12800.871991280084, 13878.861211387895, 13950.79073813891, 13960.162390256592, 13983.720325593482, 13362.866371336308, 13520.526781562647, 13533.052686311961, 13537.323133843318, 13555.11891727037, 608.3976862905736, 621.0901029991062, 749.8875168724694, 753.7663324369463, 766.5400759544257, 766.3868904876077, 782.9960850195741, 783.3889566138421, 785.6700185921926, 786.1273985875673, 819.3608984991716, 819.397742659145, 824.7195953375851, 825.0429501777938, 825.0923983618002, 642.0497663458061, 661.1009027722293, 787.3779714025912, 816.4978538199024, 816.5713000674634, 583.1486030395628, 596.8418369132183, 597.0804960361039, 597.1520440973827, 597.8176656119882, 13723.725525489433, 13775.242361670103, 13783.793243101361, 13785.241811700353, 13803.51687690936, 12831.74336513274, 13220.6694832629, 13462.663433414145, 13542.59372218835, 13753.174809511462, 12343.259404435763, 12448.0, 12512.249265044036, 12688.619341419771, 12726.172798768142, 4182.226288136704, 4196.489263865006, 4217.725847819913, 4273.4444522212225, 4288.828446862121, 65541.344586554, 65919.0, 66510.66744666245, 67074.66462667656, 67089.32910670928, 10511.316764410289, 10537.315074520131, 10599.417032063157, 10660.733481663021, 10746.408947507962, 17181.7422738659, 17825.554361140817, 19855.205791768458, 19855.404337869888, 19979.60040799176, 6921.411680007256, 7075.433965282765, 7149.320814522716, 7272.963635181896, 7314.232005639331, 3774.857760780168, 3808.143167787281, 3871.8644847430205, 3917.8628747993685, 3942.152437225953, 2896.348321627659, 2995.610570625848, 3011.1719277198945, 3023.0779612218485, 3024.4555979923384, 508.654115201659, 509.95155460231217, 516.3906590223497, 521.2546059135396, 522.725569076238, 530.8089087928342, 589.799468180812, 612.041467304627, 619.1424876545926, 620.0915658560141, 8352.64970813578, 8519.105493923049, 8608.0, 8728.781780455412, 8834.337424693174, 444.6398417282012, 484.7866938547028, 537.2934591012805, 538.692945021334, 581.3140494216865, 3873.573906870242, 4152.6055024772595, 4235.8093885775215, 4265.87202383929, 4343.869683909487, 58387.0, 59905.70047149823, 91793.0, 94334.05665943252, 106263.0, 66346.0, 66418.0, 67390.66304668445, 91762.0, 97399.51300243453, 44508.55491445044, 59766.402335976956, 60396.69801650964, 69034.0, 74674.25325746673, 7735.613219339123, 7980.644517609591, 8033.731916884763, 8159.34725221969, 8258.545779982158, 41643.7917810409, 42450.78774606107, 43283.35074973941, 43660.0, 43693.56306436895, 58470.0, 63066.36933630605, 64596.67701661649, 65554.0, 68192.31807682058, 11214.55141794319, 11609.482934398158, 11653.53385864556, 11731.824022639497, 11948.462319195483, 12920.741585168433, 13181.868181318065, 13209.207447553177, 13461.461541538229, 14057.226852522801, 10794.0, 11551.191416600757, 11624.6512604622, 11954.940225299166, 13328.600141995756, 12556.928106862266, 12830.166039207796, 13168.078234523875, 13587.116837405538, 13607.387667554785, 12033.4584943676, 12526.123171377916, 12675.429605667583, 12994.610161695164, 13001.15492492985, 9511.0, 9641.886934623311, 9648.614055437703, 9912.15746661542, 10394.636187733393, 9074.863877041718, 9682.322237443312, 9765.169960553432, 9771.267154963549, 9885.752856178366], "value": 6644.6119508159845, "unit": "score"}], "name": "dromaeo_css", "value": 6325.1418574716645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 115.0, 114.0, 116.0, 113.0, 114.0, 112.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 127.0, 164.0, 125.0, 131.0, 131.0, 131.0, 162.0, 135.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 115.0, 77.0, 78.0, 78.0, 78.0, 99.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 129.0, 84.0, 83.0, 83.0, 114.0, 83.0, 83.0, 116.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 63.0, 62.0, 61.0, 63.0, 65.0, 63.0, 65.0, 63.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 83.0, 82.0, 89.0, 83.0, 83.0, 91.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 138.0, 140.0, 132.0, 133.0, 133.0, 131.0, 172.0, 138.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 173.0, 171.0, 175.0, 177.0, 170.0, 175.0, 173.0, 170.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 67.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1544.9999999999998, "alertThreshold": 2.0}]} 05:04:54 INFO - Return code: 0 05:04:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:54 INFO - # TBPL SUCCESS # 05:04:54 INFO - Running post-action listener: _resource_record_post_action 05:04:54 INFO - [mozharness: 2016-09-23 12:04:54.212751Z] Finished run-tests step (success) 05:04:54 INFO - Running post-run listener: _resource_record_post_run 05:04:54 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400117760; Read time: 12; Write time: 296500 05:04:54 INFO - TinderboxPrint: CPU usage
13.0% 05:04:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:04:54 INFO - TinderboxPrint: I/O write bytes / time
400,117,760 / 296,500 05:04:54 INFO - TinderboxPrint: CPU idle
8,354.2 (87.0%) 05:04:54 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 05:04:54 INFO - TinderboxPrint: Swap in / out
0 / 0 05:04:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99893248; Read time: 0; Write time: 85672 05:04:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 288464896; Read time: 0; Write time: 208848 05:04:54 INFO - Running post-run listener: _upload_blobber_files 05:04:54 INFO - Blob upload gear active. 05:04:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:54 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 05:04:54 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'] 05:04:54 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 05:04:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:04:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:55 INFO - (blobuploader) - INFO - Done attempting. 05:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:59 INFO - (blobuploader) - INFO - Done attempting. 05:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:00 INFO - (blobuploader) - INFO - Done attempting. 05:05:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:00 INFO - Return code: 0 05:05:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e18d526ede506e510292748a9f16d270ac98cfb8517e485b3adcd3a3e44f288ca2aa3f32dc269ab22a7ad5f1c70fc9ec13db77b358fdca10b361260629a9254f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0866406a2a87510794acd31779bed8add1181a29fe0ae3909dd26726ee241f3fc72af2c03e0a7a64d3d3d2ea9fc305918a548ec0a02979ba68a904a1dd094f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7473495a5d69bc051ef1d8bdf50ef7100a29bf331a41f14abce8055efdc7c7c9f4c2ba41316adfe5f3ce8bbdc192b5c848983629dee8f0ac82b5799cd5afd818"} 05:05:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:00 INFO - Contents: 05:05:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e18d526ede506e510292748a9f16d270ac98cfb8517e485b3adcd3a3e44f288ca2aa3f32dc269ab22a7ad5f1c70fc9ec13db77b358fdca10b361260629a9254f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0866406a2a87510794acd31779bed8add1181a29fe0ae3909dd26726ee241f3fc72af2c03e0a7a64d3d3d2ea9fc305918a548ec0a02979ba68a904a1dd094f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7473495a5d69bc051ef1d8bdf50ef7100a29bf331a41f14abce8055efdc7c7c9f4c2ba41316adfe5f3ce8bbdc192b5c848983629dee8f0ac82b5799cd5afd818"} 05:05:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:00 INFO - Copying logs to upload dir... 05:05:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.588231 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-23 05:05:00.144555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 05:05:00.148032) ========= 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=920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902 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/e18d526ede506e510292748a9f16d270ac98cfb8517e485b3adcd3a3e44f288ca2aa3f32dc269ab22a7ad5f1c70fc9ec13db77b358fdca10b361260629a9254f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0866406a2a87510794acd31779bed8add1181a29fe0ae3909dd26726ee241f3fc72af2c03e0a7a64d3d3d2ea9fc305918a548ec0a02979ba68a904a1dd094f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7473495a5d69bc051ef1d8bdf50ef7100a29bf331a41f14abce8055efdc7c7c9f4c2ba41316adfe5f3ce8bbdc192b5c848983629dee8f0ac82b5799cd5afd818"} build_url:https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/T-Tob-GLRDu5GpYTOaORiw/artifacts/public/build/firefox-52.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/e18d526ede506e510292748a9f16d270ac98cfb8517e485b3adcd3a3e44f288ca2aa3f32dc269ab22a7ad5f1c70fc9ec13db77b358fdca10b361260629a9254f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0866406a2a87510794acd31779bed8add1181a29fe0ae3909dd26726ee241f3fc72af2c03e0a7a64d3d3d2ea9fc305918a548ec0a02979ba68a904a1dd094f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7473495a5d69bc051ef1d8bdf50ef7100a29bf331a41f14abce8055efdc7c7c9f4c2ba41316adfe5f3ce8bbdc192b5c848983629dee8f0ac82b5799cd5afd818"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 05:05:00.172870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:05:00.173158) ========= 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=920470bf432669ad7e3a5387000001ca-1474630856.87504-646007902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:05:00.255608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 05:05:00.256029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 05:05:00.256337) ========= ========= Total master_lag: 0.16 =========