builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1477409355.16 results: success (0) buildid: 20161025053821 builduid: 15945fb1427e4c3b947a1af998ff7105 revision: 1280f78d221d4c1e146443ee18f99b37f5e520fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.161882) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.162571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.163080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.180714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.181062) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 08:29:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-10-25 08:29:16 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.287621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.287973) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015334 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.338060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.338471) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1280f78d221d4c1e146443ee18f99b37f5e520fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1280f78d221d4c1e146443ee18f99b37f5e520fd --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=a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 08:29:16,193 truncating revision to first 12 chars 2016-10-25 08:29:16,193 Setting DEBUG logging. 2016-10-25 08:29:16,193 attempt 1/10 2016-10-25 08:29:16,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1280f78d221d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 08:29:16,492 unpacking tar archive at: mozilla-aurora-1280f78d221d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.980509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.980870) ========= script_repo_revision: 1280f78d221d4c1e146443ee18f99b37f5e520fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.981311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.981633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 08:29:15.992643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-25 08:29:15.993200) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:16 INFO - MultiFileLogger online at 20161025 08:29:16 in /builds/slave/test 08:29:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:29:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:16 INFO - {'append_to_log': False, 08:29:16 INFO - 'base_work_dir': '/builds/slave/test', 08:29:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:29:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:16 INFO - 'branch': 'Mozilla-Aurora', 08:29:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:16 INFO - 'config_files': ('talos/linux_config.py',), 08:29:16 INFO - 'default_actions': ('clobber', 08:29:16 INFO - 'read-buildbot-config', 08:29:16 INFO - 'download-and-extract', 08:29:16 INFO - 'populate-webroot', 08:29:16 INFO - 'create-virtualenv', 08:29:16 INFO - 'install', 08:29:16 INFO - 'run-tests'), 08:29:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:16 INFO - 'download_minidump_stackwalk': True, 08:29:16 INFO - 'download_symbols': 'ondemand', 08:29:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:16 INFO - 'installer_path': 'installer.exe', 08:29:16 INFO - 'log_level': 'info', 08:29:16 INFO - 'log_name': 'talos', 08:29:16 INFO - 'log_to_console': True, 08:29:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:16 INFO - 'opt_config_files': (), 08:29:16 INFO - 'pip_index': False, 08:29:16 INFO - 'sps_profile': False, 08:29:16 INFO - 'sps_profile_interval': 0, 08:29:16 INFO - 'suite': 'dromaeojs', 08:29:16 INFO - 'system_bits': '32', 08:29:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:16 INFO - 'title': 'talos-linux64-ix-062', 08:29:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:16 INFO - 'use_talos_json': True, 08:29:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:16 INFO - 'work_dir': 'build'} 08:29:16 INFO - [mozharness: 2016-10-25 15:29:16.945546Z] Running clobber step. 08:29:16 INFO - Running pre-action listener: _resource_record_pre_action 08:29:16 INFO - Running main action method: clobber 08:29:16 INFO - rmtree: /builds/slave/test/build 08:29:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:17 INFO - Running post-action listener: _resource_record_post_action 08:29:17 INFO - [mozharness: 2016-10-25 15:29:17.931614Z] Finished clobber step (success) 08:29:17 INFO - [mozharness: 2016-10-25 15:29:17.931713Z] Running read-buildbot-config step. 08:29:17 INFO - Running pre-action listener: _resource_record_pre_action 08:29:17 INFO - Running main action method: read_buildbot_config 08:29:17 INFO - Using buildbot properties: 08:29:17 INFO - { 08:29:17 INFO - "project": "", 08:29:17 INFO - "product": "firefox", 08:29:17 INFO - "script_repo_revision": "production", 08:29:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:29:17 INFO - "repository": "", 08:29:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:29:17 INFO - "buildid": "20161025053821", 08:29:17 INFO - "pgo_build": "True", 08:29:17 INFO - "basedir": "/builds/slave/test", 08:29:17 INFO - "buildnumber": 589, 08:29:17 INFO - "slavename": "talos-linux64-ix-062", 08:29:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:29:17 INFO - "platform": "ubuntu64_hw", 08:29:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:29:17 INFO - "branch": "mozilla-aurora", 08:29:17 INFO - "repo_path": "releases/mozilla-aurora", 08:29:17 INFO - "revision": "1280f78d221d4c1e146443ee18f99b37f5e520fd", 08:29:17 INFO - "stage_platform": "linux64-pgo", 08:29:17 INFO - "builduid": "15945fb1427e4c3b947a1af998ff7105", 08:29:17 INFO - "slavebuilddir": "test" 08:29:17 INFO - } 08:29:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 08:29:17 INFO - Running post-action listener: _resource_record_post_action 08:29:17 INFO - [mozharness: 2016-10-25 15:29:17.934168Z] Finished read-buildbot-config step (success) 08:29:17 INFO - [mozharness: 2016-10-25 15:29:17.934259Z] Running download-and-extract step. 08:29:17 INFO - Running pre-action listener: _resource_record_pre_action 08:29:17 INFO - Running main action method: download_and_extract 08:29:17 INFO - mkdir: /builds/slave/test/build/tests 08:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:17 INFO - trying https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:29:17 INFO - Downloading https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:29:18 INFO - Downloaded 1361 bytes. 08:29:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 08:29:18 INFO - Using the following test package requirements: 08:29:18 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 08:29:18 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:29:18 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:29:18 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'jsshell-linux-x86_64.zip'], 08:29:18 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:29:18 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 08:29:18 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:29:18 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:29:18 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:29:18 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 08:29:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:29:18 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:29:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 08:29:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:29:18 INFO - Fetch https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:29:19 INFO - Expected file size: 21910387 08:29:23 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:29:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 08:29:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:29:23 INFO - Fetch https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:29:24 INFO - Expected file size: 21910387 08:29:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 08:29:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:29:28 INFO - Fetch https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:29:29 INFO - Expected file size: 14414081 08:29: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')]} 08:29:29 INFO - trying https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:29:29 INFO - Downloading https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:29:30 INFO - Downloaded 64004241 bytes. 08:29:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:29:30 INFO - mkdir: /builds/slave/test/properties 08:29:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:30 INFO - Contents: 08:29:30 INFO - build_url:https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 08:29:31 INFO - Running post-action listener: _resource_record_post_action 08:29:31 INFO - Running post-action listener: set_extra_try_arguments 08:29:31 INFO - [mozharness: 2016-10-25 15:29:31.661886Z] Finished download-and-extract step (success) 08:29:31 INFO - [mozharness: 2016-10-25 15:29:31.662113Z] Running populate-webroot step. 08:29:31 INFO - Running pre-action listener: _resource_record_pre_action 08:29:31 INFO - Running main action method: populate_webroot 08:29:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:31 INFO - '--tppagecycles', 08:29:31 INFO - '7'], 08:29:31 INFO - 'tests': ['tsvgm']}}, 08:29:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['damp', 'tps']}, 08:29:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'tests': ['damp', 'tps']}, 08:29:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['dromaeo_dom']}, 08:29:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['basic_compositor_video']}, 08:29:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:29:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['a11yr', 08:29:31 INFO - 'ts_paint', 08:29:31 INFO - 'tpaint', 08:29:31 INFO - 'sessionrestore', 08:29:31 INFO - 'sessionrestore_no_auto_restore', 08:29:31 INFO - 'tabpaint']}, 08:29:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:31 INFO - 'ts_paint', 08:29:31 INFO - 'tpaint', 08:29:31 INFO - 'sessionrestore', 08:29:31 INFO - 'sessionrestore_no_auto_restore', 08:29:31 INFO - 'tabpaint']}, 08:29:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:31 INFO - 'ts_paint', 08:29:31 INFO - 'tpaint', 08:29:31 INFO - 'sessionrestore', 08:29:31 INFO - 'sessionrestore_no_auto_restore', 08:29:31 INFO - 'tabpaint']}, 08:29:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:31 INFO - 'ts_paint', 08:29:31 INFO - 'tpaint', 08:29:31 INFO - 'sessionrestore', 08:29:31 INFO - 'sessionrestore_no_auto_restore', 08:29:31 INFO - 'tabpaint']}, 08:29:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['a11yr', 08:29:31 INFO - 'ts_paint', 08:29:31 INFO - 'tpaint', 08:29:31 INFO - 'sessionrestore', 08:29:31 INFO - 'sessionrestore_no_auto_restore', 08:29:31 INFO - 'tabpaint']}, 08:29:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['a11yr', 08:29:31 INFO - 'ts_paint', 08:29:31 INFO - 'tpaint', 08:29:31 INFO - 'sessionrestore', 08:29:31 INFO - 'sessionrestore_no_auto_restore', 08:29:31 INFO - 'tabpaint']}, 08:29:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['tsvgx', 08:29:31 INFO - 'tsvgr_opacity', 08:29:31 INFO - 'tart', 08:29:31 INFO - 'tscrollx', 08:29:31 INFO - 'cart']}, 08:29:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:31 INFO - 'tsvgr_opacity', 08:29:31 INFO - 'tart', 08:29:31 INFO - 'tscrollx', 08:29:31 INFO - 'cart']}, 08:29:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'talos_options': ['--disable-e10s'], 08:29:31 INFO - 'tests': ['tp5o']}, 08:29:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'tests': ['tp5o']}, 08:29:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'talos_options': ['--disable-e10s', 08:29:31 INFO - '--xperf_path', 08:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:31 INFO - 'tests': ['tp5n']}, 08:29:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:31 INFO - 'talos_options': ['--xperf_path', 08:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:31 INFO - 'tests': ['tp5n']}}, 08:29:31 INFO - 'talos.zip': {'path': '', 08:29:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:31 INFO - Running post-action listener: _resource_record_post_action 08:29:31 INFO - [mozharness: 2016-10-25 15:29:31.684791Z] Finished populate-webroot step (success) 08:29:31 INFO - [mozharness: 2016-10-25 15:29:31.684880Z] Running create-virtualenv step. 08:29:31 INFO - Running pre-action listener: _resource_record_pre_action 08:29:31 INFO - Running main action method: create_virtualenv 08:29:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:31 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 08:29:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:31 INFO - Using real prefix '/usr' 08:29:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:34 INFO - Installing pip.................done. 08:29:34 INFO - Return code: 0 08:29:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:29:34 INFO - Using env: {'DISPLAY': ':0', 08:29:34 INFO - 'HOME': '/home/cltbld', 08:29:34 INFO - 'LANG': 'en_US.UTF-8', 08:29:34 INFO - 'LANGUAGE': 'en_US:en', 08:29:34 INFO - 'LOGNAME': 'cltbld', 08:29:34 INFO - 'MAIL': '/var/mail/cltbld', 08:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:34 INFO - 'MOZ_NO_REMOTE': '1', 08:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:34 INFO - 'NO_EM_RESTART': '1', 08:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:34 INFO - 'PWD': '/builds/slave/test', 08:29:34 INFO - 'SHELL': '/bin/bash', 08:29:34 INFO - 'SHLVL': '1', 08:29:34 INFO - 'TERM': 'linux', 08:29:34 INFO - 'TMOUT': '86400', 08:29:34 INFO - 'USER': 'cltbld', 08:29:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:34 INFO - '_': '/tools/buildbot/bin/python'} 08:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:34 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 08:29:34 INFO - Cleaning up... 08:29:34 INFO - Return code: 0 08:29:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:29:34 INFO - Using env: {'DISPLAY': ':0', 08:29:34 INFO - 'HOME': '/home/cltbld', 08:29:34 INFO - 'LANG': 'en_US.UTF-8', 08:29:34 INFO - 'LANGUAGE': 'en_US:en', 08:29:34 INFO - 'LOGNAME': 'cltbld', 08:29:34 INFO - 'MAIL': '/var/mail/cltbld', 08:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:34 INFO - 'MOZ_NO_REMOTE': '1', 08:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:34 INFO - 'NO_EM_RESTART': '1', 08:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:34 INFO - 'PWD': '/builds/slave/test', 08:29:34 INFO - 'SHELL': '/bin/bash', 08:29:34 INFO - 'SHLVL': '1', 08:29:34 INFO - 'TERM': 'linux', 08:29:34 INFO - 'TMOUT': '86400', 08:29:34 INFO - 'USER': 'cltbld', 08:29:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:34 INFO - '_': '/tools/buildbot/bin/python'} 08:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:34 INFO - Downloading/unpacking psutil>=3.1.1 08:29:34 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 08:29:34 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 08:29:34 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 08:29:34 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 08:29:34 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 08:29:34 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 08:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:36 INFO - Installing collected packages: psutil 08:29:36 INFO - Running setup.py install for psutil 08:29:36 INFO - building 'psutil._psutil_linux' extension 08:29:36 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 08:29:36 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 08:29:37 INFO - building 'psutil._psutil_posix' extension 08:29:37 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 08:29:37 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 08:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:37 INFO - Successfully installed psutil 08:29:37 INFO - Cleaning up... 08:29:37 INFO - Return code: 0 08:29:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:29:37 INFO - Using env: {'DISPLAY': ':0', 08:29:37 INFO - 'HOME': '/home/cltbld', 08:29:37 INFO - 'LANG': 'en_US.UTF-8', 08:29:37 INFO - 'LANGUAGE': 'en_US:en', 08:29:37 INFO - 'LOGNAME': 'cltbld', 08:29:37 INFO - 'MAIL': '/var/mail/cltbld', 08:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:37 INFO - 'MOZ_NO_REMOTE': '1', 08:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:37 INFO - 'NO_EM_RESTART': '1', 08:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:37 INFO - 'PWD': '/builds/slave/test', 08:29:37 INFO - 'SHELL': '/bin/bash', 08:29:37 INFO - 'SHLVL': '1', 08:29:37 INFO - 'TERM': 'linux', 08:29:37 INFO - 'TMOUT': '86400', 08:29:37 INFO - 'USER': 'cltbld', 08:29:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:37 INFO - '_': '/tools/buildbot/bin/python'} 08:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:39 INFO - Installing collected packages: mozsystemmonitor 08:29:39 INFO - Running setup.py install for mozsystemmonitor 08:29:39 INFO - Successfully installed mozsystemmonitor 08:29:39 INFO - Cleaning up... 08:29:39 INFO - Return code: 0 08:29:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29:39 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')]} 08:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:39 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')]} 08:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:39 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:39 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 08:29:39 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 08:29:39 INFO - Using env: {'DISPLAY': ':0', 08:29:39 INFO - 'HOME': '/home/cltbld', 08:29:39 INFO - 'LANG': 'en_US.UTF-8', 08:29:39 INFO - 'LANGUAGE': 'en_US:en', 08:29:39 INFO - 'LOGNAME': 'cltbld', 08:29:39 INFO - 'MAIL': '/var/mail/cltbld', 08:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:39 INFO - 'MOZ_NO_REMOTE': '1', 08:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:39 INFO - 'NO_EM_RESTART': '1', 08:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:39 INFO - 'PWD': '/builds/slave/test', 08:29:39 INFO - 'SHELL': '/bin/bash', 08:29:39 INFO - 'SHLVL': '1', 08:29:39 INFO - 'TERM': 'linux', 08:29:39 INFO - 'TMOUT': '86400', 08:29:39 INFO - 'USER': 'cltbld', 08:29:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:39 INFO - '_': '/tools/buildbot/bin/python'} 08:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:43 INFO - warning: no files found matching '*.txt' 08:29:43 INFO - no previously-included directories found matching 'build' 08:29:43 INFO - no previously-included directories found matching 'dist' 08:29:43 INFO - no previously-included directories found matching '.git*' 08:29:43 INFO - Installing collected packages: jsonschema, functools32 08:29:43 INFO - Running setup.py install for functools32 08:29:43 INFO - warning: no files found matching '*.txt' 08:29:43 INFO - no previously-included directories found matching 'build' 08:29:43 INFO - no previously-included directories found matching 'dist' 08:29:43 INFO - no previously-included directories found matching '.git*' 08:29:43 INFO - Successfully installed jsonschema functools32 08:29:43 INFO - Cleaning up... 08:29:43 INFO - Return code: 0 08:29:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:43 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:43 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 08:29:43 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 08:29:43 INFO - Using env: {'DISPLAY': ':0', 08:29:43 INFO - 'HOME': '/home/cltbld', 08:29:43 INFO - 'LANG': 'en_US.UTF-8', 08:29:43 INFO - 'LANGUAGE': 'en_US:en', 08:29:43 INFO - 'LOGNAME': 'cltbld', 08:29:43 INFO - 'MAIL': '/var/mail/cltbld', 08:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:43 INFO - 'MOZ_NO_REMOTE': '1', 08:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:43 INFO - 'NO_EM_RESTART': '1', 08:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:43 INFO - 'PWD': '/builds/slave/test', 08:29:43 INFO - 'SHELL': '/bin/bash', 08:29:43 INFO - 'SHLVL': '1', 08:29:43 INFO - 'TERM': 'linux', 08:29:43 INFO - 'TMOUT': '86400', 08:29:43 INFO - 'USER': 'cltbld', 08:29:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:43 INFO - '_': '/tools/buildbot/bin/python'} 08:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:29:43 INFO - Cleaning up... 08:29:43 INFO - Return code: 0 08:29:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:43 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:43 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 08:29:43 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 08:29:43 INFO - Using env: {'DISPLAY': ':0', 08:29:43 INFO - 'HOME': '/home/cltbld', 08:29:43 INFO - 'LANG': 'en_US.UTF-8', 08:29:43 INFO - 'LANGUAGE': 'en_US:en', 08:29:43 INFO - 'LOGNAME': 'cltbld', 08:29:43 INFO - 'MAIL': '/var/mail/cltbld', 08:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:43 INFO - 'MOZ_NO_REMOTE': '1', 08:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:43 INFO - 'NO_EM_RESTART': '1', 08:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:43 INFO - 'PWD': '/builds/slave/test', 08:29:43 INFO - 'SHELL': '/bin/bash', 08:29:43 INFO - 'SHLVL': '1', 08:29:43 INFO - 'TERM': 'linux', 08:29:43 INFO - 'TMOUT': '86400', 08:29:43 INFO - 'USER': 'cltbld', 08:29:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:43 INFO - '_': '/tools/buildbot/bin/python'} 08:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:43 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 08:29:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:29:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:46 INFO - Downloading docopt-0.6.1.tar.gz 08:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:46 INFO - Running setup.py install for blobuploader 08:29:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:46 INFO - Running setup.py install for requests 08:29:46 INFO - Running setup.py install for docopt 08:29:46 INFO - Successfully installed blobuploader requests docopt 08:29:46 INFO - Cleaning up... 08:29:47 INFO - Return code: 0 08:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:47 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')]} 08:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:47 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')]} 08:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:47 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:47 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 08:29:47 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 08:29:47 INFO - Using env: {'DISPLAY': ':0', 08:29:47 INFO - 'HOME': '/home/cltbld', 08:29:47 INFO - 'LANG': 'en_US.UTF-8', 08:29:47 INFO - 'LANGUAGE': 'en_US:en', 08:29:47 INFO - 'LOGNAME': 'cltbld', 08:29:47 INFO - 'MAIL': '/var/mail/cltbld', 08:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:47 INFO - 'MOZ_NO_REMOTE': '1', 08:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:47 INFO - 'NO_EM_RESTART': '1', 08:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:47 INFO - 'PWD': '/builds/slave/test', 08:29:47 INFO - 'SHELL': '/bin/bash', 08:29:47 INFO - 'SHLVL': '1', 08:29:47 INFO - 'TERM': 'linux', 08:29:47 INFO - 'TMOUT': '86400', 08:29:47 INFO - 'USER': 'cltbld', 08:29:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:47 INFO - '_': '/tools/buildbot/bin/python'} 08:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:47 INFO - Running setup.py (path:/tmp/pip-wzTNAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:47 INFO - Running setup.py (path:/tmp/pip-dUp2fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:47 INFO - Running setup.py (path:/tmp/pip-5CjJQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:47 INFO - Running setup.py (path:/tmp/pip-2Hfv5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:47 INFO - Running setup.py (path:/tmp/pip-rcSDQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:47 INFO - Running setup.py (path:/tmp/pip-J5ijvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:47 INFO - Running setup.py (path:/tmp/pip-_w9Kxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:47 INFO - Running setup.py (path:/tmp/pip-WJ41Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:47 INFO - Running setup.py (path:/tmp/pip-b_mGWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:47 INFO - Running setup.py (path:/tmp/pip-crAJ9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:48 INFO - Running setup.py (path:/tmp/pip-DBYFye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:48 INFO - Running setup.py (path:/tmp/pip-gidAKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:48 INFO - Running setup.py (path:/tmp/pip-urj51I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:48 INFO - Running setup.py (path:/tmp/pip-xdm2LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:48 INFO - Running setup.py (path:/tmp/pip-dE9hK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:48 INFO - Running setup.py (path:/tmp/pip-qZ8ylF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:48 INFO - Running setup.py (path:/tmp/pip-RSgdYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:48 INFO - Running setup.py install for manifestparser 08:29:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:48 INFO - Running setup.py install for mozcrash 08:29:48 INFO - Running setup.py install for mozdebug 08:29:48 INFO - Running setup.py install for mozdevice 08:29:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:29:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:48 INFO - Running setup.py install for mozfile 08:29:49 INFO - Running setup.py install for mozhttpd 08:29:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Running setup.py install for mozinfo 08:29:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Running setup.py install for mozInstall 08:29:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Running setup.py install for mozleak 08:29:49 INFO - Running setup.py install for mozlog 08:29:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Running setup.py install for moznetwork 08:29:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Running setup.py install for mozprocess 08:29:49 INFO - Running setup.py install for mozprofile 08:29:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:49 INFO - Running setup.py install for mozrunner 08:29:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:50 INFO - Running setup.py install for mozscreenshot 08:29:50 INFO - Running setup.py install for moztest 08:29:50 INFO - Running setup.py install for mozversion 08:29:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:50 INFO - Cleaning up... 08:29:50 INFO - Return code: 0 08:29:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:50 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:50 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 08:29:50 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 08:29:50 INFO - Using env: {'DISPLAY': ':0', 08:29:50 INFO - 'HOME': '/home/cltbld', 08:29:50 INFO - 'LANG': 'en_US.UTF-8', 08:29:50 INFO - 'LANGUAGE': 'en_US:en', 08:29:50 INFO - 'LOGNAME': 'cltbld', 08:29:50 INFO - 'MAIL': '/var/mail/cltbld', 08:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:50 INFO - 'MOZ_NO_REMOTE': '1', 08:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:50 INFO - 'NO_EM_RESTART': '1', 08:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:50 INFO - 'PWD': '/builds/slave/test', 08:29:50 INFO - 'SHELL': '/bin/bash', 08:29:50 INFO - 'SHLVL': '1', 08:29:50 INFO - 'TERM': 'linux', 08:29:50 INFO - 'TMOUT': '86400', 08:29:50 INFO - 'USER': 'cltbld', 08:29:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:50 INFO - '_': '/tools/buildbot/bin/python'} 08:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:50 INFO - Running setup.py (path:/tmp/pip-OoQVkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:50 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)) 08:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:50 INFO - Running setup.py (path:/tmp/pip-GTK6Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:50 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)) 08:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:50 INFO - Running setup.py (path:/tmp/pip-qH9Pp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:50 INFO - Running setup.py (path:/tmp/pip-G8qdRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:50 INFO - Running setup.py (path:/tmp/pip-2yns4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:50 INFO - Running setup.py (path:/tmp/pip-D68VCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:51 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)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:51 INFO - Running setup.py (path:/tmp/pip-CLe2qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:51 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)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:51 INFO - Running setup.py (path:/tmp/pip-VIaMmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:51 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)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:51 INFO - Running setup.py (path:/tmp/pip-HRiRPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:51 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)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:51 INFO - Running setup.py (path:/tmp/pip-Ma0mqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:51 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)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:51 INFO - Running setup.py (path:/tmp/pip-Y7_QjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:51 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)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:51 INFO - Running setup.py (path:/tmp/pip-PYFZ3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:51 INFO - Running setup.py (path:/tmp/pip-GWuMw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:51 INFO - Running setup.py (path:/tmp/pip-Q6VPrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:51 INFO - Running setup.py (path:/tmp/pip-KNkWvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:51 INFO - Running setup.py (path:/tmp/pip-HGa2Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:51 INFO - Running setup.py (path:/tmp/pip-prPHeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:29:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:53 INFO - Downloading blessings-1.6.tar.gz 08:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:54 INFO - Installing collected packages: blessings 08:29:54 INFO - Running setup.py install for blessings 08:29:54 INFO - Successfully installed blessings 08:29:54 INFO - Cleaning up... 08:29:54 INFO - Return code: 0 08:29:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:54 INFO - Reading from file tmpfile_stdout 08:29:54 INFO - Current package versions: 08:29:54 INFO - argparse == 1.2.1 08:29:54 INFO - blessings == 1.6 08:29:54 INFO - blobuploader == 1.2.4 08:29:54 INFO - docopt == 0.6.1 08:29:54 INFO - functools32 == 3.2.3-2 08:29:54 INFO - jsonschema == 2.5.1 08:29:54 INFO - manifestparser == 1.1 08:29:54 INFO - mozInstall == 1.12 08:29:54 INFO - mozcrash == 0.17 08:29:54 INFO - mozdebug == 0.1 08:29:54 INFO - mozdevice == 0.48 08:29:54 INFO - mozfile == 1.2 08:29:54 INFO - mozhttpd == 0.7 08:29:54 INFO - mozinfo == 0.9 08:29:54 INFO - mozleak == 0.1 08:29:54 INFO - mozlog == 3.4 08:29:54 INFO - moznetwork == 0.27 08:29:54 INFO - mozprocess == 0.23 08:29:54 INFO - mozprofile == 0.28 08:29:54 INFO - mozrunner == 6.12 08:29:54 INFO - mozscreenshot == 0.1 08:29:54 INFO - mozsystemmonitor == 0.3 08:29:54 INFO - moztest == 0.7 08:29:54 INFO - mozversion == 1.4 08:29:54 INFO - psutil == 3.1.1 08:29:54 INFO - requests == 1.2.3 08:29:54 INFO - wsgiref == 0.1.2 08:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:54 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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:54 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 08:29:54 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 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 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)) 08:29:54 INFO - Cleaning up... 08:29:54 INFO - Return code: 0 08:29:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:54 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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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 0x7fbac8a04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d48e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', '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 08:29:54 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 08:29:54 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 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:54 INFO - Cleaning up... 08:29:54 INFO - Return code: 0 08:29:54 INFO - Running post-action listener: _resource_record_post_action 08:29:54 INFO - Running post-action listener: _start_resource_monitoring 08:29:54 INFO - Starting resource monitoring. 08:29:54 INFO - [mozharness: 2016-10-25 15:29:54.946379Z] Finished create-virtualenv step (success) 08:29:54 INFO - [mozharness: 2016-10-25 15:29:54.946964Z] Running install step. 08:29:54 INFO - Running pre-action listener: _resource_record_pre_action 08:29:54 INFO - Running main action method: install 08:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:55 INFO - Reading from file tmpfile_stdout 08:29:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:55 INFO - Reading from file tmpfile_stdout 08:29:55 INFO - Output received: 08:29:55 INFO - Usage: mozinstall [options] installer 08:29:55 INFO - Options: 08:29:55 INFO - -h, --help show this help message and exit 08:29:55 INFO - -d DEST, --destination=DEST 08:29:55 INFO - Directory to install application into. [default: 08:29:55 INFO - "/builds/slave/test"] 08:29:55 INFO - --app=APP Application being installed. [default: firefox] 08:29:55 INFO - mkdir: /builds/slave/test/build/application 08:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:30:11 INFO - Reading from file tmpfile_stdout 08:30:11 INFO - Output received: 08:30:11 INFO - /builds/slave/test/build/application/firefox/firefox 08:30:11 INFO - Running post-action listener: _resource_record_post_action 08:30:11 INFO - [mozharness: 2016-10-25 15:30:11.235195Z] Finished install step (success) 08:30:11 INFO - [mozharness: 2016-10-25 15:30:11.235524Z] Running run-tests step. 08:30:11 INFO - Running pre-action listener: _resource_record_pre_action 08:30:11 INFO - Running main action method: run_tests 08:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:30:11 INFO - Python 2.7.3 08:30:11 INFO - Return code: 0 08:30:11 INFO - grabbing minidump binary from tooltool 08:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:11 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 0x256d100>, '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 0x25649d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2564e60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:30:11 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 08:30:11 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 08:30:11 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 08:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:11 INFO - Return code: 0 08:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 08:30:11 INFO - Using env: {'DISPLAY': ':0', 08:30:11 INFO - 'HOME': '/home/cltbld', 08:30:11 INFO - 'LANG': 'en_US.UTF-8', 08:30:11 INFO - 'LANGUAGE': 'en_US:en', 08:30:11 INFO - 'LOGNAME': 'cltbld', 08:30:11 INFO - 'MAIL': '/var/mail/cltbld', 08:30:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:11 INFO - 'MOZ_NO_REMOTE': '1', 08:30:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:11 INFO - 'NO_EM_RESTART': '1', 08:30:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:11 INFO - 'PWD': '/builds/slave/test', 08:30:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:11 INFO - 'SHELL': '/bin/bash', 08:30:11 INFO - 'SHLVL': '1', 08:30:11 INFO - 'TERM': 'linux', 08:30:11 INFO - 'TMOUT': '86400', 08:30:11 INFO - 'USER': 'cltbld', 08:30:11 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031', 08:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:11 INFO - '_': '/tools/buildbot/bin/python'} 08:30:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:30:11 INFO - mozversion application_buildid: 20161025053821 08:30:11 INFO - mozversion application_changeset: 1280f78d221d4c1e146443ee18f99b37f5e520fd 08:30:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:30:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:11 INFO - mozversion application_name: Firefox 08:30:11 INFO - mozversion application_remotingname: firefox-dev 08:30:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:30:11 INFO - mozversion application_vendor: Mozilla 08:30:11 INFO - mozversion application_version: 51.0a2 08:30:11 INFO - mozversion platform_buildid: 20161025053821 08:30:11 INFO - mozversion platform_changeset: 1280f78d221d4c1e146443ee18f99b37f5e520fd 08:30:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:30:11 INFO - mozversion platform_version: 51.0a2 08:30:11 INFO - using testdate: 1477409411 08:30:11 INFO - actual date: 1477409411 08:30:11 INFO - starting webserver on 'localhost:40480' 08:30:11 INFO - SUITE-START | Running 2 tests 08:30:11 INFO - TEST-START | dromaeo_css 08:30:11 INFO - operating with platform_type : linux_ 08:30:11 INFO - Initialising browser for dromaeo_css test... 08:30:11 INFO - TEST-INFO | started process 28516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVe7Bwl/profile http://localhost:40480/getInfo.html) 08:30:15 INFO - PROCESS | 28516 | __metrics Screen width/height:1600/1200 08:30:15 INFO - PROCESS | 28516 | colorDepth:24 08:30:15 INFO - PROCESS | 28516 | Browser inner width/height: 1024/697 08:30:15 INFO - PROCESS | 28516 | __metrics 08:30:15 INFO - PROCESS | 28516 | 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" 08:30:15 INFO - PROCESS | 28516 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:15 INFO - PROCESS | 28516 | console.error: PushService: 08:30:15 INFO - PROCESS | 28516 | stateChangeProcessEnqueue: Error transitioning state 08:30:15 INFO - PROCESS | 28516 | UnknownError 08:30:16 INFO - TEST-INFO | 28516: exit 0 08:30:16 INFO - Browser initialized. 08:30:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:16 INFO - TEST-INFO | started process 28607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVe7Bwl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:28 INFO - PROCESS | 28607 | RSS: Main: 144891904 08:30:28 INFO - PROCESS | 28607 | 08:31:19 INFO - PROCESS | 28607 | 1477409479334 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] 08:33:28 INFO - PROCESS | 28607 | Cycle 1(1): loaded http://localhost:40480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40480/tests/dromaeo/cssquery-ext.html) 08:33:29 INFO - PROCESS | 28607 | RSS: Main: 245145600 08:33:29 INFO - PROCESS | 28607 | 08:36:31 INFO - PROCESS | 28607 | Cycle 1(1): loaded http://localhost:40480/tests/dromaeo/cssquery-ext.html (next: http://localhost:40480/tests/dromaeo/cssquery-jquery.html) 08:36:32 INFO - PROCESS | 28607 | RSS: Main: 235155456 08:36:32 INFO - PROCESS | 28607 | 08:39:34 INFO - PROCESS | 28607 | Cycle 1(1): loaded http://localhost:40480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40480/tests/dromaeo/cssquery-mootools.html) 08:39:34 INFO - PROCESS | 28607 | RSS: Main: 218349568 08:39:34 INFO - PROCESS | 28607 | 08:42:36 INFO - PROCESS | 28607 | Cycle 1(1): loaded http://localhost:40480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40480/tests/dromaeo/cssquery-prototype.html) 08:42:37 INFO - PROCESS | 28607 | RSS: Main: 216043520 08:42:37 INFO - PROCESS | 28607 | 08:45:40 INFO - PROCESS | 28607 | Cycle 1(1): loaded http://localhost:40480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40480/tests/dromaeo/cssquery-yui.html) 08:45:40 INFO - PROCESS | 28607 | RSS: Main: 177086464 08:45:40 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | Cycle 1(1): loaded http://localhost:40480/tests/dromaeo/cssquery-yui.html (next: http://localhost:40480/tests/dromaeo/cssquery-dojo.html) 08:48:43 INFO - PROCESS | 28607 | RSS: Main: 266502144 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | __start_tp_report 08:48:43 INFO - PROCESS | 28607 | _x_x_mozilla_page_load 08:48:43 INFO - PROCESS | 28607 | _x_x_mozilla_page_load_details 08:48:43 INFO - PROCESS | 28607 | |i|pagename|runs| 08:48:43 INFO - PROCESS | 28607 | |0;dojo.html;3082.6763189865064;3138.7489000879923;3160.3205310858175;3169;3188.0435869239222;5454.781808727651;5550.028744969629;5557.305336832896;5559.471850174237;5593.133064375018;5542.307211598551;5575.581831362644;5576.693281869496;5585.8603534911645;5601.131824567188;5037.143685573461;5054.671446355994;5091.109055915219;5132.820351287705;5140.665856719302;4984.2025275955675;5055.342805435288;5129.589632829365;5131.435542090367;5138;4909.975450122744;4941.332920055783;4949.331840201581;4978.327925730035;4997.825076122336;5037.4710655381205;5066.493350664922;5068.5691716204165;5124.231365295198;5162.845114646567;4834.323194752737;5026.045051440215;5048.823291184827;5092.79628814847;5114.795408183668;5408.567314614821;5433.0763770159165;5440.564754819605;5453.972730136364;5477.67133971963;5813.069908814612;5824.912626310609;5878.735456904449;5927.733252003627;5951.970240148815;5731.598788084836;5945.16767652529;5946.791862284799;5959.702014899238;5976.521878249773;5371.623986320959;5428.647137936061;5523.199136125279;5523.585731070106;5554.666719996813;6050.939490605126;6081.604695694766;6103.38966103395;6107.114468402056;6108.5418593605655;5600.691961942132;5842;5849.268841394825;5849.941500585025;5854.648721076749;5719.542436605062;5848.473637372657;5897.056470964625;5915.733791979371;5977.462028417463;5868.383819698955;5868.9706551467825;5875.059990401515;5877.441643043904;5907.084401917709;5848.5321174305955;5884.176215329857;5892.941070589325;5906.143609176645;5915.7633694652595;4465.419495465569;4480.484744254452;4527;4528.909421811545;4531.071130418256;4007.8196481158416;4027;4029.315016447211;4030.5163380394542;4062.8374865005067;5583.69289689071;5594.021046316879;5604.41153678866;5605.355384130877;5637.9718101409235;5842.707864606753;5877.971355012855;5890.381509941394;5918;5938.228030356113;5638.577106717013;5641.012822756002;5647.265855438766;5668.943310566924;5690.573207009491;5093.9745301274;5104.157813960729;5109.591232701449;5143.099957507496;5164.122099243138;5758;5878.147668588116;5929.970350148395;6024.457798798129;6061.54538409621;5909;6002.489788368038;6010.248718910137;6044.697765111639;6051.031834906394;6105.45050945417;6108.35862234459;6109.725062372115;6111.7249723763425;6129.785457508966;5689.459501347365;5708.115242137475;5792.073268277056;5852;5871.970640146772;5890.087036509348;5944.4352786485215;5974.701264936823;6016.157737916607;6054.39456054391;5870.119482077552;5871.119332100219;5872.647641141545;5875.383084776037;5884.823455296348;5567.832965011056;5872;5879.353271140086;5881.088431293157;5891.410858914246;5512.80705175317;5776.884462310646;5793.913091303718;5813.970930145491;5911.054231322968;5836.037053886062;5874.794382196603;5878.794242201502;5882.735276912464;5925.377835327228;5542.61201715876;5601.859953501195;5722.712389712281;5780.757137215519;5784.2769653793275 08:48:43 INFO - PROCESS | 28607 | |1;ext.html;578.8032069096506;604.5012864386881;622.8193823791103;632.1907957814;647.258888572584;33214.83748068815;45989.31016034758;47326.52673473269;47462.52537474624;47543.76228118863;47904.520954790445;48627.75686121565;48629;48698.51301486984;48704.756476217655;8411.621477033548;9402.247820174369;9539.141477267045;9543.236541076698;9575.808483830318;8559.657613695445;10921.508532116073;11266.830997535002;11287.548498060069;11623.825642615368;11370.886291137065;11486.540538378455;11563.884361156364;11577.6526704199;11578.189526733133;11286.153538484605;11331.603393881256;11332.150088743378;11349.943250283779;11371.488283027242;11109.166812489095;11160.386178760165;11170.162237832114;11171.050460710849;11181.888181118247;46230.30654540184;46428;46502.53497465016;46597;46647.30029049567;3675.7426980111404;3680.723945704056;3683.4658974448553;3691.446283057563;3724.6647801697704;33986;34024;34272.48591271108;34860.12849678778;35365.64634353675;4657.930131048037;4686.6485013624115;4731.787069581877;4754.429468463806;4762.595179409755;348319;348902;350854;353474;354342;63251.683741581;63351;63550;63651;63658.363416365246;37128.44307335392;37569.43645845314;37607;37632.24735505274;66016;18340.908295458703;18346.174422151034;18461.815381846278;18473.353432629792;18495.260189592536;12900.483980640856;13000.739985200244;14477.697007269397;14823.407063717546;15004.549863504113;19678.606427871364;20589.455790815748;20678.035586619248;20726.54914156025;20776.58446831055;7013.26360732126;7208.423326134001;7232.349088582053;7240.4569657275915;7299.197088320387;940.7695114696943;1006.7030226083323;1046.5186014433446;1059.4596755654673;1108.3571528513603;33624.83187584095;34060.48909266363;34100.31799363999;34260.666160182314;34795.30409391798;1084.360227465799;1105.8894110589038;1160.6169963911889;1170.4615876696644;1262.2237324045645;16599.50201493933;16872.578185545215;17595.472135835946;17691.73462398065;17927.551811204823;554430;554788;558660;558942;561174;60242;60640;60761.696191519644;60764;60820;1233.2600439736086;1334.6129622409392;1365.5357178559339;1383.875451209396;1389.9783659010618;31165.844170779;35220.64779352173;35302.29395412129;35533.64466355303;35824.46263306;52125;52829;52979;52979.47020529745;52982;420786;420909;421661;422023;422538;30388.544171837882;31537;31561.21096972594;31607.525887112173;31624.209394764395;50108.24837627366;50136.74931625318;50349;50845.237321440945;51272.230916537024;42835.78582107194;42837.14325713531;43476.565234347254;44264.55735442733;45282.547174527834;42114.1577168461;42244.15511689687;42642.57357426386;42954.57045429631;42978.78510607427;41734.791326043174;42008.78995605002;42245;42869.14261714811;43434;35216;37391.62608373881;37435.62564374322;37447;37564.24871502609;28480.02879093079;28520.14439566816;29331.266718332212;29335.266618334714;29402 08:48:43 INFO - PROCESS | 28607 | |2;jquery.html;390.71087395327464;413.46662804981577;424.29143330637834;435.79735423028285;439.6768375244197;14453.566393008214;16035.198240088008;19781.901090494564;20396;21120.260790872322;19578.60842783147;19824.405267841987;20263.290784822533;20409.285675001378;20418.183272669114;5767.625104368202;5811.128330750379;5857.384974577651;5894.056950887859;5910.320313163998;4262.126264115849;5779.855503612402;5867.7066146692705;5876.70616469177;5893.58744887858;4441.777911104448;6229.345918678541;6460.127882735841;6489.545731798776;6624.205095388536;6328.367163283658;6521.641309727963;6560.507961902828;6572.178477690289;6594.58216483456;5837.708114594253;5839.386864379221;5846.473817356416;5846.824595262106;5848.327442344143;23417;23997.880010599834;24020.63969040466;24077;24294.757052429428;2509.146890057371;2532.468181681849;2590.106413287413;2780.7914406419395;2901.956470652942;14868.330925108396;14889.627759305995;14940.701185976328;15490;15645.608859778482;1903.7049257364993;1923.0769230769308;1954.5016020914718;1965.8132477414622;1981.197614965941;81256;81330.59334703347;81341.59329203375;83526.16473835305;84011.5799420999;10682.252242342962;10894.910508949042;10950.835737463944;11269.492872820743;11330.886691132982;14875.702485950436;14893.77659335111;14896.478623248351;14911.776323355158;14914.627134321512;8398.664053437795;8573.957130214434;8600.354973377021;8655.26430253423;8794.560271986504;8576.442531235574;8591.097934716765;8649.654013839501;8819.867701984474;8837.425567338103;6656.201255849329;6712.127423434922;6714.194296684429;6778.864422711518;6924.792256232321;1807.205261607911;1977.6440240756801;1995.600879824041;1996.9800301996795;2021.7877122901884;927.6706769097009;1069.5454431866426;1075.7575000874003;1082.9298937512083;1112.9666110016713;12443.440045197987;20139.39581812548;20162.89918550398;20282;20554.897225513778;483.3692031898406;498.2238320387878;509.22851879402737;509.72220140023774;522.115015049495;6179.938200618026;6443.420092191725;6471.5146364022885;6748;6764.425023872927;509445;518024;522386;543424;545092;96858;97787;98928.50535747275;99120;100237;531.5747402078322;540.7053156029973;542.0487045235665;544.0967993131383;544.5643485211815;11523.711907202052;11651.825222621837;11653.184277100861;11838.28970261787;11856.288622682667;40479;40691.18617627572;41055.79472102621;41854.95362615959;42627.360589590564;57482;58405;58681.4131858693;59370.40629593821;59980.400195997485;9114.361994660576;9165.358424910191;9218.861717074384;9287.535623218677;9440.811183776423;10075.89924100779;11964.46159922823;12680.619581412573;12689.111762176559;12960.222386656453;11013.779724405307;11218.775624487302;11369;11448.656540303804;11542.480588373375;11376.715582110513;12135.08986825974;12163.209391389531;12210.938945305217;12491.188072775241;11191.38447385369;11228.382438965935;11236.775264494501;11369.204155709022;11476.540938362707;9453.43279403238;9459.148676619137;9463.2429405646;9598.817630400488;9660.37207581505;11409.828852567052;11747.706307342385;11876.615164678025;12156.149069565046;12170.939145304572 08:48:43 INFO - PROCESS | 28607 | |3;mootools.html;1511.4181040299484;1534.2405509272908;1644.4408900973667;1785.1609743420588;1812.048674445915;8524.659013639455;9170.541472926352;9177.632894684204;9191.17279444849;9208.67769628063;7810.414218933574;7979.321757650607;8607.526586037766;8810.207081362676;8858.424202426837;2453.521563295158;2478.8968908835577;2486.987565062181;2488.129154795825;2491.4394261291245;2420.5521978434044;2485.72657007729;2494.787943024845;2497.825152239344;2505.6366826810104;2410.517896420714;2443.462438263588;2503.68703912011;2504.27376060943;2508.598624220125;2439.524292762912;2449.179524859165;2457.9016839326405;2488.1913378151994;2489.191012920808;2389.6415537669313;2400.207931382657;2412.2039726890084;2416.782489575929;2434.050720219116;8958.328125390557;9030.232430243437;9052.637894484213;9062.546872656407;9078.954605226998;5425.267588875491;5584.274044374246;5598.44015598441;5603.523700485463;5614.859628509279;3396.707455594288;3436.914077148066;3516.542849429558;3518.138056176253;3534.8232588370734;1181.6632259805915;1221.8533775946855;1229.170310040719;1254.680056585574;1284.267967258663;12496.187747796364;12530.874691253062;12555.937220313932;12569;12608.11743177978;4774.188387974053;4836;4870.683405578626;4944.53026962438;5040.697558146523;10587.947060264649;10590.735231619117;10596.152307815357;10601.151907847508;10602.469876506144;5511.53151982078;5513.338399392099;5574.60977731563;5581.860453488614;5582.553395728413;4437;4591.242444996538;4961.975190124099;5042.873928151752;5071.771770270347;4202.70581059329;4227.767472788964;4282.892927676833;4310.719803212781;4318.956810431919;1330.760463116629;1333.48660765604;1353.4315587453293;1358.6875018745743;1361.6391656211113;807.7520231242744;860.2472836268265;965.2181732796317;986.590564915552;1014.9492525373702;5798.797042103506;6037;6177.7837775677635;6180.289266734293;6221.564490485713;498.3446767500797;503.2828219786789;508.2274942088006;513.8561202863204;533.0325459291452;4149.896252593649;4153.54311025787;4253.2769429197115;4253.914921701548;4264.914701705949;10909.781804363869;11239.932206440375;11344.149188810872;11373.545058197746;11375.488103035383;10232.437215953045;11242.325460472235;11285.266457680225;11291.322520648788;11297.435128243555;8236.752897412967;8608.48349099056;8609.61256743448;8612.741617751477;8613.052564217931;5892.499137573354;5899.085641725539;6090.665013424127;6140.355262697352;6159.23009623797;9707.611695532381;10323.741906452398;10515.106215971728;10527;10527.263091583516;10221.897781022391;10401.58393664245;10448.268621196747;10515.894841051491;10556.472176391304;7081.681324340314;7201.3518783309755;7830.2952734254195;7984.92015079865;8167.264946154874;8734.91265087341;8836.337274704552;8839.558022098998;8918.86621700688;8967.237784788365;6684.665766711548;7577.0907491099215;7730.574818385043;7961.641726122222;8069.7175598853755;7816.882746758917;7852.568108754073;7900.762977110696;7918.881216781638;8151.714689986059;6689.799306020827;6788.321167883172;6796.388325050769;6798.218204906499;6806.591604503746;5052.924206136838;5162.251473536391;5181.715005674573;5232.293640358503;5331.280277162534;5171.534561889298;5245.632805703564;5281.075811732854;5296.41739408657;5481.287432633732 08:48:43 INFO - PROCESS | 28607 | |4;prototype.html;343.8933930481551;355.5040718198113;360.41792505104246;362.9328574213772;367.2819637608474;5505.587080968933;5538.363088244853;5543.808081262533;5564.026295398309;5604.327480702316;5168.173092305232;5241.528262456378;5329.413764485913;5355.6251062425645;5465.562754979602;4265.424167737347;4268.530461649216;4274.1451709658195;4295.742255464675;4319.265724826787;4256.97871510642;4284.2930916398755;4291.4850217973735;4298.570142985708;4328.761918094504;3999.5800440953717;3999.900002499932;4240.893977650568;4247.492140290199;4321.503027151886;4229.323308270693;4240.469941257343;4245.830166793325;4253.702240843142;4291.291936830419;3818.1936276836504;3829.100161462054;3832.3485007548784;3842.346801043829;3844.826982785781;5090.032893750175;5234.502722241381;5336.626436149471;5347.010803001457;5359.035373632744;4901.534354236342;4909.705417674951;4917.901641967176;4923.409190897115;4939.110960027194;5619.909050022471;5634.887302253973;5675.716214189274;5675.836453527058;5677.886442271173;4146;4184.8744537663915;4239.173361194568;4245.320748680197;4248.787560621957;5830.970845145789;5831.425515110896;5837;5860.853478663025;5894.821035792858;4381.671374646914;4387.583179597933;4406.669499787528;4420.336949457543;4425.911481770411;4260.382244574519;4351.216001439395;4395.450568678915;4395.824167033346;4476.820927162942;4896.632752543503;4898.730569818623;4900.803967841246;4901.607871370282;4910.238912968495;5691.686957217393;5691.686957217393;5692.943070569324;5702.857428564236;5705.515031222392;1483.2806089046803;1506.9150211847452;1516.1585320147424;1516.5526169779941;1528.8241852186918;980.7352014955922;1014.4927536231884;1026.9794604107876;1074.6990842564094;1079.7084787107437;5554.333479982428;5556.499915007668;5557.194206839986;5568.749406276727;5588.770470496484;5715.714214289269;5839.240898683144;5852.473277405054;5852.912206316909;5877.647341159544;5464.808731694372;5477.890442191214;5487.286652735119;5514.6691198527415;5549.445055494499;3074.7540196784203;3092.4588197065423;3109.5491153782573;3111.828849413259;3117.781755277109;5706.686132262683;5873.383294754075;5876.970615146897;5915.290165180119;5981.192539007266;5854.970725146347;5889.94110058894;5941.55438342126;5942.346341902387;5971.164037034819;5677.460641239076;6003.609765365325;6004.988328909777;6008.909866352008;6024.156618073385;5750.223719797774;5754.079347304411;5762.193292939076;5773.22061521706;5822.446867547576;5640.661560306231;5658.603897727119;5676.886462270814;5706.914396283976;5785.392533783892;5627.7467513961155;5809.796657116981;5892.939270931273;5907.586468947133;5930.822075337746;4345.326474396347;4347.673924455742;4374.7156434832905;4391.341298805205;4415.82336706541;5900.734466948912;5907.3501914790195;5912.290525136839;5923.585349025527;5924.496417804535;5632.633878797865;5689.886202276014;5699.458551437607;5718.228039214653;5762.732198916399;5672;5687.5449964001955;5696.430356964271;5699.777086936016;5720.74256658443;5264.657797243167;5505.421930697379;5558.666480011212;5698.4016678249845;5720;5723.771049157987;5740.799072032459;5749.579000494699;5758.1650660654805;5759.992001399822;5497.47773961473;5627.7467513961155;5631.8592035199445;5636.492715655447;5662.603617746719 08:48:43 INFO - PROCESS | 28607 | |5;yui.html;807.4953154278576;822.3421262989609;824.4229039672227;829.6722794496175;864.9740507784769;15622.921885390571;15940;16226.594335141597;16317.592060198485;16407.097609631466;15436.845631543682;15512.84487155128;15651.217439128026;15756.975796573215;15777.368905243806;699.360085521747;718.0378293087263;839.5004972041626;849.558229720545;881.3874357321664;871.8169184471237;873.3319010956624;873.8033942362981;874.0996773323487;875.8642410426394;918.6876462002917;922.6401703335705;922.6862866625346;922.861570764384;923.4736200365794;749.61394881636;771.2441807029087;881.801594641207;908.636545381846;923.2890674180877;676.9932300677028;677.5223467455432;678.0101052463409;678.0507289794278;678.0947435174048;13165.341732913315;13188.208707477486;13193.802092968614;13203.669908252274;13213.405396757169;14563.781543276858;14850.925745371203;14889.925550372178;14936.850631493655;15141.848581514154;12614.36928153598;12694.365281735876;14068.437262509487;14185.148891066568;14584;4569.497355290915;4601.125786100663;4640.883977900546;4700.4359476862655;4822.324874517571;82967.5851620744;84657.57671211666;85764;86789.56605216934;87711;11646.94176529112;11682.76634467323;11793.469293881795;11971;12190.939045304716;20686.172553098007;20811.68782468264;20822;20824.37526874166;20882.477938051365;8663.436876603;8690.348223883107;8829.33779966505;8925.910740892637;9040.909590904139;4781.95218047822;4855.975720121377;4898.461169271377;4998.475160108209;5120.18077107661;3346.1969127409734;3482.3905816482015;3482.460218666111;3485.5120283160377;3485.790852548855;605.9878802424015;616.4513582911212;627.3381582430579;646.9805905822833;655.3119224814021;673.7338751193251;700.9789706308717;713.4827250243532;734.3977938090821;737.3253473072186;9057.184853363096;9171.77070573241;9567.665131720356;9720.90279097214;9850.314339886181;613.800020959024;724.8586525627452;734.9816254593571;736.37408203027;739.6782399656166;4710.8351207707565;4714.528547145258;4824.107540105092;4837.516248375205;4846.200376937766;127889;128321;128698.35650821873;131092;132853;64946.675266623366;66480;80993;90549;106807;95905.9999999986;97155;97366.51316743513;97981;99217;9101.544922753968;9202.631894724136;9306.813863722824;9323.160915517636;9337.253019758267;42763.57236427596;43657.12685746204;47714;55115.89768204694;56447.43552564586;50883.49116508788;52342;63004.36995629985;71190.64404677943;76997.18349107934;14004.36980335867;14640.26798660084;14649.12105273687;14662.853371466575;14765.704685906436;15844.1285729286;15856.542235953446;15934.9203253983;16304.021758694516;16578.419755308987;14015.229162395759;14434.927825360806;14622.926885365505;15108;15494.690106198039;14637.634059148606;15075.09549427038;15246.695066098839;15522.456714014956;16043.839561604234;13973.510927117502;14159;15393;15504;15610.45363412275;11576.131790115944;12495.12534122639;12542.372881356077;12888.806667900177;13200.14199077057;12349.506019759108;12353.197042192229;12374.13381063317;12715.491380344683;13008.544700935421 08:48:43 INFO - PROCESS | 28607 | __end_tp_report 08:48:43 INFO - PROCESS | 28607 | __start_cc_report 08:48:43 INFO - PROCESS | 28607 | _x_x_mozilla_cycle_collect,856 08:48:43 INFO - PROCESS | 28607 | __end_cc_report 08:48:43 INFO - PROCESS | 28607 | __startTimestamp1477410523410__endTimestamp 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | ------- Summary: start ------- 08:48:43 INFO - PROCESS | 28607 | Number of tests: 6 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | [#0] dojo.html Cycles:165 Average:5497.11 Median:5719.54 stddev:628.84 (11.0%) stddev-sans-first:601.57 08:48:43 INFO - PROCESS | 28607 | Values: 3082.7 3138.7 3160.3 3169.0 3188.0 5454.8 5550.0 5557.3 5559.5 5593.1 5542.3 5575.6 5576.7 5585.9 5601.1 5037.1 5054.7 5091.1 5132.8 5140.7 4984.2 5055.3 5129.6 5131.4 5138.0 4910.0 4941.3 4949.3 4978.3 4997.8 5037.5 5066.5 5068.6 5124.2 5162.8 4834.3 5026.0 5048.8 5092.8 5114.8 5408.6 5433.1 5440.6 5454.0 5477.7 5813.1 5824.9 5878.7 5927.7 5952.0 5731.6 5945.2 5946.8 5959.7 5976.5 5371.6 5428.6 5523.2 5523.6 5554.7 6050.9 6081.6 6103.4 6107.1 6108.5 5600.7 5842.0 5849.3 5849.9 5854.6 5719.5 5848.5 5897.1 5915.7 5977.5 5868.4 5869.0 5875.1 5877.4 5907.1 5848.5 5884.2 5892.9 5906.1 5915.8 4465.4 4480.5 4527.0 4528.9 4531.1 4007.8 4027.0 4029.3 4030.5 4062.8 5583.7 5594.0 5604.4 5605.4 5638.0 5842.7 5878.0 5890.4 5918.0 5938.2 5638.6 5641.0 5647.3 5668.9 5690.6 5094.0 5104.2 5109.6 5143.1 5164.1 5758.0 5878.1 5930.0 6024.5 6061.5 5909.0 6002.5 6010.2 6044.7 6051.0 6105.5 6108.4 6109.7 6111.7 6129.8 5689.5 5708.1 5792.1 5852.0 5872.0 5890.1 5944.4 5974.7 6016.2 6054.4 5870.1 5871.1 5872.6 5875.4 5884.8 5567.8 5872.0 5879.4 5881.1 5891.4 5512.8 5776.9 5793.9 5814.0 5911.1 5836.0 5874.8 5878.8 5882.7 5925.4 5542.6 5601.9 5722.7 5780.8 5784.3 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | [#1] ext.html Cycles:180 Average:61495.18 Median:20558.15 stddev:119545.98 (581.5%) stddev-sans-first:119793.85 08:48:43 INFO - PROCESS | 28607 | Values: 578.8 604.5 622.8 632.2 647.3 33214.8 45989.3 47326.5 47462.5 47543.8 47904.5 48627.8 48629.0 48698.5 48704.8 8411.6 9402.2 9539.1 9543.2 9575.8 8559.7 10921.5 11266.8 11287.5 11623.8 11370.9 11486.5 11563.9 11577.7 11578.2 11286.2 11331.6 11332.2 11349.9 11371.5 11109.2 11160.4 11170.2 11171.1 11181.9 46230.3 46428.0 46502.5 46597.0 46647.3 3675.7 3680.7 3683.5 3691.4 3724.7 33986.0 34024.0 34272.5 34860.1 35365.6 4657.9 4686.6 4731.8 4754.4 4762.6 348319.0 348902.0 350854.0 353474.0 354342.0 63251.7 63351.0 63550.0 63651.0 63658.4 37128.4 37569.4 37607.0 37632.2 66016.0 18340.9 18346.2 18461.8 18473.4 18495.3 12900.5 13000.7 14477.7 14823.4 15004.5 19678.6 20589.5 20678.0 20726.5 20776.6 7013.3 7208.4 7232.3 7240.5 7299.2 940.8 1006.7 1046.5 1059.5 1108.4 33624.8 34060.5 34100.3 34260.7 34795.3 1084.4 1105.9 1160.6 1170.5 1262.2 16599.5 16872.6 17595.5 17691.7 17927.6 554430.0 554788.0 558660.0 558942.0 561174.0 60242.0 60640.0 60761.7 60764.0 60820.0 1233.3 1334.6 1365.5 1383.9 1390.0 31165.8 35220.6 35302.3 35533.6 35824.5 52125.0 52829.0 52979.0 52979.5 52982.0 420786.0 420909.0 421661.0 422023.0 422538.0 30388.5 31537.0 31561.2 31607.5 31624.2 50108.2 50136.7 50349.0 50845.2 51272.2 42835.8 42837.1 43476.6 44264.6 45282.5 42114.2 42244.2 42642.6 42954.6 42978.8 41734.8 42008.8 42245.0 42869.1 43434.0 35216.0 37391.6 37435.6 37447.0 37564.2 28480.0 28520.1 29331.3 29335.3 29402.0 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | [#2] jquery.html Cycles:180 Average:30263.35 Median:21139.62 stddev:87008.42 (411.6%) stddev-sans-first:87223.59 08:48:43 INFO - PROCESS | 28607 | Values: 390.7 413.5 424.3 435.8 439.7 14453.6 16035.2 19781.9 20396.0 21120.3 19578.6 19824.4 20263.3 20409.3 20418.2 5767.6 5811.1 5857.4 5894.1 5910.3 4262.1 5779.9 5867.7 5876.7 5893.6 4441.8 6229.3 6460.1 6489.5 6624.2 6328.4 6521.6 6560.5 6572.2 6594.6 5837.7 5839.4 5846.5 5846.8 5848.3 23417.0 23997.9 24020.6 24077.0 24294.8 2509.1 2532.5 2590.1 2780.8 2902.0 14868.3 14889.6 14940.7 15490.0 15645.6 1903.7 1923.1 1954.5 1965.8 1981.2 81256.0 81330.6 81341.6 83526.2 84011.6 10682.3 10894.9 10950.8 11269.5 11330.9 14875.7 14893.8 14896.5 14911.8 14914.6 8398.7 8574.0 8600.4 8655.3 8794.6 8576.4 8591.1 8649.7 8819.9 8837.4 6656.2 6712.1 6714.2 6778.9 6924.8 1807.2 1977.6 1995.6 1997.0 2021.8 927.7 1069.5 1075.8 1082.9 1113.0 12443.4 20139.4 20162.9 20282.0 20554.9 483.4 498.2 509.2 509.7 522.1 6179.9 6443.4 6471.5 6748.0 6764.4 509445.0 518024.0 522386.0 543424.0 545092.0 96858.0 97787.0 98928.5 99120.0 100237.0 531.6 540.7 542.0 544.1 544.6 11523.7 11651.8 11653.2 11838.3 11856.3 40479.0 40691.2 41055.8 41855.0 42627.4 57482.0 58405.0 58681.4 59370.4 59980.4 9114.4 9165.4 9218.9 9287.5 9440.8 10075.9 11964.5 12680.6 12689.1 12960.2 11013.8 11218.8 11369.0 11448.7 11542.5 11376.7 12135.1 12163.2 12210.9 12491.2 11191.4 11228.4 11236.8 11369.2 11476.5 9453.4 9459.1 9463.2 9598.8 9660.4 11409.8 11747.7 11876.6 12156.1 12170.9 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | [#3] mootools.html Cycles:180 Average:5929.66 Median:4953.25 stddev:3357.62 (67.8%) stddev-sans-first:3350.62 08:48:43 INFO - PROCESS | 28607 | Values: 1511.4 1534.2 1644.4 1785.2 1812.0 8524.7 9170.5 9177.6 9191.2 9208.7 7810.4 7979.3 8607.5 8810.2 8858.4 2453.5 2478.9 2487.0 2488.1 2491.4 2420.6 2485.7 2494.8 2497.8 2505.6 2410.5 2443.5 2503.7 2504.3 2508.6 2439.5 2449.2 2457.9 2488.2 2489.2 2389.6 2400.2 2412.2 2416.8 2434.1 8958.3 9030.2 9052.6 9062.5 9079.0 5425.3 5584.3 5598.4 5603.5 5614.9 3396.7 3436.9 3516.5 3518.1 3534.8 1181.7 1221.9 1229.2 1254.7 1284.3 12496.2 12530.9 12555.9 12569.0 12608.1 4774.2 4836.0 4870.7 4944.5 5040.7 10587.9 10590.7 10596.2 10601.2 10602.5 5511.5 5513.3 5574.6 5581.9 5582.6 4437.0 4591.2 4962.0 5042.9 5071.8 4202.7 4227.8 4282.9 4310.7 4319.0 1330.8 1333.5 1353.4 1358.7 1361.6 807.8 860.2 965.2 986.6 1014.9 5798.8 6037.0 6177.8 6180.3 6221.6 498.3 503.3 508.2 513.9 533.0 4149.9 4153.5 4253.3 4253.9 4264.9 10909.8 11239.9 11344.1 11373.5 11375.5 10232.4 11242.3 11285.3 11291.3 11297.4 8236.8 8608.5 8609.6 8612.7 8613.1 5892.5 5899.1 6090.7 6140.4 6159.2 9707.6 10323.7 10515.1 10527.0 10527.3 10221.9 10401.6 10448.3 10515.9 10556.5 7081.7 7201.4 7830.3 7984.9 8167.3 8734.9 8836.3 8839.6 8918.9 8967.2 6684.7 7577.1 7730.6 7961.6 8069.7 7816.9 7852.6 7900.8 7918.9 8151.7 6689.8 6788.3 6796.4 6798.2 6806.6 5052.9 5162.3 5181.7 5232.3 5331.3 5171.5 5245.6 5281.1 5296.4 5481.3 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | [#4] prototype.html Cycles:180 Average:4819.48 Median:5510.13 stddev:1379.18 (25.0%) stddev-sans-first:1341.51 08:48:43 INFO - PROCESS | 28607 | Values: 343.9 355.5 360.4 362.9 367.3 5505.6 5538.4 5543.8 5564.0 5604.3 5168.2 5241.5 5329.4 5355.6 5465.6 4265.4 4268.5 4274.1 4295.7 4319.3 4257.0 4284.3 4291.5 4298.6 4328.8 3999.6 3999.9 4240.9 4247.5 4321.5 4229.3 4240.5 4245.8 4253.7 4291.3 3818.2 3829.1 3832.3 3842.3 3844.8 5090.0 5234.5 5336.6 5347.0 5359.0 4901.5 4909.7 4917.9 4923.4 4939.1 5619.9 5634.9 5675.7 5675.8 5677.9 4146.0 4184.9 4239.2 4245.3 4248.8 5831.0 5831.4 5837.0 5860.9 5894.8 4381.7 4387.6 4406.7 4420.3 4425.9 4260.4 4351.2 4395.5 4395.8 4476.8 4896.6 4898.7 4900.8 4901.6 4910.2 5691.7 5691.7 5692.9 5702.9 5705.5 1483.3 1506.9 1516.2 1516.6 1528.8 980.7 1014.5 1027.0 1074.7 1079.7 5554.3 5556.5 5557.2 5568.7 5588.8 5715.7 5839.2 5852.5 5852.9 5877.6 5464.8 5477.9 5487.3 5514.7 5549.4 3074.8 3092.5 3109.5 3111.8 3117.8 5706.7 5873.4 5877.0 5915.3 5981.2 5855.0 5889.9 5941.6 5942.3 5971.2 5677.5 6003.6 6005.0 6008.9 6024.2 5750.2 5754.1 5762.2 5773.2 5822.4 5640.7 5658.6 5676.9 5706.9 5785.4 5627.7 5809.8 5892.9 5907.6 5930.8 4345.3 4347.7 4374.7 4391.3 4415.8 5900.7 5907.4 5912.3 5923.6 5924.5 5632.6 5689.9 5699.5 5718.2 5762.7 5672.0 5687.5 5696.4 5699.8 5720.7 5264.7 5505.4 5558.7 5698.4 5720.0 5723.8 5740.8 5749.6 5758.2 5760.0 5497.5 5627.7 5631.9 5636.5 5662.6 08:48:43 INFO - PROCESS | 28607 | 08:48:43 INFO - PROCESS | 28607 | [#5] yui.html Cycles:180 Average:21279.42 Median:4802.14 stddev:30957.21 (644.7%) stddev-sans-first:31005.89 08:48:43 INFO - PROCESS | 28607 | Values: 807.5 822.3 824.4 829.7 865.0 15622.9 15940.0 16226.6 16317.6 16407.1 15436.8 15512.8 15651.2 15757.0 15777.4 699.4 718.0 839.5 849.6 881.4 871.8 873.3 873.8 874.1 875.9 918.7 922.6 922.7 922.9 923.5 749.6 771.2 881.8 908.6 923.3 677.0 677.5 678.0 678.1 678.1 13165.3 13188.2 13193.8 13203.7 13213.4 14563.8 14850.9 14889.9 14936.9 15141.8 12614.4 12694.4 14068.4 14185.1 14584.0 4569.5 4601.1 4640.9 4700.4 4822.3 82967.6 84657.6 85764.0 86789.6 87711.0 11646.9 11682.8 11793.5 11971.0 12190.9 20686.2 20811.7 20822.0 20824.4 20882.5 8663.4 8690.3 8829.3 8925.9 9040.9 4782.0 4856.0 4898.5 4998.5 5120.2 3346.2 3482.4 3482.5 3485.5 3485.8 606.0 616.5 627.3 647.0 655.3 673.7 701.0 713.5 734.4 737.3 9057.2 9171.8 9567.7 9720.9 9850.3 613.8 724.9 735.0 736.4 739.7 4710.8 4714.5 4824.1 4837.5 4846.2 127889.0 128321.0 128698.4 131092.0 132853.0 64946.7 66480.0 80993.0 90549.0 106807.0 95906.0 97155.0 97366.5 97981.0 99217.0 9101.5 9202.6 9306.8 9323.2 9337.3 42763.6 43657.1 47714.0 55115.9 56447.4 50883.5 52342.0 63004.4 71190.6 76997.2 14004.4 14640.3 14649.1 14662.9 14765.7 15844.1 15856.5 15934.9 16304.0 16578.4 14015.2 14434.9 14622.9 15108.0 15494.7 14637.6 15075.1 15246.7 15522.5 16043.8 13973.5 14159.0 15393.0 15504.0 15610.5 11576.1 12495.1 12542.4 12888.8 13200.1 12349.5 12353.2 12374.1 12715.5 13008.5 08:48:43 INFO - PROCESS | 28607 | -------- Summary: end -------- 08:48:43 INFO - PROCESS | 28607 | 08:48:44 INFO - TEST-INFO | 28607: exit 0 08:48:44 INFO - TEST-OK | dromaeo_css | took 1112693ms 08:48:44 INFO - TEST-START | kraken 08:48:44 INFO - operating with platform_type : linux_ 08:48:44 INFO - Initialising browser for kraken test... 08:48:44 INFO - TEST-INFO | started process 28926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzyxYJ/profile http://localhost:40480/getInfo.html) 08:48:47 INFO - PROCESS | 28926 | __metrics Screen width/height:1600/1200 08:48:47 INFO - PROCESS | 28926 | colorDepth:24 08:48:47 INFO - PROCESS | 28926 | Browser inner width/height: 1024/697 08:48:47 INFO - PROCESS | 28926 | __metrics 08:48:48 INFO - PROCESS | 28926 | 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" 08:48:48 INFO - PROCESS | 28926 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:48 INFO - PROCESS | 28926 | console.error: PushService: 08:48:48 INFO - PROCESS | 28926 | stateChangeProcessEnqueue: Error transitioning state 08:48:48 INFO - PROCESS | 28926 | UnknownError 08:48:49 INFO - TEST-INFO | 28926: exit 0 08:48:49 INFO - Browser initialized. 08:48:49 INFO - Running cycle 1/1 for kraken test... 08:48:49 INFO - TEST-INFO | started process 29016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzyxYJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:00 INFO - PROCESS | 29016 | RSS: Main: 145133568 08:49:00 INFO - PROCESS | 29016 | 08:49:03 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40480/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:04 INFO - PROCESS | 29016 | RSS: Main: 186511360 08:49:04 INFO - PROCESS | 29016 | 08:49:06 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40480/tests/kraken/driver.html?testName=audio-dft) 08:49:07 INFO - PROCESS | 29016 | RSS: Main: 175681536 08:49:07 INFO - PROCESS | 29016 | 08:49:10 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40480/tests/kraken/driver.html?testName=audio-fft) 08:49:10 INFO - PROCESS | 29016 | RSS: Main: 267157504 08:49:10 INFO - PROCESS | 29016 | 08:49:12 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40480/tests/kraken/driver.html?testName=audio-oscillator) 08:49:13 INFO - PROCESS | 29016 | RSS: Main: 173899776 08:49:13 INFO - PROCESS | 29016 | 08:49:15 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:16 INFO - PROCESS | 29016 | RSS: Main: 175845376 08:49:16 INFO - PROCESS | 29016 | 08:49:19 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40480/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:19 INFO - PROCESS | 29016 | RSS: Main: 210939904 08:49:19 INFO - PROCESS | 29016 | 08:49:23 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40480/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:23 INFO - PROCESS | 29016 | RSS: Main: 210509824 08:49:23 INFO - PROCESS | 29016 | 08:49:26 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40480/tests/kraken/driver.html?testName=json-parse-financial) 08:49:27 INFO - PROCESS | 29016 | RSS: Main: 209981440 08:49:27 INFO - PROCESS | 29016 | 08:49:28 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:29 INFO - PROCESS | 29016 | RSS: Main: 172036096 08:49:29 INFO - PROCESS | 29016 | 08:49:31 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:31 INFO - PROCESS | 29016 | RSS: Main: 179781632 08:49:31 INFO - PROCESS | 29016 | 08:49:33 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:34 INFO - PROCESS | 29016 | RSS: Main: 187932672 08:49:34 INFO - PROCESS | 29016 | 08:49:36 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:37 INFO - PROCESS | 29016 | RSS: Main: 196452352 08:49:37 INFO - PROCESS | 29016 | 08:49:40 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:40 INFO - PROCESS | 29016 | RSS: Main: 193896448 08:49:40 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:40480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40480/tests/kraken/driver.html?testName=ai-astar) 08:49:42 INFO - PROCESS | 29016 | RSS: Main: 244535296 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | __start_tp_report 08:49:42 INFO - PROCESS | 29016 | _x_x_mozilla_page_load 08:49:42 INFO - PROCESS | 29016 | _x_x_mozilla_page_load_details 08:49:42 INFO - PROCESS | 29016 | |i|pagename|runs| 08:49:42 INFO - PROCESS | 29016 | |0;ai-astar;109;114;113;112;113;112;114;111;111;112 08:49:42 INFO - PROCESS | 29016 | |1;audio-beat-detection;152;125;121;168;123;124;118;123;146;118 08:49:42 INFO - PROCESS | 29016 | |2;audio-dft;162;163;162;163;161;164;160;163;162;161 08:49:42 INFO - PROCESS | 29016 | |3;audio-fft;74;77;77;106;76;76;76;76;97;76 08:49:42 INFO - PROCESS | 29016 | |4;audio-oscillator;82;82;119;81;82;82;104;81;81;113 08:49:42 INFO - PROCESS | 29016 | |5;imaging-gaussian-blur;117;117;116;118;117;116;118;117;117;118 08:49:42 INFO - PROCESS | 29016 | |6;imaging-darkroom;147;147;146;147;149;147;146;146;148;146 08:49:42 INFO - PROCESS | 29016 | |7;imaging-desaturate;96;96;95;96;95;96;95;95;95;95 08:49:42 INFO - PROCESS | 29016 | |8;json-parse-financial;50;50;50;49;49;50;49;48;49;49 08:49:42 INFO - PROCESS | 29016 | |9;json-stringify-tinderbox;65;58;58;58;59;59;59;59;59;59 08:49:42 INFO - PROCESS | 29016 | |10;stanford-crypto-aes;83;80;79;73;74;74;75;74;74;75 08:49:42 INFO - PROCESS | 29016 | |11;stanford-crypto-ccm;124;132;125;128;124;131;123;130;165;134 08:49:42 INFO - PROCESS | 29016 | |12;stanford-crypto-pbkdf2;154;157;156;153;156;155;156;151;156;160 08:49:42 INFO - PROCESS | 29016 | |13;stanford-crypto-sha256-iterative;63;63;62;64;63;64;64;65;61;63 08:49:42 INFO - PROCESS | 29016 | __end_tp_report 08:49:42 INFO - PROCESS | 29016 | __start_cc_report 08:49:42 INFO - PROCESS | 29016 | _x_x_mozilla_cycle_collect,1556 08:49:42 INFO - PROCESS | 29016 | __end_cc_report 08:49:42 INFO - PROCESS | 29016 | __startTimestamp1477410582640__endTimestamp 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | ------- Summary: start ------- 08:49:42 INFO - PROCESS | 29016 | Number of tests: 14 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.52 (1.4%) stddev-sans-first:1.13 08:49:42 INFO - PROCESS | 29016 | Values: 109.0 114.0 113.0 112.0 113.0 112.0 114.0 111.0 111.0 112.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:124.50 stddev:17.25 (13.9%) stddev-sans-first:16.68 08:49:42 INFO - PROCESS | 29016 | Values: 152.0 125.0 121.0 168.0 123.0 124.0 118.0 123.0 146.0 118.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 08:49:42 INFO - PROCESS | 29016 | Values: 162.0 163.0 162.0 163.0 161.0 164.0 160.0 163.0 162.0 161.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:10.99 (14.5%) stddev-sans-first:11.35 08:49:42 INFO - PROCESS | 29016 | Values: 74.0 77.0 77.0 106.0 76.0 76.0 76.0 76.0 97.0 76.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:81.50 stddev:15.13 (18.6%) stddev-sans-first:15.72 08:49:42 INFO - PROCESS | 29016 | Values: 82.0 82.0 119.0 81.0 82.0 82.0 104.0 81.0 81.0 113.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 08:49:42 INFO - PROCESS | 29016 | Values: 117.0 117.0 116.0 118.0 117.0 116.0 118.0 117.0 117.0 118.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 08:49:42 INFO - PROCESS | 29016 | Values: 147.0 147.0 146.0 147.0 149.0 147.0 146.0 146.0 148.0 146.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:49:42 INFO - PROCESS | 29016 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.50 stddev:0.67 (1.4%) stddev-sans-first:0.67 08:49:42 INFO - PROCESS | 29016 | Values: 50.0 50.0 50.0 49.0 49.0 50.0 49.0 48.0 49.0 49.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:2.06 (3.5%) stddev-sans-first:0.50 08:49:42 INFO - PROCESS | 29016 | Values: 65.0 58.0 58.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.00 stddev:3.35 (4.5%) stddev-sans-first:2.45 08:49:42 INFO - PROCESS | 29016 | Values: 83.0 80.0 79.0 73.0 74.0 74.0 75.0 74.0 74.0 75.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:130.50 stddev:12.34 (9.5%) stddev-sans-first:12.78 08:49:42 INFO - PROCESS | 29016 | Values: 124.0 132.0 125.0 128.0 124.0 131.0 123.0 130.0 165.0 134.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 08:49:42 INFO - PROCESS | 29016 | Values: 154.0 157.0 156.0 153.0 156.0 155.0 156.0 151.0 156.0 160.0 08:49:42 INFO - PROCESS | 29016 | 08:49:42 INFO - PROCESS | 29016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.14 (1.8%) stddev-sans-first:1.20 08:49:42 INFO - PROCESS | 29016 | Values: 63.0 63.0 62.0 64.0 63.0 64.0 64.0 65.0 61.0 63.0 08:49:42 INFO - PROCESS | 29016 | -------- Summary: end -------- 08:49:42 INFO - PROCESS | 29016 | 08:49:43 INFO - TEST-INFO | 29016: exit 0 08:49:43 INFO - TEST-OK | kraken | took 59389ms 08:49:43 INFO - SUITE-END | took 1172s 08:49:43 INFO - Completed test suite (00:19:32) 08:49:43 INFO - javascript benchmark 08:49:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.6763189865064, 3138.7489000879923, 3160.3205310858175, 3169.0, 3188.0435869239222, 5454.781808727651, 5550.028744969629, 5557.305336832896, 5559.471850174237, 5593.133064375018, 5542.307211598551, 5575.581831362644, 5576.693281869496, 5585.8603534911645, 5601.131824567188, 5037.143685573461, 5054.671446355994, 5091.109055915219, 5132.820351287705, 5140.665856719302, 4984.2025275955675, 5055.342805435288, 5129.589632829365, 5131.435542090367, 5138.0, 4909.975450122744, 4941.332920055783, 4949.331840201581, 4978.327925730035, 4997.825076122336, 5037.4710655381205, 5066.493350664922, 5068.5691716204165, 5124.231365295198, 5162.845114646567, 4834.323194752737, 5026.045051440215, 5048.823291184827, 5092.79628814847, 5114.795408183668, 5408.567314614821, 5433.0763770159165, 5440.564754819605, 5453.972730136364, 5477.67133971963, 5813.069908814612, 5824.912626310609, 5878.735456904449, 5927.733252003627, 5951.970240148815, 5731.598788084836, 5945.16767652529, 5946.791862284799, 5959.702014899238, 5976.521878249773, 5371.623986320959, 5428.647137936061, 5523.199136125279, 5523.585731070106, 5554.666719996813, 6050.939490605126, 6081.604695694766, 6103.38966103395, 6107.114468402056, 6108.5418593605655, 5600.691961942132, 5842.0, 5849.268841394825, 5849.941500585025, 5854.648721076749, 5719.542436605062, 5848.473637372657, 5897.056470964625, 5915.733791979371, 5977.462028417463, 5868.383819698955, 5868.9706551467825, 5875.059990401515, 5877.441643043904, 5907.084401917709, 5848.5321174305955, 5884.176215329857, 5892.941070589325, 5906.143609176645, 5915.7633694652595, 4465.419495465569, 4480.484744254452, 4527.0, 4528.909421811545, 4531.071130418256, 4007.8196481158416, 4027.0, 4029.315016447211, 4030.5163380394542, 4062.8374865005067, 5583.69289689071, 5594.021046316879, 5604.41153678866, 5605.355384130877, 5637.9718101409235, 5842.707864606753, 5877.971355012855, 5890.381509941394, 5918.0, 5938.228030356113, 5638.577106717013, 5641.012822756002, 5647.265855438766, 5668.943310566924, 5690.573207009491, 5093.9745301274, 5104.157813960729, 5109.591232701449, 5143.099957507496, 5164.122099243138, 5758.0, 5878.147668588116, 5929.970350148395, 6024.457798798129, 6061.54538409621, 5909.0, 6002.489788368038, 6010.248718910137, 6044.697765111639, 6051.031834906394, 6105.45050945417, 6108.35862234459, 6109.725062372115, 6111.7249723763425, 6129.785457508966, 5689.459501347365, 5708.115242137475, 5792.073268277056, 5852.0, 5871.970640146772, 5890.087036509348, 5944.4352786485215, 5974.701264936823, 6016.157737916607, 6054.39456054391, 5870.119482077552, 5871.119332100219, 5872.647641141545, 5875.383084776037, 5884.823455296348, 5567.832965011056, 5872.0, 5879.353271140086, 5881.088431293157, 5891.410858914246, 5512.80705175317, 5776.884462310646, 5793.913091303718, 5813.970930145491, 5911.054231322968, 5836.037053886062, 5874.794382196603, 5878.794242201502, 5882.735276912464, 5925.377835327228, 5542.61201715876, 5601.859953501195, 5722.712389712281, 5780.757137215519, 5784.2769653793275], "value": 5453.961957501705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8032069096506, 604.5012864386881, 622.8193823791103, 632.1907957814, 647.258888572584, 33214.83748068815, 45989.31016034758, 47326.52673473269, 47462.52537474624, 47543.76228118863, 47904.520954790445, 48627.75686121565, 48629.0, 48698.51301486984, 48704.756476217655, 8411.621477033548, 9402.247820174369, 9539.141477267045, 9543.236541076698, 9575.808483830318, 8559.657613695445, 10921.508532116073, 11266.830997535002, 11287.548498060069, 11623.825642615368, 11370.886291137065, 11486.540538378455, 11563.884361156364, 11577.6526704199, 11578.189526733133, 11286.153538484605, 11331.603393881256, 11332.150088743378, 11349.943250283779, 11371.488283027242, 11109.166812489095, 11160.386178760165, 11170.162237832114, 11171.050460710849, 11181.888181118247, 46230.30654540184, 46428.0, 46502.53497465016, 46597.0, 46647.30029049567, 3675.7426980111404, 3680.723945704056, 3683.4658974448553, 3691.446283057563, 3724.6647801697704, 33986.0, 34024.0, 34272.48591271108, 34860.12849678778, 35365.64634353675, 4657.930131048037, 4686.6485013624115, 4731.787069581877, 4754.429468463806, 4762.595179409755, 348319.0, 348902.0, 350854.0, 353474.0, 354342.0, 63251.683741581, 63351.0, 63550.0, 63651.0, 63658.363416365246, 37128.44307335392, 37569.43645845314, 37607.0, 37632.24735505274, 66016.0, 18340.908295458703, 18346.174422151034, 18461.815381846278, 18473.353432629792, 18495.260189592536, 12900.483980640856, 13000.739985200244, 14477.697007269397, 14823.407063717546, 15004.549863504113, 19678.606427871364, 20589.455790815748, 20678.035586619248, 20726.54914156025, 20776.58446831055, 7013.26360732126, 7208.423326134001, 7232.349088582053, 7240.4569657275915, 7299.197088320387, 940.7695114696943, 1006.7030226083323, 1046.5186014433446, 1059.4596755654673, 1108.3571528513603, 33624.83187584095, 34060.48909266363, 34100.31799363999, 34260.666160182314, 34795.30409391798, 1084.360227465799, 1105.8894110589038, 1160.6169963911889, 1170.4615876696644, 1262.2237324045645, 16599.50201493933, 16872.578185545215, 17595.472135835946, 17691.73462398065, 17927.551811204823, 554430.0, 554788.0, 558660.0, 558942.0, 561174.0, 60242.0, 60640.0, 60761.696191519644, 60764.0, 60820.0, 1233.2600439736086, 1334.6129622409392, 1365.5357178559339, 1383.875451209396, 1389.9783659010618, 31165.844170779, 35220.64779352173, 35302.29395412129, 35533.64466355303, 35824.46263306, 52125.0, 52829.0, 52979.0, 52979.47020529745, 52982.0, 420786.0, 420909.0, 421661.0, 422023.0, 422538.0, 30388.544171837882, 31537.0, 31561.21096972594, 31607.525887112173, 31624.209394764395, 50108.24837627366, 50136.74931625318, 50349.0, 50845.237321440945, 51272.230916537024, 42835.78582107194, 42837.14325713531, 43476.565234347254, 44264.55735442733, 45282.547174527834, 42114.1577168461, 42244.15511689687, 42642.57357426386, 42954.57045429631, 42978.78510607427, 41734.791326043174, 42008.78995605002, 42245.0, 42869.14261714811, 43434.0, 35216.0, 37391.62608373881, 37435.62564374322, 37447.0, 37564.24871502609, 28480.02879093079, 28520.14439566816, 29331.266718332212, 29335.266618334714, 29402.0], "value": 21297.439337856023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.71087395327464, 413.46662804981577, 424.29143330637834, 435.79735423028285, 439.6768375244197, 14453.566393008214, 16035.198240088008, 19781.901090494564, 20396.0, 21120.260790872322, 19578.60842783147, 19824.405267841987, 20263.290784822533, 20409.285675001378, 20418.183272669114, 5767.625104368202, 5811.128330750379, 5857.384974577651, 5894.056950887859, 5910.320313163998, 4262.126264115849, 5779.855503612402, 5867.7066146692705, 5876.70616469177, 5893.58744887858, 4441.777911104448, 6229.345918678541, 6460.127882735841, 6489.545731798776, 6624.205095388536, 6328.367163283658, 6521.641309727963, 6560.507961902828, 6572.178477690289, 6594.58216483456, 5837.708114594253, 5839.386864379221, 5846.473817356416, 5846.824595262106, 5848.327442344143, 23417.0, 23997.880010599834, 24020.63969040466, 24077.0, 24294.757052429428, 2509.146890057371, 2532.468181681849, 2590.106413287413, 2780.7914406419395, 2901.956470652942, 14868.330925108396, 14889.627759305995, 14940.701185976328, 15490.0, 15645.608859778482, 1903.7049257364993, 1923.0769230769308, 1954.5016020914718, 1965.8132477414622, 1981.197614965941, 81256.0, 81330.59334703347, 81341.59329203375, 83526.16473835305, 84011.5799420999, 10682.252242342962, 10894.910508949042, 10950.835737463944, 11269.492872820743, 11330.886691132982, 14875.702485950436, 14893.77659335111, 14896.478623248351, 14911.776323355158, 14914.627134321512, 8398.664053437795, 8573.957130214434, 8600.354973377021, 8655.26430253423, 8794.560271986504, 8576.442531235574, 8591.097934716765, 8649.654013839501, 8819.867701984474, 8837.425567338103, 6656.201255849329, 6712.127423434922, 6714.194296684429, 6778.864422711518, 6924.792256232321, 1807.205261607911, 1977.6440240756801, 1995.600879824041, 1996.9800301996795, 2021.7877122901884, 927.6706769097009, 1069.5454431866426, 1075.7575000874003, 1082.9298937512083, 1112.9666110016713, 12443.440045197987, 20139.39581812548, 20162.89918550398, 20282.0, 20554.897225513778, 483.3692031898406, 498.2238320387878, 509.22851879402737, 509.72220140023774, 522.115015049495, 6179.938200618026, 6443.420092191725, 6471.5146364022885, 6748.0, 6764.425023872927, 509445.0, 518024.0, 522386.0, 543424.0, 545092.0, 96858.0, 97787.0, 98928.50535747275, 99120.0, 100237.0, 531.5747402078322, 540.7053156029973, 542.0487045235665, 544.0967993131383, 544.5643485211815, 11523.711907202052, 11651.825222621837, 11653.184277100861, 11838.28970261787, 11856.288622682667, 40479.0, 40691.18617627572, 41055.79472102621, 41854.95362615959, 42627.360589590564, 57482.0, 58405.0, 58681.4131858693, 59370.40629593821, 59980.400195997485, 9114.361994660576, 9165.358424910191, 9218.861717074384, 9287.535623218677, 9440.811183776423, 10075.89924100779, 11964.46159922823, 12680.619581412573, 12689.111762176559, 12960.222386656453, 11013.779724405307, 11218.775624487302, 11369.0, 11448.656540303804, 11542.480588373375, 11376.715582110513, 12135.08986825974, 12163.209391389531, 12210.938945305217, 12491.188072775241, 11191.38447385369, 11228.382438965935, 11236.775264494501, 11369.204155709022, 11476.540938362707, 9453.43279403238, 9459.148676619137, 9463.2429405646, 9598.817630400488, 9660.37207581505, 11409.828852567052, 11747.706307342385, 11876.615164678025, 12156.149069565046, 12170.939145304572], "value": 9069.92596400516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.4181040299484, 1534.2405509272908, 1644.4408900973667, 1785.1609743420588, 1812.048674445915, 8524.659013639455, 9170.541472926352, 9177.632894684204, 9191.17279444849, 9208.67769628063, 7810.414218933574, 7979.321757650607, 8607.526586037766, 8810.207081362676, 8858.424202426837, 2453.521563295158, 2478.8968908835577, 2486.987565062181, 2488.129154795825, 2491.4394261291245, 2420.5521978434044, 2485.72657007729, 2494.787943024845, 2497.825152239344, 2505.6366826810104, 2410.517896420714, 2443.462438263588, 2503.68703912011, 2504.27376060943, 2508.598624220125, 2439.524292762912, 2449.179524859165, 2457.9016839326405, 2488.1913378151994, 2489.191012920808, 2389.6415537669313, 2400.207931382657, 2412.2039726890084, 2416.782489575929, 2434.050720219116, 8958.328125390557, 9030.232430243437, 9052.637894484213, 9062.546872656407, 9078.954605226998, 5425.267588875491, 5584.274044374246, 5598.44015598441, 5603.523700485463, 5614.859628509279, 3396.707455594288, 3436.914077148066, 3516.542849429558, 3518.138056176253, 3534.8232588370734, 1181.6632259805915, 1221.8533775946855, 1229.170310040719, 1254.680056585574, 1284.267967258663, 12496.187747796364, 12530.874691253062, 12555.937220313932, 12569.0, 12608.11743177978, 4774.188387974053, 4836.0, 4870.683405578626, 4944.53026962438, 5040.697558146523, 10587.947060264649, 10590.735231619117, 10596.152307815357, 10601.151907847508, 10602.469876506144, 5511.53151982078, 5513.338399392099, 5574.60977731563, 5581.860453488614, 5582.553395728413, 4437.0, 4591.242444996538, 4961.975190124099, 5042.873928151752, 5071.771770270347, 4202.70581059329, 4227.767472788964, 4282.892927676833, 4310.719803212781, 4318.956810431919, 1330.760463116629, 1333.48660765604, 1353.4315587453293, 1358.6875018745743, 1361.6391656211113, 807.7520231242744, 860.2472836268265, 965.2181732796317, 986.590564915552, 1014.9492525373702, 5798.797042103506, 6037.0, 6177.7837775677635, 6180.289266734293, 6221.564490485713, 498.3446767500797, 503.2828219786789, 508.2274942088006, 513.8561202863204, 533.0325459291452, 4149.896252593649, 4153.54311025787, 4253.2769429197115, 4253.914921701548, 4264.914701705949, 10909.781804363869, 11239.932206440375, 11344.149188810872, 11373.545058197746, 11375.488103035383, 10232.437215953045, 11242.325460472235, 11285.266457680225, 11291.322520648788, 11297.435128243555, 8236.752897412967, 8608.48349099056, 8609.61256743448, 8612.741617751477, 8613.052564217931, 5892.499137573354, 5899.085641725539, 6090.665013424127, 6140.355262697352, 6159.23009623797, 9707.611695532381, 10323.741906452398, 10515.106215971728, 10527.0, 10527.263091583516, 10221.897781022391, 10401.58393664245, 10448.268621196747, 10515.894841051491, 10556.472176391304, 7081.681324340314, 7201.3518783309755, 7830.2952734254195, 7984.92015079865, 8167.264946154874, 8734.91265087341, 8836.337274704552, 8839.558022098998, 8918.86621700688, 8967.237784788365, 6684.665766711548, 7577.0907491099215, 7730.574818385043, 7961.641726122222, 8069.7175598853755, 7816.882746758917, 7852.568108754073, 7900.762977110696, 7918.881216781638, 8151.714689986059, 6689.799306020827, 6788.321167883172, 6796.388325050769, 6798.218204906499, 6806.591604503746, 5052.924206136838, 5162.251473536391, 5181.715005674573, 5232.293640358503, 5331.280277162534, 5171.534561889298, 5245.632805703564, 5281.075811732854, 5296.41739408657, 5481.287432633732], "value": 4701.409411080561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.8933930481551, 355.5040718198113, 360.41792505104246, 362.9328574213772, 367.2819637608474, 5505.587080968933, 5538.363088244853, 5543.808081262533, 5564.026295398309, 5604.327480702316, 5168.173092305232, 5241.528262456378, 5329.413764485913, 5355.6251062425645, 5465.562754979602, 4265.424167737347, 4268.530461649216, 4274.1451709658195, 4295.742255464675, 4319.265724826787, 4256.97871510642, 4284.2930916398755, 4291.4850217973735, 4298.570142985708, 4328.761918094504, 3999.5800440953717, 3999.900002499932, 4240.893977650568, 4247.492140290199, 4321.503027151886, 4229.323308270693, 4240.469941257343, 4245.830166793325, 4253.702240843142, 4291.291936830419, 3818.1936276836504, 3829.100161462054, 3832.3485007548784, 3842.346801043829, 3844.826982785781, 5090.032893750175, 5234.502722241381, 5336.626436149471, 5347.010803001457, 5359.035373632744, 4901.534354236342, 4909.705417674951, 4917.901641967176, 4923.409190897115, 4939.110960027194, 5619.909050022471, 5634.887302253973, 5675.716214189274, 5675.836453527058, 5677.886442271173, 4146.0, 4184.8744537663915, 4239.173361194568, 4245.320748680197, 4248.787560621957, 5830.970845145789, 5831.425515110896, 5837.0, 5860.853478663025, 5894.821035792858, 4381.671374646914, 4387.583179597933, 4406.669499787528, 4420.336949457543, 4425.911481770411, 4260.382244574519, 4351.216001439395, 4395.450568678915, 4395.824167033346, 4476.820927162942, 4896.632752543503, 4898.730569818623, 4900.803967841246, 4901.607871370282, 4910.238912968495, 5691.686957217393, 5691.686957217393, 5692.943070569324, 5702.857428564236, 5705.515031222392, 1483.2806089046803, 1506.9150211847452, 1516.1585320147424, 1516.5526169779941, 1528.8241852186918, 980.7352014955922, 1014.4927536231884, 1026.9794604107876, 1074.6990842564094, 1079.7084787107437, 5554.333479982428, 5556.499915007668, 5557.194206839986, 5568.749406276727, 5588.770470496484, 5715.714214289269, 5839.240898683144, 5852.473277405054, 5852.912206316909, 5877.647341159544, 5464.808731694372, 5477.890442191214, 5487.286652735119, 5514.6691198527415, 5549.445055494499, 3074.7540196784203, 3092.4588197065423, 3109.5491153782573, 3111.828849413259, 3117.781755277109, 5706.686132262683, 5873.383294754075, 5876.970615146897, 5915.290165180119, 5981.192539007266, 5854.970725146347, 5889.94110058894, 5941.55438342126, 5942.346341902387, 5971.164037034819, 5677.460641239076, 6003.609765365325, 6004.988328909777, 6008.909866352008, 6024.156618073385, 5750.223719797774, 5754.079347304411, 5762.193292939076, 5773.22061521706, 5822.446867547576, 5640.661560306231, 5658.603897727119, 5676.886462270814, 5706.914396283976, 5785.392533783892, 5627.7467513961155, 5809.796657116981, 5892.939270931273, 5907.586468947133, 5930.822075337746, 4345.326474396347, 4347.673924455742, 4374.7156434832905, 4391.341298805205, 4415.82336706541, 5900.734466948912, 5907.3501914790195, 5912.290525136839, 5923.585349025527, 5924.496417804535, 5632.633878797865, 5689.886202276014, 5699.458551437607, 5718.228039214653, 5762.732198916399, 5672.0, 5687.5449964001955, 5696.430356964271, 5699.777086936016, 5720.74256658443, 5264.657797243167, 5505.421930697379, 5558.666480011212, 5698.4016678249845, 5720.0, 5723.771049157987, 5740.799072032459, 5749.579000494699, 5758.1650660654805, 5759.992001399822, 5497.47773961473, 5627.7467513961155, 5631.8592035199445, 5636.492715655447, 5662.603617746719], "value": 4388.030309331785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.4953154278576, 822.3421262989609, 824.4229039672227, 829.6722794496175, 864.9740507784769, 15622.921885390571, 15940.0, 16226.594335141597, 16317.592060198485, 16407.097609631466, 15436.845631543682, 15512.84487155128, 15651.217439128026, 15756.975796573215, 15777.368905243806, 699.360085521747, 718.0378293087263, 839.5004972041626, 849.558229720545, 881.3874357321664, 871.8169184471237, 873.3319010956624, 873.8033942362981, 874.0996773323487, 875.8642410426394, 918.6876462002917, 922.6401703335705, 922.6862866625346, 922.861570764384, 923.4736200365794, 749.61394881636, 771.2441807029087, 881.801594641207, 908.636545381846, 923.2890674180877, 676.9932300677028, 677.5223467455432, 678.0101052463409, 678.0507289794278, 678.0947435174048, 13165.341732913315, 13188.208707477486, 13193.802092968614, 13203.669908252274, 13213.405396757169, 14563.781543276858, 14850.925745371203, 14889.925550372178, 14936.850631493655, 15141.848581514154, 12614.36928153598, 12694.365281735876, 14068.437262509487, 14185.148891066568, 14584.0, 4569.497355290915, 4601.125786100663, 4640.883977900546, 4700.4359476862655, 4822.324874517571, 82967.5851620744, 84657.57671211666, 85764.0, 86789.56605216934, 87711.0, 11646.94176529112, 11682.76634467323, 11793.469293881795, 11971.0, 12190.939045304716, 20686.172553098007, 20811.68782468264, 20822.0, 20824.37526874166, 20882.477938051365, 8663.436876603, 8690.348223883107, 8829.33779966505, 8925.910740892637, 9040.909590904139, 4781.95218047822, 4855.975720121377, 4898.461169271377, 4998.475160108209, 5120.18077107661, 3346.1969127409734, 3482.3905816482015, 3482.460218666111, 3485.5120283160377, 3485.790852548855, 605.9878802424015, 616.4513582911212, 627.3381582430579, 646.9805905822833, 655.3119224814021, 673.7338751193251, 700.9789706308717, 713.4827250243532, 734.3977938090821, 737.3253473072186, 9057.184853363096, 9171.77070573241, 9567.665131720356, 9720.90279097214, 9850.314339886181, 613.800020959024, 724.8586525627452, 734.9816254593571, 736.37408203027, 739.6782399656166, 4710.8351207707565, 4714.528547145258, 4824.107540105092, 4837.516248375205, 4846.200376937766, 127889.0, 128321.0, 128698.35650821873, 131092.0, 132853.0, 64946.675266623366, 66480.0, 80993.0, 90549.0, 106807.0, 95905.9999999986, 97155.0, 97366.51316743513, 97981.0, 99217.0, 9101.544922753968, 9202.631894724136, 9306.813863722824, 9323.160915517636, 9337.253019758267, 42763.57236427596, 43657.12685746204, 47714.0, 55115.89768204694, 56447.43552564586, 50883.49116508788, 52342.0, 63004.36995629985, 71190.64404677943, 76997.18349107934, 14004.36980335867, 14640.26798660084, 14649.12105273687, 14662.853371466575, 14765.704685906436, 15844.1285729286, 15856.542235953446, 15934.9203253983, 16304.021758694516, 16578.419755308987, 14015.229162395759, 14434.927825360806, 14622.926885365505, 15108.0, 15494.690106198039, 14637.634059148606, 15075.09549427038, 15246.695066098839, 15522.456714014956, 16043.839561604234, 13973.510927117502, 14159.0, 15393.0, 15504.0, 15610.45363412275, 11576.131790115944, 12495.12534122639, 12542.372881356077, 12888.806667900177, 13200.14199077057, 12349.506019759108, 12353.197042192229, 12374.13381063317, 12715.491380344683, 13008.544700935421], "value": 7849.959405179073, "unit": "score"}], "name": "dromaeo_css", "value": 7447.4712632783, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 113.0, 112.0, 113.0, 112.0, 114.0, 111.0, 111.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 121.0, 168.0, 123.0, 124.0, 118.0, 123.0, 146.0, 118.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 161.0, 164.0, 160.0, 163.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 106.0, 76.0, 76.0, 76.0, 76.0, 97.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 119.0, 81.0, 82.0, 82.0, 104.0, 81.0, 81.0, 113.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 118.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 149.0, 147.0, 146.0, 146.0, 148.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 49.0, 49.0, 50.0, 49.0, 48.0, 49.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 79.0, 73.0, 74.0, 74.0, 75.0, 74.0, 74.0, 75.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 125.0, 128.0, 124.0, 131.0, 123.0, 130.0, 165.0, 134.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 156.0, 153.0, 156.0, 155.0, 156.0, 151.0, 156.0, 160.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 64.0, 63.0, 64.0, 64.0, 65.0, 61.0, 63.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1472.1, "alertThreshold": 2.0}]} 08:49:43 INFO - Return code: 0 08:49:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:49:43 INFO - # TBPL SUCCESS # 08:49:43 INFO - Running post-action listener: _resource_record_post_action 08:49:43 INFO - [mozharness: 2016-10-25 15:49:43.945932Z] Finished run-tests step (success) 08:49:43 INFO - Running post-run listener: _resource_record_post_run 08:49:44 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363130880; Read time: 8; Write time: 181624 08:49:44 INFO - TinderboxPrint: CPU usage
12.9% 08:49:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:49:44 INFO - TinderboxPrint: I/O write bytes / time
363,130,880 / 181,624 08:49:44 INFO - TinderboxPrint: CPU idle
8,251.1 (87.0%) 08:49:44 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 08:49:44 INFO - TinderboxPrint: Swap in / out
0 / 0 08:49:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124063744; Read time: 0; Write time: 71864 08:49:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 238174208; Read time: 0; Write time: 109736 08:49:44 INFO - Running post-run listener: _upload_blobber_files 08:49:44 INFO - Blob upload gear active. 08:49:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:49:44 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 08:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:49:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:49:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:49:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:49 INFO - (blobuploader) - INFO - Done attempting. 08:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:50 INFO - (blobuploader) - INFO - Done attempting. 08:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:51 INFO - (blobuploader) - INFO - Done attempting. 08:49:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:51 INFO - Return code: 0 08:49:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5e01f489e803cab72f1bada0f656c6e3767c464a7df147875d686399d107bbb05795e98742fe71fe946e32db008e026001b30abd015758ee9826345a113740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79297be2321eee5d6f59e527a38c50cf5bddde406d0be50ee91891815f99f38d585d34a4d3c71301062c9c8d5eece9bc63211a586b46ed8b6b78c8adc717dbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1d83882ce6cda470b1cb54723cf7dc6aebf7bd7735e765020483b2be3aeda7612a2116a217cc19ee1e58412a44de975431404038b8744c04a5baacfd5dd0011"} 08:49:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:51 INFO - Contents: 08:49:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5e01f489e803cab72f1bada0f656c6e3767c464a7df147875d686399d107bbb05795e98742fe71fe946e32db008e026001b30abd015758ee9826345a113740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79297be2321eee5d6f59e527a38c50cf5bddde406d0be50ee91891815f99f38d585d34a4d3c71301062c9c8d5eece9bc63211a586b46ed8b6b78c8adc717dbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1d83882ce6cda470b1cb54723cf7dc6aebf7bd7735e765020483b2be3aeda7612a2116a217cc19ee1e58412a44de975431404038b8744c04a5baacfd5dd0011"} 08:49:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:51 INFO - Copying logs to upload dir... 08:49:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.721758 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-25 08:49:50.732210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 08:49:50.735910) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5e01f489e803cab72f1bada0f656c6e3767c464a7df147875d686399d107bbb05795e98742fe71fe946e32db008e026001b30abd015758ee9826345a113740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79297be2321eee5d6f59e527a38c50cf5bddde406d0be50ee91891815f99f38d585d34a4d3c71301062c9c8d5eece9bc63211a586b46ed8b6b78c8adc717dbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1d83882ce6cda470b1cb54723cf7dc6aebf7bd7735e765020483b2be3aeda7612a2116a217cc19ee1e58412a44de975431404038b8744c04a5baacfd5dd0011"} build_url:https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/I1nF2WS_R8WfUG8xJMzArQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5e01f489e803cab72f1bada0f656c6e3767c464a7df147875d686399d107bbb05795e98742fe71fe946e32db008e026001b30abd015758ee9826345a113740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/79297be2321eee5d6f59e527a38c50cf5bddde406d0be50ee91891815f99f38d585d34a4d3c71301062c9c8d5eece9bc63211a586b46ed8b6b78c8adc717dbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1d83882ce6cda470b1cb54723cf7dc6aebf7bd7735e765020483b2be3aeda7612a2116a217cc19ee1e58412a44de975431404038b8744c04a5baacfd5dd0011"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 08:49:50.761191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:49:50.761510) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1477408838.568-877609031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:49:50.846266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 08:49:50.846587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 08:49:50.846872) ========= ========= Total master_lag: 0.18 =========