builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1474582409.91 results: success (0) buildid: 20160922123043 builduid: 61d54a57437d44a4a0c32e1a7ec4823d revision: dae8eaf6a289d6f3710a3a02b9f5566ce310139e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:29.906534) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:29.906918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:29.907204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:29.971243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:29.971528) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 15:13:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.2K=0.2s 2016-09-22 15:13:30 (58.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.295923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:30.281314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:30.281621) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019115 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:30.334060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:30.334835) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev dae8eaf6a289d6f3710a3a02b9f5566ce310139e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev dae8eaf6a289d6f3710a3a02b9f5566ce310139e --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=78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 15:13:31,055 truncating revision to first 12 chars 2016-09-22 15:13:31,055 Setting DEBUG logging. 2016-09-22 15:13:31,055 attempt 1/10 2016-09-22 15:13:31,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/dae8eaf6a289?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 15:13:31,381 unpacking tar archive at: autoland-dae8eaf6a289/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:31.021178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:31.021709) ========= script_repo_revision: dae8eaf6a289d6f3710a3a02b9f5566ce310139e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:31.022371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:31.022883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 15:13:31.034155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-22 15:13:31.034465) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:13:31 INFO - MultiFileLogger online at 20160922 15:13:31 in /builds/slave/test 15:13:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:13:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:13:31 INFO - {'append_to_log': False, 15:13:31 INFO - 'base_work_dir': '/builds/slave/test', 15:13:31 INFO - 'blob_upload_branch': 'Autoland', 15:13:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:13:31 INFO - 'branch': 'Autoland', 15:13:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:13:31 INFO - 'config_files': ('talos/linux_config.py',), 15:13:31 INFO - 'default_actions': ('clobber', 15:13:31 INFO - 'read-buildbot-config', 15:13:31 INFO - 'download-and-extract', 15:13:31 INFO - 'populate-webroot', 15:13:31 INFO - 'create-virtualenv', 15:13:31 INFO - 'install', 15:13:31 INFO - 'run-tests'), 15:13:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:13:31 INFO - 'download_minidump_stackwalk': True, 15:13:31 INFO - 'download_symbols': 'ondemand', 15:13:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:13:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:13:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:13:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:13:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:13:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:13:31 INFO - 'installer_path': 'installer.exe', 15:13:31 INFO - 'log_level': 'info', 15:13:31 INFO - 'log_name': 'talos', 15:13:31 INFO - 'log_to_console': True, 15:13:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:13:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:13:31 INFO - 'opt_config_files': (), 15:13:31 INFO - 'pip_index': False, 15:13:31 INFO - 'sps_profile': False, 15:13:31 INFO - 'sps_profile_interval': 0, 15:13:31 INFO - 'suite': 'dromaeojs', 15:13:31 INFO - 'system_bits': '32', 15:13:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:13:31 INFO - 'title': 'talos-linux64-ix-019', 15:13:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:13:31 INFO - 'use_talos_json': True, 15:13:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:13:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:13:31 INFO - 'work_dir': 'build'} 15:13:31 INFO - [mozharness: 2016-09-22 22:13:31.850250Z] Running clobber step. 15:13:31 INFO - Running pre-action listener: _resource_record_pre_action 15:13:31 INFO - Running main action method: clobber 15:13:31 INFO - rmtree: /builds/slave/test/build 15:13:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:13:32 INFO - Running post-action listener: _resource_record_post_action 15:13:32 INFO - [mozharness: 2016-09-22 22:13:32.310006Z] Finished clobber step (success) 15:13:32 INFO - [mozharness: 2016-09-22 22:13:32.310106Z] Running read-buildbot-config step. 15:13:32 INFO - Running pre-action listener: _resource_record_pre_action 15:13:32 INFO - Running main action method: read_buildbot_config 15:13:32 INFO - Using buildbot properties: 15:13:32 INFO - { 15:13:32 INFO - "project": "", 15:13:32 INFO - "product": "firefox", 15:13:32 INFO - "script_repo_revision": "production", 15:13:32 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:13:32 INFO - "repository": "", 15:13:32 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 15:13:32 INFO - "buildid": "20160922123043", 15:13:32 INFO - "pgo_build": "True", 15:13:32 INFO - "basedir": "/builds/slave/test", 15:13:32 INFO - "buildnumber": 248, 15:13:32 INFO - "slavename": "talos-linux64-ix-019", 15:13:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:13:32 INFO - "platform": "ubuntu64_hw", 15:13:32 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:13:32 INFO - "branch": "autoland", 15:13:32 INFO - "repo_path": "integration/autoland", 15:13:32 INFO - "revision": "dae8eaf6a289d6f3710a3a02b9f5566ce310139e", 15:13:32 INFO - "stage_platform": "linux64-pgo", 15:13:32 INFO - "builduid": "61d54a57437d44a4a0c32e1a7ec4823d", 15:13:32 INFO - "slavebuilddir": "test" 15:13:32 INFO - } 15:13:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:13:32 INFO - Running post-action listener: _resource_record_post_action 15:13:32 INFO - [mozharness: 2016-09-22 22:13:32.312522Z] Finished read-buildbot-config step (success) 15:13:32 INFO - [mozharness: 2016-09-22 22:13:32.312611Z] Running download-and-extract step. 15:13:32 INFO - Running pre-action listener: _resource_record_pre_action 15:13:32 INFO - Running main action method: download_and_extract 15:13:32 INFO - mkdir: /builds/slave/test/build/tests 15:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:32 INFO - trying https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:13:32 INFO - Downloading https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:13:32 INFO - Downloaded 1361 bytes. 15:13:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:13:32 INFO - Using the following test package requirements: 15:13:32 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:13:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:13:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'jsshell-linux-x86_64.zip'], 15:13:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:13:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:13:32 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:13:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:13:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:13:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:13:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:13:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:13:32 INFO - Fetch https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:13:33 INFO - Expected file size: 21943839 15:13:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:13:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:13:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:13:37 INFO - Fetch https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:13:38 INFO - Expected file size: 21943839 15:13:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:13:42 INFO - Fetch https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:13:43 INFO - Expected file size: 14414059 15:13: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')]} 15:13:43 INFO - trying https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:43 INFO - Downloading https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:13:45 INFO - Downloaded 59619770 bytes. 15:13:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:45 INFO - mkdir: /builds/slave/test/properties 15:13:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:45 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:45 INFO - Contents: 15:13:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:46 INFO - Running post-action listener: _resource_record_post_action 15:13:46 INFO - Running post-action listener: set_extra_try_arguments 15:13:46 INFO - [mozharness: 2016-09-22 22:13:46.457456Z] Finished download-and-extract step (success) 15:13:46 INFO - [mozharness: 2016-09-22 22:13:46.457688Z] Running populate-webroot step. 15:13:46 INFO - Running pre-action listener: _resource_record_pre_action 15:13:46 INFO - Running main action method: populate_webroot 15:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:46 INFO - '--tppagecycles', 15:13:46 INFO - '7'], 15:13:46 INFO - 'tests': ['tsvgm']}}, 15:13:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:13:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:13:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:13:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['damp', 'tps']}, 15:13:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'tests': ['damp', 'tps']}, 15:13:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['dromaeo_dom']}, 15:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['basic_compositor_video']}, 15:13:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:13:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['a11yr', 15:13:46 INFO - 'ts_paint', 15:13:46 INFO - 'tpaint', 15:13:46 INFO - 'sessionrestore', 15:13:46 INFO - 'sessionrestore_no_auto_restore', 15:13:46 INFO - 'tabpaint']}, 15:13:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tsvgx', 15:13:46 INFO - 'tsvgr_opacity', 15:13:46 INFO - 'tart', 15:13:46 INFO - 'tscrollx', 15:13:46 INFO - 'cart']}, 15:13:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:13:46 INFO - 'tsvgr_opacity', 15:13:46 INFO - 'tart', 15:13:46 INFO - 'tscrollx', 15:13:46 INFO - 'cart']}, 15:13:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s'], 15:13:46 INFO - 'tests': ['tp5o']}, 15:13:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'tests': ['tp5o']}, 15:13:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--disable-e10s', 15:13:46 INFO - '--xperf_path', 15:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:46 INFO - 'tests': ['tp5n']}, 15:13:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:46 INFO - 'talos_options': ['--xperf_path', 15:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:46 INFO - 'tests': ['tp5n']}}, 15:13:46 INFO - 'talos.zip': {'path': '', 15:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:46 INFO - Running post-action listener: _resource_record_post_action 15:13:46 INFO - [mozharness: 2016-09-22 22:13:46.475884Z] Finished populate-webroot step (success) 15:13:46 INFO - [mozharness: 2016-09-22 22:13:46.475972Z] Running create-virtualenv step. 15:13:46 INFO - Running pre-action listener: _resource_record_pre_action 15:13:46 INFO - Running main action method: create_virtualenv 15:13:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:46 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 15:13:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:46 INFO - Using real prefix '/usr' 15:13:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:49 INFO - Installing pip.................done. 15:13:49 INFO - Return code: 0 15:13:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:13:49 INFO - Using env: {'DISPLAY': ':0', 15:13:49 INFO - 'HOME': '/home/cltbld', 15:13:49 INFO - 'LANG': 'en_US.UTF-8', 15:13:49 INFO - 'LANGUAGE': 'en_US:en', 15:13:49 INFO - 'LOGNAME': 'cltbld', 15:13:49 INFO - 'MAIL': '/var/mail/cltbld', 15:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:49 INFO - 'MOZ_NO_REMOTE': '1', 15:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:49 INFO - 'NO_EM_RESTART': '1', 15:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:49 INFO - 'PWD': '/builds/slave/test', 15:13:49 INFO - 'SHELL': '/bin/bash', 15:13:49 INFO - 'SHLVL': '1', 15:13:49 INFO - 'TERM': 'linux', 15:13:49 INFO - 'TMOUT': '86400', 15:13:49 INFO - 'USER': 'cltbld', 15:13:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:49 INFO - '_': '/tools/buildbot/bin/python'} 15:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:49 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 15:13:49 INFO - Cleaning up... 15:13:49 INFO - Return code: 0 15:13:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:13:49 INFO - Using env: {'DISPLAY': ':0', 15:13:49 INFO - 'HOME': '/home/cltbld', 15:13:49 INFO - 'LANG': 'en_US.UTF-8', 15:13:49 INFO - 'LANGUAGE': 'en_US:en', 15:13:49 INFO - 'LOGNAME': 'cltbld', 15:13:49 INFO - 'MAIL': '/var/mail/cltbld', 15:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:49 INFO - 'MOZ_NO_REMOTE': '1', 15:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:49 INFO - 'NO_EM_RESTART': '1', 15:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:49 INFO - 'PWD': '/builds/slave/test', 15:13:49 INFO - 'SHELL': '/bin/bash', 15:13:49 INFO - 'SHLVL': '1', 15:13:49 INFO - 'TERM': 'linux', 15:13:49 INFO - 'TMOUT': '86400', 15:13:49 INFO - 'USER': 'cltbld', 15:13:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:49 INFO - '_': '/tools/buildbot/bin/python'} 15:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:49 INFO - Downloading/unpacking psutil>=3.1.1 15:13:49 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 15:13:49 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 15:13:49 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 15:13:49 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 15:13:49 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 15:13:49 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 15:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:51 INFO - Installing collected packages: psutil 15:13:51 INFO - Running setup.py install for psutil 15:13:51 INFO - building 'psutil._psutil_linux' extension 15:13:51 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 15:13:51 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 15:13:51 INFO - building 'psutil._psutil_posix' extension 15:13:51 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 15:13:51 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 15:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:51 INFO - Successfully installed psutil 15:13:51 INFO - Cleaning up... 15:13:52 INFO - Return code: 0 15:13:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:52 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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:13:52 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 15:13:52 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 15:13:52 INFO - Using env: {'DISPLAY': ':0', 15:13:52 INFO - 'HOME': '/home/cltbld', 15:13:52 INFO - 'LANG': 'en_US.UTF-8', 15:13:52 INFO - 'LANGUAGE': 'en_US:en', 15:13:52 INFO - 'LOGNAME': 'cltbld', 15:13:52 INFO - 'MAIL': '/var/mail/cltbld', 15:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:52 INFO - 'MOZ_NO_REMOTE': '1', 15:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:52 INFO - 'NO_EM_RESTART': '1', 15:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:52 INFO - 'PWD': '/builds/slave/test', 15:13:52 INFO - 'SHELL': '/bin/bash', 15:13:52 INFO - 'SHLVL': '1', 15:13:52 INFO - 'TERM': 'linux', 15:13:52 INFO - 'TMOUT': '86400', 15:13:52 INFO - 'USER': 'cltbld', 15:13:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:52 INFO - '_': '/tools/buildbot/bin/python'} 15:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:13:52 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 15:13:52 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 15:13:52 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 15:13:52 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 15:13:52 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 15:13:52 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 15:13:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:13:54 INFO - Installing collected packages: mozsystemmonitor 15:13:54 INFO - Running setup.py install for mozsystemmonitor 15:13:54 INFO - Successfully installed mozsystemmonitor 15:13:54 INFO - Cleaning up... 15:13:54 INFO - Return code: 0 15:13:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:13: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==2.5.1'] in /builds/slave/test/build 15:13: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==2.5.1 15:13:54 INFO - Using env: {'DISPLAY': ':0', 15:13:54 INFO - 'HOME': '/home/cltbld', 15:13:54 INFO - 'LANG': 'en_US.UTF-8', 15:13:54 INFO - 'LANGUAGE': 'en_US:en', 15:13:54 INFO - 'LOGNAME': 'cltbld', 15:13:54 INFO - 'MAIL': '/var/mail/cltbld', 15:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:54 INFO - 'MOZ_NO_REMOTE': '1', 15:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:54 INFO - 'NO_EM_RESTART': '1', 15:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:54 INFO - 'PWD': '/builds/slave/test', 15:13:54 INFO - 'SHELL': '/bin/bash', 15:13:54 INFO - 'SHLVL': '1', 15:13:54 INFO - 'TERM': 'linux', 15:13:54 INFO - 'TMOUT': '86400', 15:13:54 INFO - 'USER': 'cltbld', 15:13:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:54 INFO - '_': '/tools/buildbot/bin/python'} 15:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:54 INFO - Downloading/unpacking jsonschema==2.5.1 15:13:54 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 15:13:54 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 15:13:54 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 15:13:54 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 15:13:54 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 15:13:54 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 15:13:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:56 INFO - warning: no files found matching '*.txt' 15:13:56 INFO - no previously-included directories found matching 'build' 15:13:56 INFO - no previously-included directories found matching 'dist' 15:13:56 INFO - no previously-included directories found matching '.git*' 15:13:56 INFO - Installing collected packages: jsonschema, functools32 15:13:56 INFO - Running setup.py install for functools32 15:13:56 INFO - warning: no files found matching '*.txt' 15:13:56 INFO - no previously-included directories found matching 'build' 15:13:56 INFO - no previously-included directories found matching 'dist' 15:13:56 INFO - no previously-included directories found matching '.git*' 15:13:56 INFO - Successfully installed jsonschema functools32 15:13:56 INFO - Cleaning up... 15:13:56 INFO - Return code: 0 15:13:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:13:56 INFO - Using env: {'DISPLAY': ':0', 15:13:56 INFO - 'HOME': '/home/cltbld', 15:13:56 INFO - 'LANG': 'en_US.UTF-8', 15:13:56 INFO - 'LANGUAGE': 'en_US:en', 15:13:56 INFO - 'LOGNAME': 'cltbld', 15:13:56 INFO - 'MAIL': '/var/mail/cltbld', 15:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:56 INFO - 'MOZ_NO_REMOTE': '1', 15:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:56 INFO - 'NO_EM_RESTART': '1', 15:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:56 INFO - 'PWD': '/builds/slave/test', 15:13:56 INFO - 'SHELL': '/bin/bash', 15:13:56 INFO - 'SHLVL': '1', 15:13:56 INFO - 'TERM': 'linux', 15:13:56 INFO - 'TMOUT': '86400', 15:13:56 INFO - 'USER': 'cltbld', 15:13:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:56 INFO - '_': '/tools/buildbot/bin/python'} 15:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:13:57 INFO - Cleaning up... 15:13:57 INFO - Return code: 0 15:13:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:57 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')]} 15:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:57 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')]} 15:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:57 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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:13:57 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 15:13:57 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 15:13:57 INFO - Using env: {'DISPLAY': ':0', 15:13:57 INFO - 'HOME': '/home/cltbld', 15:13:57 INFO - 'LANG': 'en_US.UTF-8', 15:13:57 INFO - 'LANGUAGE': 'en_US:en', 15:13:57 INFO - 'LOGNAME': 'cltbld', 15:13:57 INFO - 'MAIL': '/var/mail/cltbld', 15:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:57 INFO - 'MOZ_NO_REMOTE': '1', 15:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:57 INFO - 'NO_EM_RESTART': '1', 15:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:57 INFO - 'PWD': '/builds/slave/test', 15:13:57 INFO - 'SHELL': '/bin/bash', 15:13:57 INFO - 'SHLVL': '1', 15:13:57 INFO - 'TERM': 'linux', 15:13:57 INFO - 'TMOUT': '86400', 15:13:57 INFO - 'USER': 'cltbld', 15:13:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:57 INFO - '_': '/tools/buildbot/bin/python'} 15:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:57 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 15:13:57 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 15:13:57 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 15:13:57 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 15:13:57 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 15:13:57 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 15:13:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 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 15:13:59 INFO - Downloading docopt-0.6.1.tar.gz 15:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:59 INFO - Running setup.py install for blobuploader 15:14:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:14:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:14:00 INFO - Running setup.py install for requests 15:14:00 INFO - Running setup.py install for docopt 15:14:00 INFO - Successfully installed blobuploader requests docopt 15:14:00 INFO - Cleaning up... 15:14:00 INFO - Return code: 0 15:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:00 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')]} 15:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:00 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')]} 15:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:00 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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:14:00 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 15:14:00 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 15:14:00 INFO - Using env: {'DISPLAY': ':0', 15:14:00 INFO - 'HOME': '/home/cltbld', 15:14:00 INFO - 'LANG': 'en_US.UTF-8', 15:14:00 INFO - 'LANGUAGE': 'en_US:en', 15:14:00 INFO - 'LOGNAME': 'cltbld', 15:14:00 INFO - 'MAIL': '/var/mail/cltbld', 15:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:00 INFO - 'MOZ_NO_REMOTE': '1', 15:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:00 INFO - 'NO_EM_RESTART': '1', 15:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:00 INFO - 'PWD': '/builds/slave/test', 15:14:00 INFO - 'SHELL': '/bin/bash', 15:14:00 INFO - 'SHLVL': '1', 15:14:00 INFO - 'TERM': 'linux', 15:14:00 INFO - 'TMOUT': '86400', 15:14:00 INFO - 'USER': 'cltbld', 15:14:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:00 INFO - '_': '/tools/buildbot/bin/python'} 15:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:00 INFO - Running setup.py (path:/tmp/pip-1kpfBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:00 INFO - Running setup.py (path:/tmp/pip-efc1ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:00 INFO - Running setup.py (path:/tmp/pip-u9YYaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:01 INFO - Running setup.py (path:/tmp/pip-PCfvXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:01 INFO - Running setup.py (path:/tmp/pip-Rukryl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:01 INFO - Running setup.py (path:/tmp/pip-0o440f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:01 INFO - Running setup.py (path:/tmp/pip-LX4Ez5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:01 INFO - Running setup.py (path:/tmp/pip-6SiwM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:01 INFO - Running setup.py (path:/tmp/pip-H4buC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:01 INFO - Running setup.py (path:/tmp/pip-0SLeiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:01 INFO - Running setup.py (path:/tmp/pip-x2g7Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:01 INFO - Running setup.py (path:/tmp/pip-F5tZD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:01 INFO - Running setup.py (path:/tmp/pip-0x6RSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:01 INFO - Running setup.py (path:/tmp/pip-fQS5Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:01 INFO - Running setup.py (path:/tmp/pip-vWpdRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:01 INFO - Running setup.py (path:/tmp/pip-bOucIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:01 INFO - Running setup.py (path:/tmp/pip-Nrl075-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:02 INFO - Running setup.py install for manifestparser 15:14:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozcrash 15:14:02 INFO - Running setup.py install for mozdebug 15:14:02 INFO - Running setup.py install for mozdevice 15:14:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozfile 15:14:02 INFO - Running setup.py install for mozhttpd 15:14:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozinfo 15:14:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozInstall 15:14:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozleak 15:14:02 INFO - Running setup.py install for mozlog 15:14:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Running setup.py install for moznetwork 15:14:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Running setup.py install for mozprocess 15:14:03 INFO - Running setup.py install for mozprofile 15:14:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Running setup.py install for mozrunner 15:14:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Running setup.py install for mozscreenshot 15:14:03 INFO - Running setup.py install for moztest 15:14:03 INFO - Running setup.py install for mozversion 15:14:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:03 INFO - Cleaning up... 15:14:03 INFO - Return code: 0 15:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:03 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')]} 15:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:03 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')]} 15:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:03 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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:14:03 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 15:14:03 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 15:14:03 INFO - Using env: {'DISPLAY': ':0', 15:14:03 INFO - 'HOME': '/home/cltbld', 15:14:03 INFO - 'LANG': 'en_US.UTF-8', 15:14:03 INFO - 'LANGUAGE': 'en_US:en', 15:14:03 INFO - 'LOGNAME': 'cltbld', 15:14:03 INFO - 'MAIL': '/var/mail/cltbld', 15:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:03 INFO - 'MOZ_NO_REMOTE': '1', 15:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:03 INFO - 'NO_EM_RESTART': '1', 15:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:03 INFO - 'PWD': '/builds/slave/test', 15:14:03 INFO - 'SHELL': '/bin/bash', 15:14:03 INFO - 'SHLVL': '1', 15:14:03 INFO - 'TERM': 'linux', 15:14:03 INFO - 'TMOUT': '86400', 15:14:03 INFO - 'USER': 'cltbld', 15:14:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:03 INFO - '_': '/tools/buildbot/bin/python'} 15:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:04 INFO - Running setup.py (path:/tmp/pip-qmC4Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:04 INFO - Running setup.py (path:/tmp/pip-uKh953-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:04 INFO - Running setup.py (path:/tmp/pip-lYmsPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:04 INFO - Running setup.py (path:/tmp/pip-6MCkow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:04 INFO - Running setup.py (path:/tmp/pip-1pmxOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:04 INFO - Running setup.py (path:/tmp/pip-UHEJi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:04 INFO - Running setup.py (path:/tmp/pip-ESxvoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:04 INFO - Running setup.py (path:/tmp/pip-jz9JoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:04 INFO - Running setup.py (path:/tmp/pip-sAMzyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:04 INFO - Running setup.py (path:/tmp/pip-3oP9DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:04 INFO - Running setup.py (path:/tmp/pip-MmLzhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:04 INFO - Running setup.py (path:/tmp/pip-kGmDud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:04 INFO - Running setup.py (path:/tmp/pip-NbEp1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:04 INFO - Running setup.py (path:/tmp/pip-eo7fft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:05 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)) 15:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:05 INFO - Running setup.py (path:/tmp/pip-6Hgv1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:05 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)) 15:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:05 INFO - Running setup.py (path:/tmp/pip-Yhn7Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:05 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)) 15:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:05 INFO - Running setup.py (path:/tmp/pip-fPV5t7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:05 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)) 15:14:05 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)) 15:14:05 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)) 15:14:05 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)) 15:14:05 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)) 15:14:05 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)) 15:14:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14:05 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 15:14:05 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 15:14:05 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 15:14:05 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 15:14:05 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 15:14:05 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 15:14:07 INFO - Downloading blessings-1.6.tar.gz 15:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:07 INFO - Installing collected packages: blessings 15:14:07 INFO - Running setup.py install for blessings 15:14:07 INFO - Successfully installed blessings 15:14:07 INFO - Cleaning up... 15:14:07 INFO - Return code: 0 15:14:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:07 INFO - Reading from file tmpfile_stdout 15:14:07 INFO - Current package versions: 15:14:07 INFO - argparse == 1.2.1 15:14:07 INFO - blessings == 1.6 15:14:07 INFO - blobuploader == 1.2.4 15:14:07 INFO - docopt == 0.6.1 15:14:07 INFO - functools32 == 3.2.3-2 15:14:07 INFO - jsonschema == 2.5.1 15:14:07 INFO - manifestparser == 1.1 15:14:07 INFO - mozInstall == 1.12 15:14:07 INFO - mozcrash == 0.17 15:14:07 INFO - mozdebug == 0.1 15:14:07 INFO - mozdevice == 0.48 15:14:07 INFO - mozfile == 1.2 15:14:07 INFO - mozhttpd == 0.7 15:14:07 INFO - mozinfo == 0.9 15:14:07 INFO - mozleak == 0.1 15:14:07 INFO - mozlog == 3.4 15:14:07 INFO - moznetwork == 0.27 15:14:07 INFO - mozprocess == 0.23 15:14:07 INFO - mozprofile == 0.28 15:14:07 INFO - mozrunner == 6.12 15:14:07 INFO - mozscreenshot == 0.1 15:14:07 INFO - mozsystemmonitor == 0.3 15:14:07 INFO - moztest == 0.7 15:14:07 INFO - mozversion == 1.4 15:14:07 INFO - psutil == 3.1.1 15:14:07 INFO - requests == 1.2.3 15:14:07 INFO - wsgiref == 0.1.2 15:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:07 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')]} 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 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')]} 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:14:07 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 15:14:07 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 15:14:07 INFO - Using env: {'DISPLAY': ':0', 15:14:07 INFO - 'HOME': '/home/cltbld', 15:14:07 INFO - 'LANG': 'en_US.UTF-8', 15:14:07 INFO - 'LANGUAGE': 'en_US:en', 15:14:07 INFO - 'LOGNAME': 'cltbld', 15:14:07 INFO - 'MAIL': '/var/mail/cltbld', 15:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:07 INFO - 'MOZ_NO_REMOTE': '1', 15:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:07 INFO - 'NO_EM_RESTART': '1', 15:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:07 INFO - 'PWD': '/builds/slave/test', 15:14:07 INFO - 'SHELL': '/bin/bash', 15:14:07 INFO - 'SHLVL': '1', 15:14:07 INFO - 'TERM': 'linux', 15:14:07 INFO - 'TMOUT': '86400', 15:14:07 INFO - 'USER': 'cltbld', 15:14:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:07 INFO - '_': '/tools/buildbot/bin/python'} 15:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 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)) 15:14:07 INFO - Cleaning up... 15:14:07 INFO - Return code: 0 15:14:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:14:07 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')]} 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 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')]} 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 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 0x7f84ec94af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', '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 15:14:07 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 15:14:07 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 15:14:07 INFO - Using env: {'DISPLAY': ':0', 15:14:07 INFO - 'HOME': '/home/cltbld', 15:14:07 INFO - 'LANG': 'en_US.UTF-8', 15:14:07 INFO - 'LANGUAGE': 'en_US:en', 15:14:07 INFO - 'LOGNAME': 'cltbld', 15:14:07 INFO - 'MAIL': '/var/mail/cltbld', 15:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:07 INFO - 'MOZ_NO_REMOTE': '1', 15:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:07 INFO - 'NO_EM_RESTART': '1', 15:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:07 INFO - 'PWD': '/builds/slave/test', 15:14:07 INFO - 'SHELL': '/bin/bash', 15:14:07 INFO - 'SHLVL': '1', 15:14:07 INFO - 'TERM': 'linux', 15:14:07 INFO - 'TMOUT': '86400', 15:14:07 INFO - 'USER': 'cltbld', 15:14:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:07 INFO - '_': '/tools/buildbot/bin/python'} 15:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:14:08 INFO - Cleaning up... 15:14:08 INFO - Return code: 0 15:14:08 INFO - Running post-action listener: _resource_record_post_action 15:14:08 INFO - Running post-action listener: _start_resource_monitoring 15:14:08 INFO - Starting resource monitoring. 15:14:08 INFO - [mozharness: 2016-09-22 22:14:08.107243Z] Finished create-virtualenv step (success) 15:14:08 INFO - [mozharness: 2016-09-22 22:14:08.107751Z] Running install step. 15:14:08 INFO - Running pre-action listener: _resource_record_pre_action 15:14:08 INFO - Running main action method: install 15:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:08 INFO - Reading from file tmpfile_stdout 15:14:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:08 INFO - Reading from file tmpfile_stdout 15:14:08 INFO - Output received: 15:14:08 INFO - Usage: mozinstall [options] installer 15:14:08 INFO - Options: 15:14:08 INFO - -h, --help show this help message and exit 15:14:08 INFO - -d DEST, --destination=DEST 15:14:08 INFO - Directory to install application into. [default: 15:14:08 INFO - "/builds/slave/test"] 15:14:08 INFO - --app=APP Application being installed. [default: firefox] 15:14:08 INFO - mkdir: /builds/slave/test/build/application 15:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:14:25 INFO - Reading from file tmpfile_stdout 15:14:25 INFO - Output received: 15:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:14:25 INFO - Running post-action listener: _resource_record_post_action 15:14:25 INFO - [mozharness: 2016-09-22 22:14:25.370555Z] Finished install step (success) 15:14:25 INFO - [mozharness: 2016-09-22 22:14:25.370798Z] Running run-tests step. 15:14:25 INFO - Running pre-action listener: _resource_record_pre_action 15:14:25 INFO - Running main action method: run_tests 15:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:25 INFO - Python 2.7.3 15:14:25 INFO - Return code: 0 15:14:25 INFO - grabbing minidump binary from tooltool 15:14:25 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')]} 15:14:25 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 0x2a3b790>, '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 0x2a3c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:25 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 15:14:25 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 15:14:25 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 15:14:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:25 INFO - Return code: 0 15:14:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:14:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:14:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 15:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 15:14:25 INFO - Using env: {'DISPLAY': ':0', 15:14:25 INFO - 'HOME': '/home/cltbld', 15:14:25 INFO - 'LANG': 'en_US.UTF-8', 15:14:25 INFO - 'LANGUAGE': 'en_US:en', 15:14:25 INFO - 'LOGNAME': 'cltbld', 15:14:25 INFO - 'MAIL': '/var/mail/cltbld', 15:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:25 INFO - 'MOZ_NO_REMOTE': '1', 15:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:25 INFO - 'NO_EM_RESTART': '1', 15:14:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:25 INFO - 'PWD': '/builds/slave/test', 15:14:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:25 INFO - 'SHELL': '/bin/bash', 15:14:25 INFO - 'SHLVL': '1', 15:14:25 INFO - 'TERM': 'linux', 15:14:25 INFO - 'TMOUT': '86400', 15:14:25 INFO - 'USER': 'cltbld', 15:14:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386', 15:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:25 INFO - '_': '/tools/buildbot/bin/python'} 15:14:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 15:14:25 INFO - mozversion application_buildid: 20160922123043 15:14:25 INFO - mozversion application_changeset: dae8eaf6a289d6f3710a3a02b9f5566ce310139e 15:14:25 INFO - mozversion application_display_name: Nightly 15:14:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:25 INFO - mozversion application_name: Firefox 15:14:25 INFO - mozversion application_remotingname: firefox 15:14:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:14:25 INFO - mozversion application_vendor: Mozilla 15:14:25 INFO - mozversion application_version: 52.0a1 15:14:25 INFO - mozversion platform_buildid: 20160922123043 15:14:25 INFO - mozversion platform_changeset: dae8eaf6a289d6f3710a3a02b9f5566ce310139e 15:14:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:14:25 INFO - mozversion platform_version: 52.0a1 15:14:25 INFO - using testdate: 1474582465 15:14:25 INFO - actual date: 1474582465 15:14:25 INFO - starting webserver on 'localhost:44556' 15:14:25 INFO - SUITE-START | Running 2 tests 15:14:25 INFO - TEST-START | dromaeo_css 15:14:25 INFO - operating with platform_type : linux_ 15:14:25 INFO - Initialising browser for dromaeo_css test... 15:14:25 INFO - TEST-INFO | started process 28288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysBeFx/profile http://localhost:44556/getInfo.html) 15:14:30 INFO - PROCESS | 28288 | __metrics Screen width/height:1600/1200 15:14:30 INFO - PROCESS | 28288 | colorDepth:24 15:14:30 INFO - PROCESS | 28288 | Browser inner width/height: 1024/697 15:14:30 INFO - PROCESS | 28288 | __metrics 15:14:30 INFO - PROCESS | 28288 | 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" 15:14:30 INFO - PROCESS | 28288 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:14:31 INFO - PROCESS | 28288 | console.error: PushService: 15:14:31 INFO - PROCESS | 28288 | stateChangeProcessEnqueue: Error transitioning state 15:14:31 INFO - PROCESS | 28288 | UnknownError 15:14:32 INFO - TEST-INFO | 28288: exit 0 15:14:32 INFO - Browser initialized. 15:14:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:32 INFO - TEST-INFO | started process 28373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysBeFx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:44 INFO - PROCESS | 28373 | RSS: Main: 173420544 15:14:44 INFO - PROCESS | 28373 | 15:15:35 INFO - PROCESS | 28373 | 1474582535615 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] 15:17:45 INFO - PROCESS | 28373 | Cycle 1(1): loaded http://localhost:44556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44556/tests/dromaeo/cssquery-ext.html) 15:17:46 INFO - PROCESS | 28373 | RSS: Main: 329707520 15:17:46 INFO - PROCESS | 28373 | 15:20:48 INFO - PROCESS | 28373 | Cycle 1(1): loaded http://localhost:44556/tests/dromaeo/cssquery-ext.html (next: http://localhost:44556/tests/dromaeo/cssquery-jquery.html) 15:20:49 INFO - PROCESS | 28373 | RSS: Main: 264830976 15:20:49 INFO - PROCESS | 28373 | 15:23:51 INFO - PROCESS | 28373 | Cycle 1(1): loaded http://localhost:44556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44556/tests/dromaeo/cssquery-mootools.html) 15:23:52 INFO - PROCESS | 28373 | RSS: Main: 215810048 15:23:52 INFO - PROCESS | 28373 | 15:26:54 INFO - PROCESS | 28373 | Cycle 1(1): loaded http://localhost:44556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44556/tests/dromaeo/cssquery-prototype.html) 15:26:54 INFO - PROCESS | 28373 | RSS: Main: 236044288 15:26:54 INFO - PROCESS | 28373 | 15:29:57 INFO - PROCESS | 28373 | Cycle 1(1): loaded http://localhost:44556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44556/tests/dromaeo/cssquery-yui.html) 15:29:58 INFO - PROCESS | 28373 | RSS: Main: 216936448 15:29:58 INFO - PROCESS | 28373 | 15:33:00 INFO - PROCESS | 28373 | Cycle 1(1): loaded http://localhost:44556/tests/dromaeo/cssquery-yui.html (next: http://localhost:44556/tests/dromaeo/cssquery-dojo.html) 15:33:01 INFO - PROCESS | 28373 | RSS: Main: 304914432 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | __start_tp_report 15:33:01 INFO - PROCESS | 28373 | _x_x_mozilla_page_load 15:33:01 INFO - PROCESS | 28373 | _x_x_mozilla_page_load_details 15:33:01 INFO - PROCESS | 28373 | |i|pagename|runs| 15:33:01 INFO - PROCESS | 28373 | |0;dojo.html;3011.0966709987006;3036.7418769404608;3039.498482750345;3067.095206913963;3085.783995120341;5160.20016897381;5177.922331165036;5266.736663166841;5274.789008439658;5295.0204212220715;5299.814506492274;5303.284056652351;5359.5712343012565;5365;5372.059889519328;4781.3545171401765;4829.806807727687;4864.513548645143;4880.487548807378;4909.288153217782;4935.457099719046;4960.553550180483;4991.550760431561;5005.824796132136;5036.84889453317;4678.461976872669;4702.576768090888;4740.051989602093;4798.184308667535;4885.36490256268;4735.266033764772;4736.8578942631775;4782.569568738795;4799.448063472711;4822.08380407725;4668.976655116703;4705.082508910764;4708.976455117702;4721.858344249678;4760.238361862085;5155.819546315861;5176.896462070775;5192.974035129838;5210.97394513025;5244.39689435716;5575.609707320489;5579.944200557983;5581.079121944874;5625.353084395265;5697.316322041382;5660.066089095294;5661.547076233933;5661.830145095653;5662.009148399014;5686.545076393879;5174.14626586609;5305.1776974569;5313.681179129265;5314.548263397577;5374.731263436813;5675.744591493392;5760.193572899713;5793.420657934173;5801;5896.705164741746;5541.224228607998;5587.078132108157;5596.356419011866;5599.328080630269;5607.803726869622;5644.238027866268;5680.14797780328;5694;5694.914576281359;5717.742701578439;5409.404965453797;5464;5513.365962914236;5561.082421400504;5567.860803479864;5596.356419011784;5598.804041858515;5598.832035038955;5601.467860553241;5657.066584013674;4357.281048627005;4358.4769827620885;4360.847370342086;4401.185780630593;4413.117376524708;3845.1732877430927;3848.288066707668;3881.5342158941107;3887.727859049896;3916.1971795781797;5388.218708287276;5390.0836857734275;5392.325959255093;5434.809781657623;5455.781768729206;5658.660480371191;5702.344230413555;5706.657600543981;5712.314522257356;5713.657180569096;5159.7678104485385;5206.271122042917;5300.284461597635;5372.597055220874;5450.972745136249;4912.017596480719;4944;4952.975235123801;5005.424376196711;5008.549230569266;5817;5852.648841069549;5864.501517370986;5866.266716660418;5866.794662186803;5544.833654990357;5583.330000399978;5681.9147712783515;5698.401667824819;5766.394528574439;5755.769769209185;5831.241938547962;5832.50423713989;5835.066389377679;5895.823125306248;5522.061249587499;5553.8333849984565;5565.053940830149;5567.05360088794;5600.85997850057;5513.779448822002;5561.749721262634;5561.916571251353;5564.1931919870585;5578.748956297058;5420.728963551728;5463.699496527729;5509.201165831012;5519.0893502573235;5611.775528978958;5479.4520547944885;5483.2049352844415;5484.232207491034;5484.7806087757635;5486.451354864482;5486.643368181056;5494.862628434321;5498.092814685692;5503.477169668875;5510.256115424527;5397.487238712316;5452.509274165185;5520.585956053393;5529.557635389078;5576.637518561281;5383.973080134574;5446.809361672323;5453.318335208099;5480.6437581557075;5506.339239291311 15:33:01 INFO - PROCESS | 28373 | |1;ext.html;545.9782677333645;582.4612233683844;587.8941790477712;590.4774274766831;612.0727098445853;31913.680863191363;43563.34654980174;44678.32982505257;44683.329750053694;44728.32907506382;46093.7695311523;46437.535624643744;46445.767771161096;46520.3021954671;46579.99999999991;8995.640174393033;9168.220701240403;9168.679096231634;9173.128552787475;9177.311701622371;8824.382293239476;8910.955445222764;8926.37515373924;8929.642814287421;8930.776730581723;8958.462492250486;9009.189172974431;9012.369134160612;9017.32370072244;9022.323325750562;8918.375713700043;8947.060558641379;8948.910510894906;8956.193942545202;8957.641694332218;8994.595243214071;9059.81880362389;9064.592093355815;9066.138716821892;9067.229285510739;42734;43342;43348.566514334765;43362.78318608387;43374.13251734979;3302.3560405720896;3540.2565461253166;3590.1024743814046;3694.907627309312;3882.913682529367;32754.181145471317;32915.34169316624;33503.6649633503;34384.65615343865;35074.29851402958;4406.6694997874965;4416.514183439819;4427.667924905645;4461.977690111561;4496.3705081288645;339008;339231;339400;339751;339840;53082;54507.18239226415;58963.705181474674;59173.40826591679;59258;60756.69621651952;62471;62512.687436562526;67229.66385168141;67402.6188297759;16591.41930032443;16820.243089061023;16850.32598696063;16895.493135205717;17017.82982170187;11800.58697945585;12061;13197.736045279233;13269;13284.800727989088;17113.315467381413;17553.824461755474;17607.943523388636;17848.375306864196;17979.370722024665;6044.879102417927;6054.878902421927;6060.181875446847;6095.512359011268;6247.156633854463;883.3569560617246;954.4082668745283;972.6547075788135;1046.4663021858908;1059.998301604976;31054.53418198729;31299.217519562193;31307.217319567193;31720.104459383085;31880;1043.7025447747508;1078.148262872322;1079.9902091544432;1115.827046807746;1164.8194529847888;15513.84486155124;16590.336386544644;16711.83288167127;16745.330186792635;17047.65904681924;529278;537311;540046;542499;542910;58734;58773.706131469065;58780;58806.41193588095;59012;1207.9758404831855;1241.6026871401245;1270.314030423561;1349.7840345544862;1360.2858499287952;31526.211844704067;34785;34909.65090349064;35073.47389789104;35094.29811403809;55250.44749552453;55797.721011394686;55850.72074639601;55855.72072139613;55878.72060639671;368218;369668;369695;370391;371951;35826.28347433089;36619.81690091533;38765.6123438762;41982.580174197865;42325.78837105918;47353.52646473629;47522;47772.28341574949;47807.5219247817;49493.752531237114;39972.60027399689;40197.397039043855;40738.79630601828;40831.59168408396;42677.78661106799;40045.1990960185;40366.9908252296;41225;41245.58754412417;41893.37159942542;39409;40118.59881401266;40228.1954360917;40748.388774169005;40900.79549602233;34867.302653947285;36784.26431471409;37151.81424092862;37189.81405092957;38214.808925956306;27913.860430697718;27935;28016;28338.433231334846;28404 15:33:01 INFO - PROCESS | 28373 | |2;jquery.html;368.6718820249976;389.5987133252749;394.18993967396995;397.2313573235789;421.2270483662479;13318.786906258722;15217.163056031914;16120.355185792583;19581.412557623295;20125.496862578442;18323.908380458113;18502;18894.14976326065;18940.71588926164;19295.614087718237;5586.692731899744;5796.739146738407;5809.854753631172;5824.155497452867;5824.24284842972;3957.5053118360206;4146.6268035876765;5670.858228544299;5925.970370148143;7136.75021374252;7472.551646901176;7476.476646634737;7598.582077985736;7602.543847369176;7618.1620021797835;7313.378362839165;7494.437917156235;7503.324700776901;7518.473706840523;7524.8118797029965;7046.224915259318;7246.311600397954;7302.1967583565765;7330;7343.44924130687;24392.268231952894;25897.539733725454;25906;26004.73995260042;26021.73978260231;2564.974350256492;2592.2871210417097;2597.7272386399536;2670.626112344273;3118.2983828638603;15332.923335383251;15858.36566537337;15862.682746345008;16004.119773412458;16698.081605511692;1984.98523998142;2009.6081264153495;2018.5054661608;2046.6111438826724;2083.031535199237;91022.54488727514;92328.2307757446;92483;92597.07402925951;95344.52327738317;16635.16824158787;16905.239264232892;17200.483985480456;17258;17780.288788448317;31323;31435.214119647193;31541.842290788398;31549;31637.683623163935;9741.902580974242;9965.501724913871;10039.799204015879;10085.949570252102;10320.948395257976;8203.71287004952;8327.084770502819;8444.746657600283;8633.740987770378;8692.609882145967;8582.914170858336;8673.262772664395;8787.297016238686;8843.955780221058;8877;2808.9016884408948;3029.348690031654;3116.8753249870206;3221.9838900805817;3375.3586818504405;815.8659463345954;910.3809409601535;961.4759955824093;977.6285011695652;995.5619527407918;17812.821871781376;18902.621947560972;18987.430377088433;19007.714884276746;19195;966.5650457294246;990.4997976022207;998.4658207858761;1026.5637104230673;1030.6650338639972;10120.645777397904;10722.41026743521;10749.946250268855;10767;10777.892221077846;347786;349155;351047;431866;434315;92887;93605;96807.51596241974;97705.5114724436;98218;1006.9295149339476;1012.964546240878;1044.0864243786687;1047.4448542272607;1050.8896565860628;16604.335826566803;16985.320587176375;17314.30742770275;17521.299148033937;18135.909320453313;42568;42738;43259.783701081295;44128.77935610301;44781.55218447774;60816.39183608107;60881.39118608934;60916.39083609107;61438.38561614326;62093.68953155205;7681.807954801175;8573.957130214309;8791.824163516821;8896.555172241491;9098;12899.419526121535;13184.670383240496;13410.262435566137;13419.463221471031;13484.662883427993;11495.712607184887;11678.824817627912;11745.530178793095;11774.646760597196;11793.705157371134;11441.313521188755;11490.597829075943;11514.654560363202;11636;11658.358790266617;11600.6519804406;11618.88381116178;11827.586034488751;11909.583164589198;11958.820617690915;8014.238647328494;8210.507369557607;8248.422610417214;8295.677210381104;8364.330853531825;10786.191035672198;11135.888641113484;11266.324020558794;11532.769344612892;11571 15:33:01 INFO - PROCESS | 28373 | |3;mootools.html;1292.3215311961226;1451.6516036151324;1482.2144263540322;1606.5019843848409;1775.9911200443996;7285.599292038935;8343.207395297444;8606.225439710424;8609.268212201963;8897.555122243879;8692.869606955901;8728.345374096936;8738.03881573028;8754.562271886396;8764.78088047799;2326.9650955235684;2334.4280651240383;2351.4356554426986;2354.223106374901;2366.325597204797;2293.7247530296386;2320.8607483550954;2335.9182428614918;2337.4623836517612;2344.109238489372;2282;2301.7813307735737;2319.7448280689196;2337.1703045418885;2340.4850932794757;2271.579757744806;2292.4498120451053;2293.025464177726;2296.1848543767055;2303.861768293891;2241.215574548895;2254.6956160918394;2254.7068881045525;2258.220913784758;2261.6720575516624;8142.552159631218;8609.096044915257;8769.07924667907;8769.605367758466;8781.692640757543;4882.902341953141;5039.370078740158;5042.268871013683;5051.722155281458;5092.618053645954;3259.103746469716;3367.0908854609365;3393.151712071982;3416.299658569987;3430.485427185917;1189.2567145534042;1222.9327386993712;1223.3149436315691;1233.5805826019107;1244.1415423357855;12035.458404371824;12087.335196564185;12132.514699412013;12134.514619415213;12149.210301330473;4188.434561334242;4348.217320882209;4445.17764213615;4487.618552423015;4500.032493013952;9437.811243775086;9521.714348569554;9580.95209523948;9590.376625519319;9590.952045239868;4894.437139728977;4900.975495122501;4901.926471102936;4903.4606193318705;4904.313396124546;3853.325668008087;3950.9802450987563;4397.472303323621;4494.10117976406;4681.789319480631;3591.6408359163875;3647.9635203648154;3706.6664000240107;3737.570179429346;3769.6418840210135;1141.6289705845634;1152.9423528823693;1193.6419074277683;1195.055905834381;1200.2798321007326;927.0405130689838;927.7402327348353;941.4398432932394;944.8913374961967;968.733598260484;5563.693996830213;5582.469665381782;5696.287964004499;5827.533797296206;6078.240219972504;948.800751842107;965.8020105878419;981.9312648114707;988.17981075707;996.2478328861808;3947.703922205789;4086.244044851712;4150.232207041707;4168.478940132483;4326;10138.949305253427;10414.583416663248;10479.161667066617;10496.370217786956;10854;10626.096781773482;10750.247482676294;10772.353658780497;10774.461276936121;10794;8070.838583228303;8175.182481751896;8178.345732341399;8178.7955301117945;8202.712905048415;5725.370209277059;5987.6108052976415;6035.426634469718;6052.152698622284;6091.8781624366375;9850.60597576089;9906;9929.453880036668;10024.398536087858;10056.54745536438;9704.660336888457;10066.49667516636;10077.949610251902;10332.121769649664;10430.582776688847;6432.678366081584;6615.470762339098;7404.555726656418;7674;7838.294553489985;8184.713535026483;8462.365322600952;8524.957375213084;8530.78673033179;8539.957300213458;7261.201267860425;7574.81062973408;7666.425018123775;7693.769186924401;7811.1017233016655;6967.79096627102;7153.6423178839805;7235.131784185721;7386.852262954603;7442.032535770315;6848.794536163923;6897.137857767779;6924.134483189601;6941.548799328028;6944.236134025152;4876.317315575751;4960.181570041047;4979.0788704089855;4985.7257850817105;5020.774065167149;4879.4388645304825;4908.8772780680765;5020.698758074527;5058.215976523645;5114.693118412758 15:33:01 INFO - PROCESS | 28373 | |4;prototype.html;327.5430774070172;331.3472459255267;338.43143518888274;339.4246751755774;342.8457194262579;5137.306463627409;5295.735213239337;5315;5376.8924621507595;5400.486953739389;5092.236164575306;5213.687178769276;5215.660982036165;5217.921731174036;5262.710635894211;4189.010220145437;4200.0339921818;4203.621674049335;4218.240716670998;4220.767857767822;3987.700922430815;4154;4209.747415155085;4240.575942405766;4255.319148936171;4122.649574786132;4145.875623731293;4150.896227594304;4156.480439945007;4164.792210259021;4143.233501802161;4146.108586653869;4148.43996060534;4149.460570125894;4175.893388252116;3705.7585708787587;3710.9814450927843;3718.5165928429133;3743.419769935664;3744.157564547982;5029.924551131736;5149.871253218662;5161.896762064737;5200.5059519345605;5221.73891305437;4727.66906316558;4733.692309999873;4737.194676904935;4742.668013239075;4744.288356746481;5470.343558772973;5478.424765399655;5492.203630473599;5539.086050801613;5554.2779438673115;3770.454113813323;3976.443297938291;3979.7015223858325;3979.98010009951;4011.237864805707;5743.5118014968775;5751.194832723422;5754.3094828620415;5794.62334948227;5807.854803629901;4107.075907920694;4109.835606575703;4131.566185550534;4133.627973482401;4138.52406973196;3948.7433316834313;4156.605122513356;4163.958360416417;4172.812223449952;4182.163567286555;4751.192297309466;4752.405949256343;4756.976215118972;4772.49888761682;4816.8554943351755;5569.136783798518;5597.384287728347;5597.776088956396;5635.690037048002;5658.660480371191;1323.5169163255343;1354.4379082680578;1413.2297897645808;1434.1825159659102;1435.0170133458614;908.6955869783696;917.9541022948825;932.0632764072064;948.4783369146942;949.0983565612557;4663.927296721773;4681.414823147106;4753.904921901542;4789.784459699322;4790.209615413418;4935.925961110586;4966.975165124223;4972.378452693413;4972.828258611076;4976.552110310089;4546.886327841764;4745.6440766942615;4748.4539277982785;4750.596199323097;4761.428628564525;2624.42262702209;2648.602709593538;2648.8278261912915;2666.5333566625764;2677.9555973170477;5161.406438259648;5161.483851614808;5161.974190129025;5168.9741551292;5206.56819374675;4675.521973354128;4957.20684690455;5018.4730603286125;5076.898462030738;5082.847514574569;5017.745563609098;5033.395992480926;5077.416097148801;5086.643934924594;5120.18077107661;5006.824761133343;5021.297018417352;5021.748912554431;5048;5059.16523773588;4928.211486162197;4989.376327959005;4989.476105008922;5239.764210610456;5663.2071509989455;5836.474717275466;5898.675572843535;5899.941000589939;5902.763889444546;5913.349531551612;4098.8360465581045;4130.277201489787;4143.109231515239;4159.854405095807;4177.874663760092;5340.198970154508;5673.744681489426;5673.751774609579;5685.374608792947;5814.970925145347;5415.729213539386;5444.210589464585;5606.187102870143;5612.747426365905;5619.325680918316;5550.361708403585;5598.384177740527;5608.355039170548;5608.775648973995;5618.578606604603;5378.149580722224;5536.667799932017;5548.750306236309;5566.8866226754;5575.9163612545035;5590.413006634245;5602.327720673546;5647.632903861236;5651.689157096234;5686.488216060575;5462.945370546244;5508.421615730291;5529.4470552945995;5531.363893152339;5559.138333558305 15:33:01 INFO - PROCESS | 28373 | |5;yui.html;750.2759836757527;821.9383546234034;825.7852958230862;826.9751907442779;834.1450013735923;14650.413983440663;16058.75911861323;16091.678166436664;16162.595935101628;16215.432459863907;14629.122252664847;14836.703265934702;14856.33146508407;14858.55424337269;14861.479848205316;658.6509150150404;674.8886433738427;781.1290411191509;791.2048391366683;811.3347055414563;806.4193780478047;806.9556174410405;807.1968391450515;808.1110778144053;808.6765293882464;853.3642436384902;855.0338117926765;861.0614430271004;862.2584577263548;862.4868203418956;701.6386560921104;716.8530451257479;825.3191117328229;860.084010528788;861.1259571534897;621.3475850357152;621.7979156774066;622.9501639868799;624.9125122482856;625.4433554136822;14624.853751462455;14644.853551464455;14670.19313937733;14673.633159170999;14674;13682.179069255877;13988.300584970813;14345;14504.564863054125;14584.562463126018;13402.664933376744;13559.118657287343;13608.523701670492;13744.244066576335;13949;4465.933011004838;4486.371907932892;4492.8876778080485;4520.796564154621;4574.794134263932;82308.58845705733;82953.58523207405;83326.58336708338;84813.57593211994;86049;11654.112804938915;11661.300321980709;11692.941535292439;11734.471948762326;12101.818472722916;22555.548889022455;22556.436089097577;22556.66165007526;22710.886445567667;22726.772732272464;8162.551059691774;8448;8718.258947989492;8855;8911.688090916916;4623.398958135488;4634.884127896829;4729.290606409066;4763.3807605011125;4848.7090774553635;3480.704140148065;3659.1035196377056;3659.1949771050326;3666.6699997000396;3669.5596528416227;596.0493013643319;599.2539288585651;603.7343568829701;610.0513701194685;611.7400104955376;578.8523926398825;689.7378995981595;690.927452617478;696.2723953468637;700.9964950175216;9212.861807072899;9761.36551124189;10030;10247.795044099077;10286.228532860065;597.7190720361423;634.8984162534065;678.4165617568887;711.1999001123736;715.2204097533713;4495.57292057254;4684.180268453075;4699.224627936421;4738;4780.306855505932;117628.41185794187;122218;123277.38361308136;128555;132870.33564832306;108399.45800271106;108475;109142.45428772805;112803;113306.43346783213;72207.63896180486;89845.55077224573;91144;94354.52822735843;95769;8450.830983380176;8471;8674.392792504717;8681.609327580149;8724.869126963227;55431.722841385534;55632.721836390556;56142.43857561536;56701.149482758614;58457.4154258469;71669;74523;81370.30407871392;81474.59262703886;84132;11890.16768826174;11905.464254108412;12050.156489045683;12165;12316.261024338568;12346.506139754669;12483.500659973499;12525.436355363849;13323.000774942111;13335.266560339274;12070.939645301718;12288.324142172267;12299.385030748606;12719.046071544486;13096.279704615956;12113.454894529592;12299.200551964093;12337.383130843602;12509;12696.365181740692;11652.417379131179;11793.351365674971;11851.170418070653;11875.049996000473;12366.44351004189;9995.550200241152;10169.135623472088;10343.793124137626;10383.428911409643;10390.896091039296;9618.711438656852;10135.290529662852;10141.138003269805;10169;10227.335223210468 15:33:01 INFO - PROCESS | 28373 | __end_tp_report 15:33:01 INFO - PROCESS | 28373 | __start_cc_report 15:33:01 INFO - PROCESS | 28373 | _x_x_mozilla_cycle_collect,1212 15:33:01 INFO - PROCESS | 28373 | __end_cc_report 15:33:01 INFO - PROCESS | 28373 | __startTimestamp1474583581031__endTimestamp 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | ------- Summary: start ------- 15:33:01 INFO - PROCESS | 28373 | Number of tests: 6 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | [#0] dojo.html Cycles:165 Average:5247.71 Median:5463.70 stddev:586.88 (10.7%) stddev-sans-first:561.84 15:33:01 INFO - PROCESS | 28373 | Values: 3011.1 3036.7 3039.5 3067.1 3085.8 5160.2 5177.9 5266.7 5274.8 5295.0 5299.8 5303.3 5359.6 5365.0 5372.1 4781.4 4829.8 4864.5 4880.5 4909.3 4935.5 4960.6 4991.6 5005.8 5036.8 4678.5 4702.6 4740.1 4798.2 4885.4 4735.3 4736.9 4782.6 4799.4 4822.1 4669.0 4705.1 4709.0 4721.9 4760.2 5155.8 5176.9 5193.0 5211.0 5244.4 5575.6 5579.9 5581.1 5625.4 5697.3 5660.1 5661.5 5661.8 5662.0 5686.5 5174.1 5305.2 5313.7 5314.5 5374.7 5675.7 5760.2 5793.4 5801.0 5896.7 5541.2 5587.1 5596.4 5599.3 5607.8 5644.2 5680.1 5694.0 5694.9 5717.7 5409.4 5464.0 5513.4 5561.1 5567.9 5596.4 5598.8 5598.8 5601.5 5657.1 4357.3 4358.5 4360.8 4401.2 4413.1 3845.2 3848.3 3881.5 3887.7 3916.2 5388.2 5390.1 5392.3 5434.8 5455.8 5658.7 5702.3 5706.7 5712.3 5713.7 5159.8 5206.3 5300.3 5372.6 5451.0 4912.0 4944.0 4953.0 5005.4 5008.5 5817.0 5852.6 5864.5 5866.3 5866.8 5544.8 5583.3 5681.9 5698.4 5766.4 5755.8 5831.2 5832.5 5835.1 5895.8 5522.1 5553.8 5565.1 5567.1 5600.9 5513.8 5561.7 5561.9 5564.2 5578.7 5420.7 5463.7 5509.2 5519.1 5611.8 5479.5 5483.2 5484.2 5484.8 5486.5 5486.6 5494.9 5498.1 5503.5 5510.3 5397.5 5452.5 5520.6 5529.6 5576.6 5384.0 5446.8 5453.3 5480.6 5506.3 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | [#1] ext.html Cycles:180 Average:58763.56 Median:42154.18 stddev:112516.26 (266.9%) stddev-sans-first:112746.99 15:33:01 INFO - PROCESS | 28373 | Values: 546.0 582.5 587.9 590.5 612.1 31913.7 43563.3 44678.3 44683.3 44728.3 46093.8 46437.5 46445.8 46520.3 46580.0 8995.6 9168.2 9168.7 9173.1 9177.3 8824.4 8911.0 8926.4 8929.6 8930.8 8958.5 9009.2 9012.4 9017.3 9022.3 8918.4 8947.1 8948.9 8956.2 8957.6 8994.6 9059.8 9064.6 9066.1 9067.2 42734.0 43342.0 43348.6 43362.8 43374.1 3302.4 3540.3 3590.1 3694.9 3882.9 32754.2 32915.3 33503.7 34384.7 35074.3 4406.7 4416.5 4427.7 4462.0 4496.4 339008.0 339231.0 339400.0 339751.0 339840.0 53082.0 54507.2 58963.7 59173.4 59258.0 60756.7 62471.0 62512.7 67229.7 67402.6 16591.4 16820.2 16850.3 16895.5 17017.8 11800.6 12061.0 13197.7 13269.0 13284.8 17113.3 17553.8 17607.9 17848.4 17979.4 6044.9 6054.9 6060.2 6095.5 6247.2 883.4 954.4 972.7 1046.5 1060.0 31054.5 31299.2 31307.2 31720.1 31880.0 1043.7 1078.1 1080.0 1115.8 1164.8 15513.8 16590.3 16711.8 16745.3 17047.7 529278.0 537311.0 540046.0 542499.0 542910.0 58734.0 58773.7 58780.0 58806.4 59012.0 1208.0 1241.6 1270.3 1349.8 1360.3 31526.2 34785.0 34909.7 35073.5 35094.3 55250.4 55797.7 55850.7 55855.7 55878.7 368218.0 369668.0 369695.0 370391.0 371951.0 35826.3 36619.8 38765.6 41982.6 42325.8 47353.5 47522.0 47772.3 47807.5 49493.8 39972.6 40197.4 40738.8 40831.6 42677.8 40045.2 40367.0 41225.0 41245.6 41893.4 39409.0 40118.6 40228.2 40748.4 40900.8 34867.3 36784.3 37151.8 37189.8 38214.8 27913.9 27935.0 28016.0 28338.4 28404.0 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | [#2] jquery.html Cycles:180 Average:27696.14 Median:31545.42 stddev:64521.69 (204.5%) stddev-sans-first:64670.07 15:33:01 INFO - PROCESS | 28373 | Values: 368.7 389.6 394.2 397.2 421.2 13318.8 15217.2 16120.4 19581.4 20125.5 18323.9 18502.0 18894.1 18940.7 19295.6 5586.7 5796.7 5809.9 5824.2 5824.2 3957.5 4146.6 5670.9 5926.0 7136.8 7472.6 7476.5 7598.6 7602.5 7618.2 7313.4 7494.4 7503.3 7518.5 7524.8 7046.2 7246.3 7302.2 7330.0 7343.4 24392.3 25897.5 25906.0 26004.7 26021.7 2565.0 2592.3 2597.7 2670.6 3118.3 15332.9 15858.4 15862.7 16004.1 16698.1 1985.0 2009.6 2018.5 2046.6 2083.0 91022.5 92328.2 92483.0 92597.1 95344.5 16635.2 16905.2 17200.5 17258.0 17780.3 31323.0 31435.2 31541.8 31549.0 31637.7 9741.9 9965.5 10039.8 10085.9 10320.9 8203.7 8327.1 8444.7 8633.7 8692.6 8582.9 8673.3 8787.3 8844.0 8877.0 2808.9 3029.3 3116.9 3222.0 3375.4 815.9 910.4 961.5 977.6 995.6 17812.8 18902.6 18987.4 19007.7 19195.0 966.6 990.5 998.5 1026.6 1030.7 10120.6 10722.4 10749.9 10767.0 10777.9 347786.0 349155.0 351047.0 431866.0 434315.0 92887.0 93605.0 96807.5 97705.5 98218.0 1006.9 1013.0 1044.1 1047.4 1050.9 16604.3 16985.3 17314.3 17521.3 18135.9 42568.0 42738.0 43259.8 44128.8 44781.6 60816.4 60881.4 60916.4 61438.4 62093.7 7681.8 8574.0 8791.8 8896.6 9098.0 12899.4 13184.7 13410.3 13419.5 13484.7 11495.7 11678.8 11745.5 11774.6 11793.7 11441.3 11490.6 11514.7 11636.0 11658.4 11600.7 11618.9 11827.6 11909.6 11958.8 8014.2 8210.5 8248.4 8295.7 8364.3 10786.2 11135.9 11266.3 11532.8 11571.0 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | [#3] mootools.html Cycles:180 Average:5640.38 Median:4901.45 stddev:3210.93 (65.5%) stddev-sans-first:3203.31 15:33:01 INFO - PROCESS | 28373 | Values: 1292.3 1451.7 1482.2 1606.5 1776.0 7285.6 8343.2 8606.2 8609.3 8897.6 8692.9 8728.3 8738.0 8754.6 8764.8 2327.0 2334.4 2351.4 2354.2 2366.3 2293.7 2320.9 2335.9 2337.5 2344.1 2282.0 2301.8 2319.7 2337.2 2340.5 2271.6 2292.4 2293.0 2296.2 2303.9 2241.2 2254.7 2254.7 2258.2 2261.7 8142.6 8609.1 8769.1 8769.6 8781.7 4882.9 5039.4 5042.3 5051.7 5092.6 3259.1 3367.1 3393.2 3416.3 3430.5 1189.3 1222.9 1223.3 1233.6 1244.1 12035.5 12087.3 12132.5 12134.5 12149.2 4188.4 4348.2 4445.2 4487.6 4500.0 9437.8 9521.7 9581.0 9590.4 9591.0 4894.4 4901.0 4901.9 4903.5 4904.3 3853.3 3951.0 4397.5 4494.1 4681.8 3591.6 3648.0 3706.7 3737.6 3769.6 1141.6 1152.9 1193.6 1195.1 1200.3 927.0 927.7 941.4 944.9 968.7 5563.7 5582.5 5696.3 5827.5 6078.2 948.8 965.8 981.9 988.2 996.2 3947.7 4086.2 4150.2 4168.5 4326.0 10138.9 10414.6 10479.2 10496.4 10854.0 10626.1 10750.2 10772.4 10774.5 10794.0 8070.8 8175.2 8178.3 8178.8 8202.7 5725.4 5987.6 6035.4 6052.2 6091.9 9850.6 9906.0 9929.5 10024.4 10056.5 9704.7 10066.5 10077.9 10332.1 10430.6 6432.7 6615.5 7404.6 7674.0 7838.3 8184.7 8462.4 8525.0 8530.8 8540.0 7261.2 7574.8 7666.4 7693.8 7811.1 6967.8 7153.6 7235.1 7386.9 7442.0 6848.8 6897.1 6924.1 6941.5 6944.2 4876.3 4960.2 4979.1 4985.7 5020.8 4879.4 4908.9 5020.7 5058.2 5114.7 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | [#4] prototype.html Cycles:180 Average:4534.67 Median:5012.29 stddev:1310.94 (26.2%) stddev-sans-first:1276.02 15:33:01 INFO - PROCESS | 28373 | Values: 327.5 331.3 338.4 339.4 342.8 5137.3 5295.7 5315.0 5376.9 5400.5 5092.2 5213.7 5215.7 5217.9 5262.7 4189.0 4200.0 4203.6 4218.2 4220.8 3987.7 4154.0 4209.7 4240.6 4255.3 4122.6 4145.9 4150.9 4156.5 4164.8 4143.2 4146.1 4148.4 4149.5 4175.9 3705.8 3711.0 3718.5 3743.4 3744.2 5029.9 5149.9 5161.9 5200.5 5221.7 4727.7 4733.7 4737.2 4742.7 4744.3 5470.3 5478.4 5492.2 5539.1 5554.3 3770.5 3976.4 3979.7 3980.0 4011.2 5743.5 5751.2 5754.3 5794.6 5807.9 4107.1 4109.8 4131.6 4133.6 4138.5 3948.7 4156.6 4164.0 4172.8 4182.2 4751.2 4752.4 4757.0 4772.5 4816.9 5569.1 5597.4 5597.8 5635.7 5658.7 1323.5 1354.4 1413.2 1434.2 1435.0 908.7 918.0 932.1 948.5 949.1 4663.9 4681.4 4753.9 4789.8 4790.2 4935.9 4967.0 4972.4 4972.8 4976.6 4546.9 4745.6 4748.5 4750.6 4761.4 2624.4 2648.6 2648.8 2666.5 2678.0 5161.4 5161.5 5162.0 5169.0 5206.6 4675.5 4957.2 5018.5 5076.9 5082.8 5017.7 5033.4 5077.4 5086.6 5120.2 5006.8 5021.3 5021.7 5048.0 5059.2 4928.2 4989.4 4989.5 5239.8 5663.2 5836.5 5898.7 5899.9 5902.8 5913.3 4098.8 4130.3 4143.1 4159.9 4177.9 5340.2 5673.7 5673.8 5685.4 5815.0 5415.7 5444.2 5606.2 5612.7 5619.3 5550.4 5598.4 5608.4 5608.8 5618.6 5378.1 5536.7 5548.8 5566.9 5575.9 5590.4 5602.3 5647.6 5651.7 5686.5 5462.9 5508.4 5529.4 5531.4 5559.1 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - PROCESS | 28373 | [#5] yui.html Cycles:180 Average:21771.70 Median:4547.80 stddev:32646.25 (717.8%) stddev-sans-first:32699.67 15:33:01 INFO - PROCESS | 28373 | Values: 750.3 821.9 825.8 827.0 834.1 14650.4 16058.8 16091.7 16162.6 16215.4 14629.1 14836.7 14856.3 14858.6 14861.5 658.7 674.9 781.1 791.2 811.3 806.4 807.0 807.2 808.1 808.7 853.4 855.0 861.1 862.3 862.5 701.6 716.9 825.3 860.1 861.1 621.3 621.8 623.0 624.9 625.4 14624.9 14644.9 14670.2 14673.6 14674.0 13682.2 13988.3 14345.0 14504.6 14584.6 13402.7 13559.1 13608.5 13744.2 13949.0 4465.9 4486.4 4492.9 4520.8 4574.8 82308.6 82953.6 83326.6 84813.6 86049.0 11654.1 11661.3 11692.9 11734.5 12101.8 22555.5 22556.4 22556.7 22710.9 22726.8 8162.6 8448.0 8718.3 8855.0 8911.7 4623.4 4634.9 4729.3 4763.4 4848.7 3480.7 3659.1 3659.2 3666.7 3669.6 596.0 599.3 603.7 610.1 611.7 578.9 689.7 690.9 696.3 701.0 9212.9 9761.4 10030.0 10247.8 10286.2 597.7 634.9 678.4 711.2 715.2 4495.6 4684.2 4699.2 4738.0 4780.3 117628.4 122218.0 123277.4 128555.0 132870.3 108399.5 108475.0 109142.5 112803.0 113306.4 72207.6 89845.6 91144.0 94354.5 95769.0 8450.8 8471.0 8674.4 8681.6 8724.9 55431.7 55632.7 56142.4 56701.1 58457.4 71669.0 74523.0 81370.3 81474.6 84132.0 11890.2 11905.5 12050.2 12165.0 12316.3 12346.5 12483.5 12525.4 13323.0 13335.3 12070.9 12288.3 12299.4 12719.0 13096.3 12113.5 12299.2 12337.4 12509.0 12696.4 11652.4 11793.4 11851.2 11875.0 12366.4 9995.6 10169.1 10343.8 10383.4 10390.9 9618.7 10135.3 10141.1 10169.0 10227.3 15:33:01 INFO - PROCESS | 28373 | -------- Summary: end -------- 15:33:01 INFO - PROCESS | 28373 | 15:33:01 INFO - TEST-INFO | 28373: exit 0 15:33:01 INFO - TEST-OK | dromaeo_css | took 1116334ms 15:33:01 INFO - TEST-START | kraken 15:33:01 INFO - operating with platform_type : linux_ 15:33:01 INFO - Initialising browser for kraken test... 15:33:01 INFO - TEST-INFO | started process 28680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSD29m/profile http://localhost:44556/getInfo.html) 15:33:06 INFO - PROCESS | 28680 | __metrics Screen width/height:1600/1200 15:33:06 INFO - PROCESS | 28680 | colorDepth:24 15:33:06 INFO - PROCESS | 28680 | Browser inner width/height: 1024/697 15:33:06 INFO - PROCESS | 28680 | __metrics 15:33:06 INFO - PROCESS | 28680 | 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" 15:33:06 INFO - PROCESS | 28680 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:07 INFO - PROCESS | 28680 | console.error: PushService: 15:33:07 INFO - PROCESS | 28680 | stateChangeProcessEnqueue: Error transitioning state 15:33:07 INFO - PROCESS | 28680 | UnknownError 15:33:08 INFO - TEST-INFO | 28680: exit 0 15:33:08 INFO - Browser initialized. 15:33:08 INFO - Running cycle 1/1 for kraken test... 15:33:08 INFO - TEST-INFO | started process 28759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSD29m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:20 INFO - PROCESS | 28759 | RSS: Main: 173977600 15:33:20 INFO - PROCESS | 28759 | 15:33:22 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44556/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:23 INFO - PROCESS | 28759 | RSS: Main: 232779776 15:33:23 INFO - PROCESS | 28759 | 15:33:26 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44556/tests/kraken/driver.html?testName=audio-dft) 15:33:27 INFO - PROCESS | 28759 | RSS: Main: 217169920 15:33:27 INFO - PROCESS | 28759 | 15:33:30 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44556/tests/kraken/driver.html?testName=audio-fft) 15:33:30 INFO - PROCESS | 28759 | RSS: Main: 299294720 15:33:30 INFO - PROCESS | 28759 | 15:33:32 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44556/tests/kraken/driver.html?testName=audio-oscillator) 15:33:33 INFO - PROCESS | 28759 | RSS: Main: 208842752 15:33:33 INFO - PROCESS | 28759 | 15:33:35 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:36 INFO - PROCESS | 28759 | RSS: Main: 212873216 15:33:36 INFO - PROCESS | 28759 | 15:33:39 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44556/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:39 INFO - PROCESS | 28759 | RSS: Main: 250040320 15:33:39 INFO - PROCESS | 28759 | 15:33:43 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44556/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:43 INFO - PROCESS | 28759 | RSS: Main: 249106432 15:33:43 INFO - PROCESS | 28759 | 15:33:46 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44556/tests/kraken/driver.html?testName=json-parse-financial) 15:33:47 INFO - PROCESS | 28759 | RSS: Main: 248528896 15:33:47 INFO - PROCESS | 28759 | 15:33:48 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:49 INFO - PROCESS | 28759 | RSS: Main: 210661376 15:33:49 INFO - PROCESS | 28759 | 15:33:50 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:51 INFO - PROCESS | 28759 | RSS: Main: 217632768 15:33:51 INFO - PROCESS | 28759 | 15:33:53 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:54 INFO - PROCESS | 28759 | RSS: Main: 222777344 15:33:54 INFO - PROCESS | 28759 | 15:33:56 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:57 INFO - PROCESS | 28759 | RSS: Main: 223358976 15:33:57 INFO - PROCESS | 28759 | 15:34:00 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:00 INFO - PROCESS | 28759 | RSS: Main: 221569024 15:34:00 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | Cycle 1(1): loaded http://localhost:44556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44556/tests/kraken/driver.html?testName=ai-astar) 15:34:02 INFO - PROCESS | 28759 | RSS: Main: 273244160 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | __start_tp_report 15:34:02 INFO - PROCESS | 28759 | _x_x_mozilla_page_load 15:34:02 INFO - PROCESS | 28759 | _x_x_mozilla_page_load_details 15:34:02 INFO - PROCESS | 28759 | |i|pagename|runs| 15:34:02 INFO - PROCESS | 28759 | |0;ai-astar;110;112;112;112;113;112;112;111;112;113 15:34:02 INFO - PROCESS | 28759 | |1;audio-beat-detection;149;121;120;169;128;118;119;123;162;120 15:34:02 INFO - PROCESS | 28759 | |2;audio-dft;163;161;162;162;161;162;163;161;161;161 15:34:02 INFO - PROCESS | 28759 | |3;audio-fft;76;75;74;110;76;77;76;75;104;75 15:34:02 INFO - PROCESS | 28759 | |4;audio-oscillator;82;82;114;82;83;82;111;82;83;111 15:34:02 INFO - PROCESS | 28759 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;116;117;117 15:34:02 INFO - PROCESS | 28759 | |6;imaging-darkroom;145;146;145;146;145;145;146;145;145;145 15:34:02 INFO - PROCESS | 28759 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;95 15:34:02 INFO - PROCESS | 28759 | |8;json-parse-financial;52;51;51;52;53;53;51;52;55;54 15:34:02 INFO - PROCESS | 28759 | |9;json-stringify-tinderbox;62;62;61;61;63;61;62;62;66;63 15:34:02 INFO - PROCESS | 28759 | |10;stanford-crypto-aes;78;79;78;79;81;84;79;78;78;77 15:34:02 INFO - PROCESS | 28759 | |11;stanford-crypto-ccm;125;123;123;129;133;132;134;124;175;125 15:34:02 INFO - PROCESS | 28759 | |12;stanford-crypto-pbkdf2;164;166;162;165;162;166;165;166;174;163 15:34:02 INFO - PROCESS | 28759 | |13;stanford-crypto-sha256-iterative;65;64;65;65;65;65;64;66;65;62 15:34:02 INFO - PROCESS | 28759 | __end_tp_report 15:34:02 INFO - PROCESS | 28759 | __start_cc_report 15:34:02 INFO - PROCESS | 28759 | _x_x_mozilla_cycle_collect,1637 15:34:02 INFO - PROCESS | 28759 | __end_cc_report 15:34:02 INFO - PROCESS | 28759 | __startTimestamp1474583642767__endTimestamp 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | ------- Summary: start ------- 15:34:02 INFO - PROCESS | 28759 | Number of tests: 14 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:0.88 (0.8%) stddev-sans-first:0.60 15:34:02 INFO - PROCESS | 28759 | Values: 110.0 112.0 112.0 112.0 113.0 112.0 112.0 111.0 112.0 113.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:125.50 stddev:19.50 (15.5%) stddev-sans-first:19.79 15:34:02 INFO - PROCESS | 28759 | Values: 149.0 121.0 120.0 169.0 128.0 118.0 119.0 123.0 162.0 120.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 15:34:02 INFO - PROCESS | 28759 | Values: 163.0 161.0 162.0 162.0 161.0 162.0 163.0 161.0 161.0 161.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.38 (17.7%) stddev-sans-first:14.03 15:34:02 INFO - PROCESS | 28759 | Values: 76.0 75.0 74.0 110.0 76.0 77.0 76.0 75.0 104.0 75.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:14.38 (17.5%) stddev-sans-first:14.86 15:34:02 INFO - PROCESS | 28759 | Values: 82.0 82.0 114.0 82.0 83.0 82.0 111.0 82.0 83.0 111.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 15:34:02 INFO - PROCESS | 28759 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:34:02 INFO - PROCESS | 28759 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:34:02 INFO - PROCESS | 28759 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.35 (2.6%) stddev-sans-first:1.42 15:34:02 INFO - PROCESS | 28759 | Values: 52.0 51.0 51.0 52.0 53.0 53.0 51.0 52.0 55.0 54.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.58 15:34:02 INFO - PROCESS | 28759 | Values: 62.0 62.0 61.0 61.0 63.0 61.0 62.0 62.0 66.0 63.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:2.02 (2.6%) stddev-sans-first:2.11 15:34:02 INFO - PROCESS | 28759 | Values: 78.0 79.0 78.0 79.0 81.0 84.0 79.0 78.0 78.0 77.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:130.50 stddev:15.59 (11.9%) stddev-sans-first:16.31 15:34:02 INFO - PROCESS | 28759 | Values: 125.0 123.0 123.0 129.0 133.0 132.0 134.0 124.0 175.0 125.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:165.50 stddev:3.43 (2.1%) stddev-sans-first:3.61 15:34:02 INFO - PROCESS | 28759 | Values: 164.0 166.0 162.0 165.0 162.0 166.0 165.0 166.0 174.0 163.0 15:34:02 INFO - PROCESS | 28759 | 15:34:02 INFO - PROCESS | 28759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 15:34:02 INFO - PROCESS | 28759 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 64.0 66.0 65.0 62.0 15:34:02 INFO - PROCESS | 28759 | -------- Summary: end -------- 15:34:02 INFO - PROCESS | 28759 | 15:34:03 INFO - TEST-INFO | 28759: exit 0 15:34:03 INFO - TEST-OK | kraken | took 61986ms 15:34:03 INFO - SUITE-END | took 1178s 15:34:04 INFO - Completed test suite (00:19:38) 15:34:04 INFO - javascript benchmark 15:34:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.0966709987006, 3036.7418769404608, 3039.498482750345, 3067.095206913963, 3085.783995120341, 5160.20016897381, 5177.922331165036, 5266.736663166841, 5274.789008439658, 5295.0204212220715, 5299.814506492274, 5303.284056652351, 5359.5712343012565, 5365.0, 5372.059889519328, 4781.3545171401765, 4829.806807727687, 4864.513548645143, 4880.487548807378, 4909.288153217782, 4935.457099719046, 4960.553550180483, 4991.550760431561, 5005.824796132136, 5036.84889453317, 4678.461976872669, 4702.576768090888, 4740.051989602093, 4798.184308667535, 4885.36490256268, 4735.266033764772, 4736.8578942631775, 4782.569568738795, 4799.448063472711, 4822.08380407725, 4668.976655116703, 4705.082508910764, 4708.976455117702, 4721.858344249678, 4760.238361862085, 5155.819546315861, 5176.896462070775, 5192.974035129838, 5210.97394513025, 5244.39689435716, 5575.609707320489, 5579.944200557983, 5581.079121944874, 5625.353084395265, 5697.316322041382, 5660.066089095294, 5661.547076233933, 5661.830145095653, 5662.009148399014, 5686.545076393879, 5174.14626586609, 5305.1776974569, 5313.681179129265, 5314.548263397577, 5374.731263436813, 5675.744591493392, 5760.193572899713, 5793.420657934173, 5801.0, 5896.705164741746, 5541.224228607998, 5587.078132108157, 5596.356419011866, 5599.328080630269, 5607.803726869622, 5644.238027866268, 5680.14797780328, 5694.0, 5694.914576281359, 5717.742701578439, 5409.404965453797, 5464.0, 5513.365962914236, 5561.082421400504, 5567.860803479864, 5596.356419011784, 5598.804041858515, 5598.832035038955, 5601.467860553241, 5657.066584013674, 4357.281048627005, 4358.4769827620885, 4360.847370342086, 4401.185780630593, 4413.117376524708, 3845.1732877430927, 3848.288066707668, 3881.5342158941107, 3887.727859049896, 3916.1971795781797, 5388.218708287276, 5390.0836857734275, 5392.325959255093, 5434.809781657623, 5455.781768729206, 5658.660480371191, 5702.344230413555, 5706.657600543981, 5712.314522257356, 5713.657180569096, 5159.7678104485385, 5206.271122042917, 5300.284461597635, 5372.597055220874, 5450.972745136249, 4912.017596480719, 4944.0, 4952.975235123801, 5005.424376196711, 5008.549230569266, 5817.0, 5852.648841069549, 5864.501517370986, 5866.266716660418, 5866.794662186803, 5544.833654990357, 5583.330000399978, 5681.9147712783515, 5698.401667824819, 5766.394528574439, 5755.769769209185, 5831.241938547962, 5832.50423713989, 5835.066389377679, 5895.823125306248, 5522.061249587499, 5553.8333849984565, 5565.053940830149, 5567.05360088794, 5600.85997850057, 5513.779448822002, 5561.749721262634, 5561.916571251353, 5564.1931919870585, 5578.748956297058, 5420.728963551728, 5463.699496527729, 5509.201165831012, 5519.0893502573235, 5611.775528978958, 5479.4520547944885, 5483.2049352844415, 5484.232207491034, 5484.7806087757635, 5486.451354864482, 5486.643368181056, 5494.862628434321, 5498.092814685692, 5503.477169668875, 5510.256115424527, 5397.487238712316, 5452.509274165185, 5520.585956053393, 5529.557635389078, 5576.637518561281, 5383.973080134574, 5446.809361672323, 5453.318335208099, 5480.6437581557075, 5506.339239291311], "value": 5208.4371300307575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.9782677333645, 582.4612233683844, 587.8941790477712, 590.4774274766831, 612.0727098445853, 31913.680863191363, 43563.34654980174, 44678.32982505257, 44683.329750053694, 44728.32907506382, 46093.7695311523, 46437.535624643744, 46445.767771161096, 46520.3021954671, 46579.99999999991, 8995.640174393033, 9168.220701240403, 9168.679096231634, 9173.128552787475, 9177.311701622371, 8824.382293239476, 8910.955445222764, 8926.37515373924, 8929.642814287421, 8930.776730581723, 8958.462492250486, 9009.189172974431, 9012.369134160612, 9017.32370072244, 9022.323325750562, 8918.375713700043, 8947.060558641379, 8948.910510894906, 8956.193942545202, 8957.641694332218, 8994.595243214071, 9059.81880362389, 9064.592093355815, 9066.138716821892, 9067.229285510739, 42734.0, 43342.0, 43348.566514334765, 43362.78318608387, 43374.13251734979, 3302.3560405720896, 3540.2565461253166, 3590.1024743814046, 3694.907627309312, 3882.913682529367, 32754.181145471317, 32915.34169316624, 33503.6649633503, 34384.65615343865, 35074.29851402958, 4406.6694997874965, 4416.514183439819, 4427.667924905645, 4461.977690111561, 4496.3705081288645, 339008.0, 339231.0, 339400.0, 339751.0, 339840.0, 53082.0, 54507.18239226415, 58963.705181474674, 59173.40826591679, 59258.0, 60756.69621651952, 62471.0, 62512.687436562526, 67229.66385168141, 67402.6188297759, 16591.41930032443, 16820.243089061023, 16850.32598696063, 16895.493135205717, 17017.82982170187, 11800.58697945585, 12061.0, 13197.736045279233, 13269.0, 13284.800727989088, 17113.315467381413, 17553.824461755474, 17607.943523388636, 17848.375306864196, 17979.370722024665, 6044.879102417927, 6054.878902421927, 6060.181875446847, 6095.512359011268, 6247.156633854463, 883.3569560617246, 954.4082668745283, 972.6547075788135, 1046.4663021858908, 1059.998301604976, 31054.53418198729, 31299.217519562193, 31307.217319567193, 31720.104459383085, 31880.0, 1043.7025447747508, 1078.148262872322, 1079.9902091544432, 1115.827046807746, 1164.8194529847888, 15513.84486155124, 16590.336386544644, 16711.83288167127, 16745.330186792635, 17047.65904681924, 529278.0, 537311.0, 540046.0, 542499.0, 542910.0, 58734.0, 58773.706131469065, 58780.0, 58806.41193588095, 59012.0, 1207.9758404831855, 1241.6026871401245, 1270.314030423561, 1349.7840345544862, 1360.2858499287952, 31526.211844704067, 34785.0, 34909.65090349064, 35073.47389789104, 35094.29811403809, 55250.44749552453, 55797.721011394686, 55850.72074639601, 55855.72072139613, 55878.72060639671, 368218.0, 369668.0, 369695.0, 370391.0, 371951.0, 35826.28347433089, 36619.81690091533, 38765.6123438762, 41982.580174197865, 42325.78837105918, 47353.52646473629, 47522.0, 47772.28341574949, 47807.5219247817, 49493.752531237114, 39972.60027399689, 40197.397039043855, 40738.79630601828, 40831.59168408396, 42677.78661106799, 40045.1990960185, 40366.9908252296, 41225.0, 41245.58754412417, 41893.37159942542, 39409.0, 40118.59881401266, 40228.1954360917, 40748.388774169005, 40900.79549602233, 34867.302653947285, 36784.26431471409, 37151.81424092862, 37189.81405092957, 38214.808925956306, 27913.860430697718, 27935.0, 28016.0, 28338.433231334846, 28404.0], "value": 20182.376772014526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.6718820249976, 389.5987133252749, 394.18993967396995, 397.2313573235789, 421.2270483662479, 13318.786906258722, 15217.163056031914, 16120.355185792583, 19581.412557623295, 20125.496862578442, 18323.908380458113, 18502.0, 18894.14976326065, 18940.71588926164, 19295.614087718237, 5586.692731899744, 5796.739146738407, 5809.854753631172, 5824.155497452867, 5824.24284842972, 3957.5053118360206, 4146.6268035876765, 5670.858228544299, 5925.970370148143, 7136.75021374252, 7472.551646901176, 7476.476646634737, 7598.582077985736, 7602.543847369176, 7618.1620021797835, 7313.378362839165, 7494.437917156235, 7503.324700776901, 7518.473706840523, 7524.8118797029965, 7046.224915259318, 7246.311600397954, 7302.1967583565765, 7330.0, 7343.44924130687, 24392.268231952894, 25897.539733725454, 25906.0, 26004.73995260042, 26021.73978260231, 2564.974350256492, 2592.2871210417097, 2597.7272386399536, 2670.626112344273, 3118.2983828638603, 15332.923335383251, 15858.36566537337, 15862.682746345008, 16004.119773412458, 16698.081605511692, 1984.98523998142, 2009.6081264153495, 2018.5054661608, 2046.6111438826724, 2083.031535199237, 91022.54488727514, 92328.2307757446, 92483.0, 92597.07402925951, 95344.52327738317, 16635.16824158787, 16905.239264232892, 17200.483985480456, 17258.0, 17780.288788448317, 31323.0, 31435.214119647193, 31541.842290788398, 31549.0, 31637.683623163935, 9741.902580974242, 9965.501724913871, 10039.799204015879, 10085.949570252102, 10320.948395257976, 8203.71287004952, 8327.084770502819, 8444.746657600283, 8633.740987770378, 8692.609882145967, 8582.914170858336, 8673.262772664395, 8787.297016238686, 8843.955780221058, 8877.0, 2808.9016884408948, 3029.348690031654, 3116.8753249870206, 3221.9838900805817, 3375.3586818504405, 815.8659463345954, 910.3809409601535, 961.4759955824093, 977.6285011695652, 995.5619527407918, 17812.821871781376, 18902.621947560972, 18987.430377088433, 19007.714884276746, 19195.0, 966.5650457294246, 990.4997976022207, 998.4658207858761, 1026.5637104230673, 1030.6650338639972, 10120.645777397904, 10722.41026743521, 10749.946250268855, 10767.0, 10777.892221077846, 347786.0, 349155.0, 351047.0, 431866.0, 434315.0, 92887.0, 93605.0, 96807.51596241974, 97705.5114724436, 98218.0, 1006.9295149339476, 1012.964546240878, 1044.0864243786687, 1047.4448542272607, 1050.8896565860628, 16604.335826566803, 16985.320587176375, 17314.30742770275, 17521.299148033937, 18135.909320453313, 42568.0, 42738.0, 43259.783701081295, 44128.77935610301, 44781.55218447774, 60816.39183608107, 60881.39118608934, 60916.39083609107, 61438.38561614326, 62093.68953155205, 7681.807954801175, 8573.957130214309, 8791.824163516821, 8896.555172241491, 9098.0, 12899.419526121535, 13184.670383240496, 13410.262435566137, 13419.463221471031, 13484.662883427993, 11495.712607184887, 11678.824817627912, 11745.530178793095, 11774.646760597196, 11793.705157371134, 11441.313521188755, 11490.597829075943, 11514.654560363202, 11636.0, 11658.358790266617, 11600.6519804406, 11618.88381116178, 11827.586034488751, 11909.583164589198, 11958.820617690915, 8014.238647328494, 8210.507369557607, 8248.422610417214, 8295.677210381104, 8364.330853531825, 10786.191035672198, 11135.888641113484, 11266.324020558794, 11532.769344612892, 11571.0], "value": 10231.162104080371, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.3215311961226, 1451.6516036151324, 1482.2144263540322, 1606.5019843848409, 1775.9911200443996, 7285.599292038935, 8343.207395297444, 8606.225439710424, 8609.268212201963, 8897.555122243879, 8692.869606955901, 8728.345374096936, 8738.03881573028, 8754.562271886396, 8764.78088047799, 2326.9650955235684, 2334.4280651240383, 2351.4356554426986, 2354.223106374901, 2366.325597204797, 2293.7247530296386, 2320.8607483550954, 2335.9182428614918, 2337.4623836517612, 2344.109238489372, 2282.0, 2301.7813307735737, 2319.7448280689196, 2337.1703045418885, 2340.4850932794757, 2271.579757744806, 2292.4498120451053, 2293.025464177726, 2296.1848543767055, 2303.861768293891, 2241.215574548895, 2254.6956160918394, 2254.7068881045525, 2258.220913784758, 2261.6720575516624, 8142.552159631218, 8609.096044915257, 8769.07924667907, 8769.605367758466, 8781.692640757543, 4882.902341953141, 5039.370078740158, 5042.268871013683, 5051.722155281458, 5092.618053645954, 3259.103746469716, 3367.0908854609365, 3393.151712071982, 3416.299658569987, 3430.485427185917, 1189.2567145534042, 1222.9327386993712, 1223.3149436315691, 1233.5805826019107, 1244.1415423357855, 12035.458404371824, 12087.335196564185, 12132.514699412013, 12134.514619415213, 12149.210301330473, 4188.434561334242, 4348.217320882209, 4445.17764213615, 4487.618552423015, 4500.032493013952, 9437.811243775086, 9521.714348569554, 9580.95209523948, 9590.376625519319, 9590.952045239868, 4894.437139728977, 4900.975495122501, 4901.926471102936, 4903.4606193318705, 4904.313396124546, 3853.325668008087, 3950.9802450987563, 4397.472303323621, 4494.10117976406, 4681.789319480631, 3591.6408359163875, 3647.9635203648154, 3706.6664000240107, 3737.570179429346, 3769.6418840210135, 1141.6289705845634, 1152.9423528823693, 1193.6419074277683, 1195.055905834381, 1200.2798321007326, 927.0405130689838, 927.7402327348353, 941.4398432932394, 944.8913374961967, 968.733598260484, 5563.693996830213, 5582.469665381782, 5696.287964004499, 5827.533797296206, 6078.240219972504, 948.800751842107, 965.8020105878419, 981.9312648114707, 988.17981075707, 996.2478328861808, 3947.703922205789, 4086.244044851712, 4150.232207041707, 4168.478940132483, 4326.0, 10138.949305253427, 10414.583416663248, 10479.161667066617, 10496.370217786956, 10854.0, 10626.096781773482, 10750.247482676294, 10772.353658780497, 10774.461276936121, 10794.0, 8070.838583228303, 8175.182481751896, 8178.345732341399, 8178.7955301117945, 8202.712905048415, 5725.370209277059, 5987.6108052976415, 6035.426634469718, 6052.152698622284, 6091.8781624366375, 9850.60597576089, 9906.0, 9929.453880036668, 10024.398536087858, 10056.54745536438, 9704.660336888457, 10066.49667516636, 10077.949610251902, 10332.121769649664, 10430.582776688847, 6432.678366081584, 6615.470762339098, 7404.555726656418, 7674.0, 7838.294553489985, 8184.713535026483, 8462.365322600952, 8524.957375213084, 8530.78673033179, 8539.957300213458, 7261.201267860425, 7574.81062973408, 7666.425018123775, 7693.769186924401, 7811.1017233016655, 6967.79096627102, 7153.6423178839805, 7235.131784185721, 7386.852262954603, 7442.032535770315, 6848.794536163923, 6897.137857767779, 6924.134483189601, 6941.548799328028, 6944.236134025152, 4876.317315575751, 4960.181570041047, 4979.0788704089855, 4985.7257850817105, 5020.774065167149, 4879.4388645304825, 4908.8772780680765, 5020.698758074527, 5058.215976523645, 5114.693118412758], "value": 4529.712755371388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5430774070172, 331.3472459255267, 338.43143518888274, 339.4246751755774, 342.8457194262579, 5137.306463627409, 5295.735213239337, 5315.0, 5376.8924621507595, 5400.486953739389, 5092.236164575306, 5213.687178769276, 5215.660982036165, 5217.921731174036, 5262.710635894211, 4189.010220145437, 4200.0339921818, 4203.621674049335, 4218.240716670998, 4220.767857767822, 3987.700922430815, 4154.0, 4209.747415155085, 4240.575942405766, 4255.319148936171, 4122.649574786132, 4145.875623731293, 4150.896227594304, 4156.480439945007, 4164.792210259021, 4143.233501802161, 4146.108586653869, 4148.43996060534, 4149.460570125894, 4175.893388252116, 3705.7585708787587, 3710.9814450927843, 3718.5165928429133, 3743.419769935664, 3744.157564547982, 5029.924551131736, 5149.871253218662, 5161.896762064737, 5200.5059519345605, 5221.73891305437, 4727.66906316558, 4733.692309999873, 4737.194676904935, 4742.668013239075, 4744.288356746481, 5470.343558772973, 5478.424765399655, 5492.203630473599, 5539.086050801613, 5554.2779438673115, 3770.454113813323, 3976.443297938291, 3979.7015223858325, 3979.98010009951, 4011.237864805707, 5743.5118014968775, 5751.194832723422, 5754.3094828620415, 5794.62334948227, 5807.854803629901, 4107.075907920694, 4109.835606575703, 4131.566185550534, 4133.627973482401, 4138.52406973196, 3948.7433316834313, 4156.605122513356, 4163.958360416417, 4172.812223449952, 4182.163567286555, 4751.192297309466, 4752.405949256343, 4756.976215118972, 4772.49888761682, 4816.8554943351755, 5569.136783798518, 5597.384287728347, 5597.776088956396, 5635.690037048002, 5658.660480371191, 1323.5169163255343, 1354.4379082680578, 1413.2297897645808, 1434.1825159659102, 1435.0170133458614, 908.6955869783696, 917.9541022948825, 932.0632764072064, 948.4783369146942, 949.0983565612557, 4663.927296721773, 4681.414823147106, 4753.904921901542, 4789.784459699322, 4790.209615413418, 4935.925961110586, 4966.975165124223, 4972.378452693413, 4972.828258611076, 4976.552110310089, 4546.886327841764, 4745.6440766942615, 4748.4539277982785, 4750.596199323097, 4761.428628564525, 2624.42262702209, 2648.602709593538, 2648.8278261912915, 2666.5333566625764, 2677.9555973170477, 5161.406438259648, 5161.483851614808, 5161.974190129025, 5168.9741551292, 5206.56819374675, 4675.521973354128, 4957.20684690455, 5018.4730603286125, 5076.898462030738, 5082.847514574569, 5017.745563609098, 5033.395992480926, 5077.416097148801, 5086.643934924594, 5120.18077107661, 5006.824761133343, 5021.297018417352, 5021.748912554431, 5048.0, 5059.16523773588, 4928.211486162197, 4989.376327959005, 4989.476105008922, 5239.764210610456, 5663.2071509989455, 5836.474717275466, 5898.675572843535, 5899.941000589939, 5902.763889444546, 5913.349531551612, 4098.8360465581045, 4130.277201489787, 4143.109231515239, 4159.854405095807, 4177.874663760092, 5340.198970154508, 5673.744681489426, 5673.751774609579, 5685.374608792947, 5814.970925145347, 5415.729213539386, 5444.210589464585, 5606.187102870143, 5612.747426365905, 5619.325680918316, 5550.361708403585, 5598.384177740527, 5608.355039170548, 5608.775648973995, 5618.578606604603, 5378.149580722224, 5536.667799932017, 5548.750306236309, 5566.8866226754, 5575.9163612545035, 5590.413006634245, 5602.327720673546, 5647.632903861236, 5651.689157096234, 5686.488216060575, 5462.945370546244, 5508.421615730291, 5529.4470552945995, 5531.363893152339, 5559.138333558305], "value": 4120.334061161812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2759836757527, 821.9383546234034, 825.7852958230862, 826.9751907442779, 834.1450013735923, 14650.413983440663, 16058.75911861323, 16091.678166436664, 16162.595935101628, 16215.432459863907, 14629.122252664847, 14836.703265934702, 14856.33146508407, 14858.55424337269, 14861.479848205316, 658.6509150150404, 674.8886433738427, 781.1290411191509, 791.2048391366683, 811.3347055414563, 806.4193780478047, 806.9556174410405, 807.1968391450515, 808.1110778144053, 808.6765293882464, 853.3642436384902, 855.0338117926765, 861.0614430271004, 862.2584577263548, 862.4868203418956, 701.6386560921104, 716.8530451257479, 825.3191117328229, 860.084010528788, 861.1259571534897, 621.3475850357152, 621.7979156774066, 622.9501639868799, 624.9125122482856, 625.4433554136822, 14624.853751462455, 14644.853551464455, 14670.19313937733, 14673.633159170999, 14674.0, 13682.179069255877, 13988.300584970813, 14345.0, 14504.564863054125, 14584.562463126018, 13402.664933376744, 13559.118657287343, 13608.523701670492, 13744.244066576335, 13949.0, 4465.933011004838, 4486.371907932892, 4492.8876778080485, 4520.796564154621, 4574.794134263932, 82308.58845705733, 82953.58523207405, 83326.58336708338, 84813.57593211994, 86049.0, 11654.112804938915, 11661.300321980709, 11692.941535292439, 11734.471948762326, 12101.818472722916, 22555.548889022455, 22556.436089097577, 22556.66165007526, 22710.886445567667, 22726.772732272464, 8162.551059691774, 8448.0, 8718.258947989492, 8855.0, 8911.688090916916, 4623.398958135488, 4634.884127896829, 4729.290606409066, 4763.3807605011125, 4848.7090774553635, 3480.704140148065, 3659.1035196377056, 3659.1949771050326, 3666.6699997000396, 3669.5596528416227, 596.0493013643319, 599.2539288585651, 603.7343568829701, 610.0513701194685, 611.7400104955376, 578.8523926398825, 689.7378995981595, 690.927452617478, 696.2723953468637, 700.9964950175216, 9212.861807072899, 9761.36551124189, 10030.0, 10247.795044099077, 10286.228532860065, 597.7190720361423, 634.8984162534065, 678.4165617568887, 711.1999001123736, 715.2204097533713, 4495.57292057254, 4684.180268453075, 4699.224627936421, 4738.0, 4780.306855505932, 117628.41185794187, 122218.0, 123277.38361308136, 128555.0, 132870.33564832306, 108399.45800271106, 108475.0, 109142.45428772805, 112803.0, 113306.43346783213, 72207.63896180486, 89845.55077224573, 91144.0, 94354.52822735843, 95769.0, 8450.830983380176, 8471.0, 8674.392792504717, 8681.609327580149, 8724.869126963227, 55431.722841385534, 55632.721836390556, 56142.43857561536, 56701.149482758614, 58457.4154258469, 71669.0, 74523.0, 81370.30407871392, 81474.59262703886, 84132.0, 11890.16768826174, 11905.464254108412, 12050.156489045683, 12165.0, 12316.261024338568, 12346.506139754669, 12483.500659973499, 12525.436355363849, 13323.000774942111, 13335.266560339274, 12070.939645301718, 12288.324142172267, 12299.385030748606, 12719.046071544486, 13096.279704615956, 12113.454894529592, 12299.200551964093, 12337.383130843602, 12509.0, 12696.365181740692, 11652.417379131179, 11793.351365674971, 11851.170418070653, 11875.049996000473, 12366.44351004189, 9995.550200241152, 10169.135623472088, 10343.793124137626, 10383.428911409643, 10390.896091039296, 9618.711438656852, 10135.290529662852, 10141.138003269805, 10169.0, 10227.335223210468], "value": 7524.173869871584, "unit": "score"}], "name": "dromaeo_css", "value": 7297.6995740500015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 120.0, 169.0, 128.0, 118.0, 119.0, 123.0, 162.0, 120.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 110.0, 76.0, 77.0, 76.0, 75.0, 104.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 114.0, 82.0, 83.0, 82.0, 111.0, 82.0, 83.0, 111.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 53.0, 53.0, 51.0, 52.0, 55.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0, 62.0, 66.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 79.0, 81.0, 84.0, 79.0, 78.0, 78.0, 77.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 123.0, 129.0, 133.0, 132.0, 134.0, 124.0, 175.0, 125.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 162.0, 165.0, 162.0, 166.0, 165.0, 166.0, 174.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 62.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1492.8999999999999, "alertThreshold": 2.0}]} 15:34:04 INFO - Return code: 0 15:34:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:34:04 INFO - # TBPL SUCCESS # 15:34:04 INFO - Running post-action listener: _resource_record_post_action 15:34:04 INFO - [mozharness: 2016-09-22 22:34:04.567795Z] Finished run-tests step (success) 15:34:04 INFO - Running post-run listener: _resource_record_post_run 15:34:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403456000; Read time: 172; Write time: 244524 15:34:04 INFO - TinderboxPrint: CPU usage
13.1% 15:34:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 15:34:04 INFO - TinderboxPrint: I/O write bytes / time
403,456,000 / 244,524 15:34:04 INFO - TinderboxPrint: CPU idle
8,294.4 (86.9%) 15:34:04 INFO - TinderboxPrint: CPU user
1,194.5 (12.5%) 15:34:04 INFO - TinderboxPrint: Swap in / out
0 / 0 15:34:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114413568; Read time: 0; Write time: 54340 15:34:04 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288010240; Read time: 160; Write time: 190152 15:34:05 INFO - Running post-run listener: _upload_blobber_files 15:34:05 INFO - Blob upload gear active. 15:34:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:05 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 15:34:05 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:34:05 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:34:05 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:06 INFO - (blobuploader) - INFO - Done attempting. 15:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:07 INFO - (blobuploader) - INFO - Done attempting. 15:34:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:34:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:11 INFO - (blobuploader) - INFO - Done attempting. 15:34:11 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:11 INFO - Return code: 0 15:34:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c0219075617efacb3e1fb76dd1a9f55693063331e7e9d48f157cd6b730db3bb8d1dec3ad39cf14d3bd89806cea4ee082e6f1913d958adde37f8bd42450d2dfab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b152ebdc82cde4b285cf12bfa070fa4cb746425bdaae044dda4a7bed5e5941b92be7e389c5d7a99addf4e0edfc41c49b9520b8d411aa7c5b527201423a16b346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d161f2c3926526c026deaf5eaadcae9a0855d4b20307c3e78d05f9ff1952a1b5e12355bdacaf7bad1eba08f6e4d2a10c7fdb0a7afd8d3d5292cb78af09fe236"} 15:34:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:11 INFO - Contents: 15:34:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c0219075617efacb3e1fb76dd1a9f55693063331e7e9d48f157cd6b730db3bb8d1dec3ad39cf14d3bd89806cea4ee082e6f1913d958adde37f8bd42450d2dfab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b152ebdc82cde4b285cf12bfa070fa4cb746425bdaae044dda4a7bed5e5941b92be7e389c5d7a99addf4e0edfc41c49b9520b8d411aa7c5b527201423a16b346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d161f2c3926526c026deaf5eaadcae9a0855d4b20307c3e78d05f9ff1952a1b5e12355bdacaf7bad1eba08f6e4d2a10c7fdb0a7afd8d3d5292cb78af09fe236"} 15:34:11 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:11 INFO - Copying logs to upload dir... 15:34:11 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.540149 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-22 15:34:10.625206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 15:34:10.631052) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c0219075617efacb3e1fb76dd1a9f55693063331e7e9d48f157cd6b730db3bb8d1dec3ad39cf14d3bd89806cea4ee082e6f1913d958adde37f8bd42450d2dfab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b152ebdc82cde4b285cf12bfa070fa4cb746425bdaae044dda4a7bed5e5941b92be7e389c5d7a99addf4e0edfc41c49b9520b8d411aa7c5b527201423a16b346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d161f2c3926526c026deaf5eaadcae9a0855d4b20307c3e78d05f9ff1952a1b5e12355bdacaf7bad1eba08f6e4d2a10c7fdb0a7afd8d3d5292cb78af09fe236"} build_url:https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/eeo0gGApTMCbYOxQI5jr8Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c0219075617efacb3e1fb76dd1a9f55693063331e7e9d48f157cd6b730db3bb8d1dec3ad39cf14d3bd89806cea4ee082e6f1913d958adde37f8bd42450d2dfab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b152ebdc82cde4b285cf12bfa070fa4cb746425bdaae044dda4a7bed5e5941b92be7e389c5d7a99addf4e0edfc41c49b9520b8d411aa7c5b527201423a16b346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d161f2c3926526c026deaf5eaadcae9a0855d4b20307c3e78d05f9ff1952a1b5e12355bdacaf7bad1eba08f6e4d2a10c7fdb0a7afd8d3d5292cb78af09fe236"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 15:34:10.656801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:34:10.657235) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1474582327.120240-1896229386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:34:10.742372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 15:34:10.742688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 15:34:10.742976) ========= ========= Total master_lag: 0.21 =========