builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1477029354.27 results: success (0) buildid: 20161020200849 builduid: 22729866934548208d7f102f00df1503 revision: 10be9d40fa865be7c3c203b9cd042722ab3069ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.266002) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.266522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.266837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.281695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.282008) ========= 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=4300f881736b422476174874000001bc-1477029353.760481-1240039752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 22:55:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-10-20 22:55:54 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.423981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.424674) ========= 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=4300f881736b422476174874000001bc-1477029353.760481-1240039752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.474183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:54.474574) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 10be9d40fa865be7c3c203b9cd042722ab3069ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 10be9d40fa865be7c3c203b9cd042722ab3069ca --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=4300f881736b422476174874000001bc-1477029353.760481-1240039752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 22:55:54,696 truncating revision to first 12 chars 2016-10-20 22:55:54,696 Setting DEBUG logging. 2016-10-20 22:55:54,696 attempt 1/10 2016-10-20 22:55:54,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/10be9d40fa86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 22:55:55,198 unpacking tar archive at: mozilla-aurora-10be9d40fa86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.877606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:55.366227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:55.366604) ========= script_repo_revision: 10be9d40fa865be7c3c203b9cd042722ab3069ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:55.367137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:55.367488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 22:55:55.378553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-20 22:55:55.378911) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1477029353.760481-1240039752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:55:55 INFO - MultiFileLogger online at 20161020 22:55:55 in /builds/slave/test 22:55:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:55:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:55:55 INFO - {'append_to_log': False, 22:55:55 INFO - 'base_work_dir': '/builds/slave/test', 22:55:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:55:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:55:55 INFO - 'branch': 'Mozilla-Aurora', 22:55:55 INFO - 'buildbot_json_path': 'buildprops.json', 22:55:55 INFO - 'config_files': ('talos/linux_config.py',), 22:55:55 INFO - 'default_actions': ('clobber', 22:55:55 INFO - 'read-buildbot-config', 22:55:55 INFO - 'download-and-extract', 22:55:55 INFO - 'populate-webroot', 22:55:55 INFO - 'create-virtualenv', 22:55:55 INFO - 'install', 22:55:55 INFO - 'run-tests'), 22:55:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:55:55 INFO - 'download_minidump_stackwalk': True, 22:55:55 INFO - 'download_symbols': 'ondemand', 22:55:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:55:55 INFO - 'tooltool.py': '/tools/tooltool.py', 22:55:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:55:55 INFO - '/tools/misc-python/virtualenv.py')}, 22:55:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:55:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:55:55 INFO - 'installer_path': 'installer.exe', 22:55:55 INFO - 'log_level': 'info', 22:55:55 INFO - 'log_name': 'talos', 22:55:55 INFO - 'log_to_console': True, 22:55:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:55:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:55:55 INFO - 'opt_config_files': (), 22:55:55 INFO - 'pip_index': False, 22:55:55 INFO - 'sps_profile': False, 22:55:55 INFO - 'sps_profile_interval': 0, 22:55:55 INFO - 'suite': 'dromaeojs', 22:55:55 INFO - 'system_bits': '32', 22:55:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:55:55 INFO - 'title': 'talos-linux64-ix-045', 22:55:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:55:55 INFO - 'use_talos_json': True, 22:55:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:55:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:55:55 INFO - 'work_dir': 'build'} 22:55:55 INFO - [mozharness: 2016-10-21 05:55:55.695449Z] Running clobber step. 22:55:55 INFO - Running pre-action listener: _resource_record_pre_action 22:55:55 INFO - Running main action method: clobber 22:55:55 INFO - rmtree: /builds/slave/test/build 22:55:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:55:56 INFO - Running post-action listener: _resource_record_post_action 22:55:56 INFO - [mozharness: 2016-10-21 05:55:56.668703Z] Finished clobber step (success) 22:55:56 INFO - [mozharness: 2016-10-21 05:55:56.668829Z] Running read-buildbot-config step. 22:55:56 INFO - Running pre-action listener: _resource_record_pre_action 22:55:56 INFO - Running main action method: read_buildbot_config 22:55:56 INFO - Using buildbot properties: 22:55:56 INFO - { 22:55:56 INFO - "project": "", 22:55:56 INFO - "product": "firefox", 22:55:56 INFO - "script_repo_revision": "production", 22:55:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:55:56 INFO - "repository": "", 22:55:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:55:56 INFO - "buildid": "20161020200849", 22:55:56 INFO - "pgo_build": "True", 22:55:56 INFO - "basedir": "/builds/slave/test", 22:55:56 INFO - "buildnumber": 545, 22:55:56 INFO - "slavename": "talos-linux64-ix-045", 22:55:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:55:56 INFO - "platform": "ubuntu64_hw", 22:55:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:55:56 INFO - "branch": "mozilla-aurora", 22:55:56 INFO - "repo_path": "releases/mozilla-aurora", 22:55:56 INFO - "revision": "10be9d40fa865be7c3c203b9cd042722ab3069ca", 22:55:56 INFO - "stage_platform": "linux64-pgo", 22:55:56 INFO - "builduid": "22729866934548208d7f102f00df1503", 22:55:56 INFO - "slavebuilddir": "test" 22:55:56 INFO - } 22:55:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 22:55:56 INFO - Running post-action listener: _resource_record_post_action 22:55:56 INFO - [mozharness: 2016-10-21 05:55:56.671306Z] Finished read-buildbot-config step (success) 22:55:56 INFO - [mozharness: 2016-10-21 05:55:56.671396Z] Running download-and-extract step. 22:55:56 INFO - Running pre-action listener: _resource_record_pre_action 22:55:56 INFO - Running main action method: download_and_extract 22:55:56 INFO - mkdir: /builds/slave/test/build/tests 22:55: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')]} 22:55:56 INFO - trying https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:55:56 INFO - Downloading https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:55:57 INFO - Downloaded 1361 bytes. 22:55:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:55:57 INFO - Using the following test package requirements: 22:55:57 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 22:55:57 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:55:57 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:55:57 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'jsshell-linux-x86_64.zip'], 22:55:57 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:55:57 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 22:55:57 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:55:57 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:55:57 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:55:57 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:55:57 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:55:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:55:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 22:55:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:55:57 INFO - Fetch https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:55:57 INFO - Expected file size: 21907975 22:56:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:56:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 22:56:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:56:02 INFO - Fetch https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:56:02 INFO - Expected file size: 21907975 22:56:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 22:56:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:56:07 INFO - Fetch https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 22:56:08 INFO - Expected file size: 14414081 22:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:08 INFO - trying https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:56:08 INFO - Downloading https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:56:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:56:09 INFO - Downloaded 63998895 bytes. 22:56:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:56:09 INFO - mkdir: /builds/slave/test/properties 22:56:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:56:09 INFO - Writing to file /builds/slave/test/properties/build_url 22:56:09 INFO - Contents: 22:56:09 INFO - build_url:https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:56:10 INFO - Running post-action listener: _resource_record_post_action 22:56:10 INFO - Running post-action listener: set_extra_try_arguments 22:56:10 INFO - [mozharness: 2016-10-21 05:56:10.345239Z] Finished download-and-extract step (success) 22:56:10 INFO - [mozharness: 2016-10-21 05:56:10.345466Z] Running populate-webroot step. 22:56:10 INFO - Running pre-action listener: _resource_record_pre_action 22:56:10 INFO - Running main action method: populate_webroot 22:56:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:56:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:56:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:56:10 INFO - '--tppagecycles', 22:56:10 INFO - '7'], 22:56:10 INFO - 'tests': ['tsvgm']}}, 22:56:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:56:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:56:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:56:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:56:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['damp', 'tps']}, 22:56:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'tests': ['damp', 'tps']}, 22:56:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['dromaeo_dom']}, 22:56:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:56:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['basic_compositor_video']}, 22:56:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:56:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['a11yr', 22:56:10 INFO - 'ts_paint', 22:56:10 INFO - 'tpaint', 22:56:10 INFO - 'sessionrestore', 22:56:10 INFO - 'sessionrestore_no_auto_restore', 22:56:10 INFO - 'tabpaint']}, 22:56:10 INFO - 'other-e10s': {'tests': ['a11yr', 22:56:10 INFO - 'ts_paint', 22:56:10 INFO - 'tpaint', 22:56:10 INFO - 'sessionrestore', 22:56:10 INFO - 'sessionrestore_no_auto_restore', 22:56:10 INFO - 'tabpaint']}, 22:56:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:56:10 INFO - 'ts_paint', 22:56:10 INFO - 'tpaint', 22:56:10 INFO - 'sessionrestore', 22:56:10 INFO - 'sessionrestore_no_auto_restore', 22:56:10 INFO - 'tabpaint']}, 22:56:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:56:10 INFO - 'ts_paint', 22:56:10 INFO - 'tpaint', 22:56:10 INFO - 'sessionrestore', 22:56:10 INFO - 'sessionrestore_no_auto_restore', 22:56:10 INFO - 'tabpaint']}, 22:56:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['a11yr', 22:56:10 INFO - 'ts_paint', 22:56:10 INFO - 'tpaint', 22:56:10 INFO - 'sessionrestore', 22:56:10 INFO - 'sessionrestore_no_auto_restore', 22:56:10 INFO - 'tabpaint']}, 22:56:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['a11yr', 22:56:10 INFO - 'ts_paint', 22:56:10 INFO - 'tpaint', 22:56:10 INFO - 'sessionrestore', 22:56:10 INFO - 'sessionrestore_no_auto_restore', 22:56:10 INFO - 'tabpaint']}, 22:56:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['tsvgx', 22:56:10 INFO - 'tsvgr_opacity', 22:56:10 INFO - 'tart', 22:56:10 INFO - 'tscrollx', 22:56:10 INFO - 'cart']}, 22:56:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:56:10 INFO - 'tsvgr_opacity', 22:56:10 INFO - 'tart', 22:56:10 INFO - 'tscrollx', 22:56:10 INFO - 'cart']}, 22:56:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'talos_options': ['--disable-e10s'], 22:56:10 INFO - 'tests': ['tp5o']}, 22:56:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'tests': ['tp5o']}, 22:56:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'talos_options': ['--disable-e10s', 22:56:10 INFO - '--xperf_path', 22:56:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:10 INFO - 'tests': ['tp5n']}, 22:56:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:10 INFO - 'talos_options': ['--xperf_path', 22:56:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:10 INFO - 'tests': ['tp5n']}}, 22:56:10 INFO - 'talos.zip': {'path': '', 22:56:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:56:10 INFO - Running post-action listener: _resource_record_post_action 22:56:10 INFO - [mozharness: 2016-10-21 05:56:10.365987Z] Finished populate-webroot step (success) 22:56:10 INFO - [mozharness: 2016-10-21 05:56:10.366076Z] Running create-virtualenv step. 22:56:10 INFO - Running pre-action listener: _resource_record_pre_action 22:56:10 INFO - Running main action method: create_virtualenv 22:56:10 INFO - Creating virtualenv /builds/slave/test/build/venv 22:56:10 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 22:56:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:56:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:56:10 INFO - Using real prefix '/usr' 22:56:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:56:10 INFO - Installing distribute.............................................................................................................................................................................................done. 22:56:12 INFO - Installing pip.................done. 22:56:12 INFO - Return code: 0 22:56:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:12 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:12 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 22:56:12 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 22:56:12 INFO - Using env: {'DISPLAY': ':0', 22:56:12 INFO - 'HOME': '/home/cltbld', 22:56:12 INFO - 'LANG': 'en_US.UTF-8', 22:56:12 INFO - 'LANGUAGE': 'en_US:en', 22:56:12 INFO - 'LOGNAME': 'cltbld', 22:56:12 INFO - 'MAIL': '/var/mail/cltbld', 22:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:12 INFO - 'MOZ_NO_REMOTE': '1', 22:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:12 INFO - 'NO_EM_RESTART': '1', 22:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:12 INFO - 'PWD': '/builds/slave/test', 22:56:12 INFO - 'SHELL': '/bin/bash', 22:56:12 INFO - 'SHLVL': '1', 22:56:12 INFO - 'TERM': 'linux', 22:56:12 INFO - 'TMOUT': '86400', 22:56:12 INFO - 'USER': 'cltbld', 22:56:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:12 INFO - '_': '/tools/buildbot/bin/python'} 22:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:13 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 22:56:13 INFO - Cleaning up... 22:56:13 INFO - Return code: 0 22:56:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:13 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:13 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 22:56:13 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 22:56:13 INFO - Using env: {'DISPLAY': ':0', 22:56:13 INFO - 'HOME': '/home/cltbld', 22:56:13 INFO - 'LANG': 'en_US.UTF-8', 22:56:13 INFO - 'LANGUAGE': 'en_US:en', 22:56:13 INFO - 'LOGNAME': 'cltbld', 22:56:13 INFO - 'MAIL': '/var/mail/cltbld', 22:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:13 INFO - 'MOZ_NO_REMOTE': '1', 22:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:13 INFO - 'NO_EM_RESTART': '1', 22:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:13 INFO - 'PWD': '/builds/slave/test', 22:56:13 INFO - 'SHELL': '/bin/bash', 22:56:13 INFO - 'SHLVL': '1', 22:56:13 INFO - 'TERM': 'linux', 22:56:13 INFO - 'TMOUT': '86400', 22:56:13 INFO - 'USER': 'cltbld', 22:56:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:13 INFO - '_': '/tools/buildbot/bin/python'} 22:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:13 INFO - Downloading/unpacking psutil>=3.1.1 22:56:13 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 22:56:13 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 22:56:13 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 22:56:13 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 22:56:13 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 22:56:13 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 22:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:56:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:15 INFO - Installing collected packages: psutil 22:56:15 INFO - Running setup.py install for psutil 22:56:15 INFO - building 'psutil._psutil_linux' extension 22:56:15 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 22:56:15 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 22:56:15 INFO - building 'psutil._psutil_posix' extension 22:56:15 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 22:56:15 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 22:56:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:15 INFO - Successfully installed psutil 22:56:15 INFO - Cleaning up... 22:56:15 INFO - Return code: 0 22:56:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:56:15 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')]} 22:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:15 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')]} 22:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:15 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:15 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 22:56:15 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 22:56:15 INFO - Using env: {'DISPLAY': ':0', 22:56:15 INFO - 'HOME': '/home/cltbld', 22:56:15 INFO - 'LANG': 'en_US.UTF-8', 22:56:15 INFO - 'LANGUAGE': 'en_US:en', 22:56:15 INFO - 'LOGNAME': 'cltbld', 22:56:15 INFO - 'MAIL': '/var/mail/cltbld', 22:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:15 INFO - 'MOZ_NO_REMOTE': '1', 22:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:15 INFO - 'NO_EM_RESTART': '1', 22:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:15 INFO - 'PWD': '/builds/slave/test', 22:56:15 INFO - 'SHELL': '/bin/bash', 22:56:15 INFO - 'SHLVL': '1', 22:56:15 INFO - 'TERM': 'linux', 22:56:15 INFO - 'TMOUT': '86400', 22:56:15 INFO - 'USER': 'cltbld', 22:56:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:15 INFO - '_': '/tools/buildbot/bin/python'} 22:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:56:16 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 22:56:16 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 22:56:16 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 22:56:16 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 22:56:16 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 22:56:16 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 22:56:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:56:18 INFO - Installing collected packages: mozsystemmonitor 22:56:18 INFO - Running setup.py install for mozsystemmonitor 22:56:18 INFO - Successfully installed mozsystemmonitor 22:56:18 INFO - Cleaning up... 22:56:18 INFO - Return code: 0 22:56:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:56:18 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')]} 22:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:18 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')]} 22:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:18 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:18 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 22:56:18 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 22:56:18 INFO - Using env: {'DISPLAY': ':0', 22:56:18 INFO - 'HOME': '/home/cltbld', 22:56:18 INFO - 'LANG': 'en_US.UTF-8', 22:56:18 INFO - 'LANGUAGE': 'en_US:en', 22:56:18 INFO - 'LOGNAME': 'cltbld', 22:56:18 INFO - 'MAIL': '/var/mail/cltbld', 22:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:18 INFO - 'MOZ_NO_REMOTE': '1', 22:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:18 INFO - 'NO_EM_RESTART': '1', 22:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:18 INFO - 'PWD': '/builds/slave/test', 22:56:18 INFO - 'SHELL': '/bin/bash', 22:56:18 INFO - 'SHLVL': '1', 22:56:18 INFO - 'TERM': 'linux', 22:56:18 INFO - 'TMOUT': '86400', 22:56:18 INFO - 'USER': 'cltbld', 22:56:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:18 INFO - '_': '/tools/buildbot/bin/python'} 22:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:18 INFO - Downloading/unpacking jsonschema==2.5.1 22:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:56:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:20 INFO - Downloading functools32-3.2.3-2.tar.gz 22:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:56:20 INFO - warning: no files found matching '*.txt' 22:56:20 INFO - no previously-included directories found matching 'build' 22:56:20 INFO - no previously-included directories found matching 'dist' 22:56:20 INFO - no previously-included directories found matching '.git*' 22:56:20 INFO - Installing collected packages: jsonschema, functools32 22:56:20 INFO - Running setup.py install for functools32 22:56:20 INFO - warning: no files found matching '*.txt' 22:56:20 INFO - no previously-included directories found matching 'build' 22:56:20 INFO - no previously-included directories found matching 'dist' 22:56:20 INFO - no previously-included directories found matching '.git*' 22:56:20 INFO - Successfully installed jsonschema functools32 22:56:20 INFO - Cleaning up... 22:56:20 INFO - Return code: 0 22:56:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:56:20 INFO - Using env: {'DISPLAY': ':0', 22:56:20 INFO - 'HOME': '/home/cltbld', 22:56:20 INFO - 'LANG': 'en_US.UTF-8', 22:56:20 INFO - 'LANGUAGE': 'en_US:en', 22:56:20 INFO - 'LOGNAME': 'cltbld', 22:56:20 INFO - 'MAIL': '/var/mail/cltbld', 22:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:20 INFO - 'MOZ_NO_REMOTE': '1', 22:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:20 INFO - 'NO_EM_RESTART': '1', 22:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:20 INFO - 'PWD': '/builds/slave/test', 22:56:20 INFO - 'SHELL': '/bin/bash', 22:56:20 INFO - 'SHLVL': '1', 22:56:20 INFO - 'TERM': 'linux', 22:56:20 INFO - 'TMOUT': '86400', 22:56:20 INFO - 'USER': 'cltbld', 22:56:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:20 INFO - '_': '/tools/buildbot/bin/python'} 22:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:56:21 INFO - Cleaning up... 22:56:21 INFO - Return code: 0 22:56:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:56:21 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')]} 22:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:21 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')]} 22:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:21 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:21 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 22:56:21 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 22:56:21 INFO - Using env: {'DISPLAY': ':0', 22:56:21 INFO - 'HOME': '/home/cltbld', 22:56:21 INFO - 'LANG': 'en_US.UTF-8', 22:56:21 INFO - 'LANGUAGE': 'en_US:en', 22:56:21 INFO - 'LOGNAME': 'cltbld', 22:56:21 INFO - 'MAIL': '/var/mail/cltbld', 22:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:21 INFO - 'MOZ_NO_REMOTE': '1', 22:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:21 INFO - 'NO_EM_RESTART': '1', 22:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:21 INFO - 'PWD': '/builds/slave/test', 22:56:21 INFO - 'SHELL': '/bin/bash', 22:56:21 INFO - 'SHLVL': '1', 22:56:21 INFO - 'TERM': 'linux', 22:56:21 INFO - 'TMOUT': '86400', 22:56:21 INFO - 'USER': 'cltbld', 22:56:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:21 INFO - '_': '/tools/buildbot/bin/python'} 22:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:21 INFO - Downloading/unpacking blobuploader==1.2.4 22:56:21 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 22:56:21 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 22:56:21 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 22:56:21 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 22:56:21 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 22:56:21 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 22:56:23 INFO - Downloading blobuploader-1.2.4.tar.gz 22:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:56:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:56:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:23 INFO - Downloading docopt-0.6.1.tar.gz 22:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:56:24 INFO - Installing collected packages: blobuploader, requests, docopt 22:56:24 INFO - Running setup.py install for blobuploader 22:56:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:56:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:56:24 INFO - Running setup.py install for requests 22:56:24 INFO - Running setup.py install for docopt 22:56:24 INFO - Successfully installed blobuploader requests docopt 22:56:24 INFO - Cleaning up... 22:56:24 INFO - Return code: 0 22:56:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:24 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:24 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 22:56:24 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 22:56:24 INFO - Using env: {'DISPLAY': ':0', 22:56:24 INFO - 'HOME': '/home/cltbld', 22:56:24 INFO - 'LANG': 'en_US.UTF-8', 22:56:24 INFO - 'LANGUAGE': 'en_US:en', 22:56:24 INFO - 'LOGNAME': 'cltbld', 22:56:24 INFO - 'MAIL': '/var/mail/cltbld', 22:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:24 INFO - 'MOZ_NO_REMOTE': '1', 22:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:24 INFO - 'NO_EM_RESTART': '1', 22:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:24 INFO - 'PWD': '/builds/slave/test', 22:56:24 INFO - 'SHELL': '/bin/bash', 22:56:24 INFO - 'SHLVL': '1', 22:56:24 INFO - 'TERM': 'linux', 22:56:24 INFO - 'TMOUT': '86400', 22:56:24 INFO - 'USER': 'cltbld', 22:56:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:24 INFO - '_': '/tools/buildbot/bin/python'} 22:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:24 INFO - Running setup.py (path:/tmp/pip-4zegYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:24 INFO - Running setup.py (path:/tmp/pip-Hi9Wrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:25 INFO - Running setup.py (path:/tmp/pip-BAOJvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:25 INFO - Running setup.py (path:/tmp/pip-uQI9U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:25 INFO - Running setup.py (path:/tmp/pip-Q3nXnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:25 INFO - Running setup.py (path:/tmp/pip-uCx0Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:25 INFO - Running setup.py (path:/tmp/pip-ZUWvn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:25 INFO - Running setup.py (path:/tmp/pip-f7l3zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:25 INFO - Running setup.py (path:/tmp/pip-OPpkIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:25 INFO - Running setup.py (path:/tmp/pip-WYYQpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:56:25 INFO - Running setup.py (path:/tmp/pip-WvQmfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:56:25 INFO - Running setup.py (path:/tmp/pip-a9iwbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:56:25 INFO - Running setup.py (path:/tmp/pip-gB909l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:56:25 INFO - Running setup.py (path:/tmp/pip-fP0li7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:25 INFO - Running setup.py (path:/tmp/pip-UJM36R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:56:25 INFO - Running setup.py (path:/tmp/pip-VPW54h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:56:26 INFO - Running setup.py (path:/tmp/pip-1HkQTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:56:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:56:26 INFO - Running setup.py install for manifestparser 22:56:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Running setup.py install for mozcrash 22:56:26 INFO - Running setup.py install for mozdebug 22:56:26 INFO - Running setup.py install for mozdevice 22:56:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Running setup.py install for mozfile 22:56:26 INFO - Running setup.py install for mozhttpd 22:56:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Running setup.py install for mozinfo 22:56:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Running setup.py install for mozInstall 22:56:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:56:26 INFO - Running setup.py install for mozleak 22:56:27 INFO - Running setup.py install for mozlog 22:56:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Running setup.py install for moznetwork 22:56:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Running setup.py install for mozprocess 22:56:27 INFO - Running setup.py install for mozprofile 22:56:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Running setup.py install for mozrunner 22:56:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Running setup.py install for mozscreenshot 22:56:27 INFO - Running setup.py install for moztest 22:56:27 INFO - Running setup.py install for mozversion 22:56:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:56:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:56:27 INFO - Cleaning up... 22:56:27 INFO - Return code: 0 22:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:27 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:27 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 22:56:27 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 22:56:27 INFO - Using env: {'DISPLAY': ':0', 22:56:27 INFO - 'HOME': '/home/cltbld', 22:56:27 INFO - 'LANG': 'en_US.UTF-8', 22:56:27 INFO - 'LANGUAGE': 'en_US:en', 22:56:27 INFO - 'LOGNAME': 'cltbld', 22:56:27 INFO - 'MAIL': '/var/mail/cltbld', 22:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:27 INFO - 'MOZ_NO_REMOTE': '1', 22:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:27 INFO - 'NO_EM_RESTART': '1', 22:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:27 INFO - 'PWD': '/builds/slave/test', 22:56:27 INFO - 'SHELL': '/bin/bash', 22:56:27 INFO - 'SHLVL': '1', 22:56:27 INFO - 'TERM': 'linux', 22:56:27 INFO - 'TMOUT': '86400', 22:56:27 INFO - 'USER': 'cltbld', 22:56:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:27 INFO - '_': '/tools/buildbot/bin/python'} 22:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:28 INFO - Running setup.py (path:/tmp/pip-K6v0Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:28 INFO - Running setup.py (path:/tmp/pip-jztNnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:28 INFO - Running setup.py (path:/tmp/pip-mZk41X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:28 INFO - Running setup.py (path:/tmp/pip-OF_UJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:28 INFO - Running setup.py (path:/tmp/pip-q7GCQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:28 INFO - Running setup.py (path:/tmp/pip-Hc96Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:28 INFO - Running setup.py (path:/tmp/pip-Jl_Xrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:28 INFO - Running setup.py (path:/tmp/pip-V5ypQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:28 INFO - Running setup.py (path:/tmp/pip-lntHZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:28 INFO - Running setup.py (path:/tmp/pip-JQdYBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:56:28 INFO - Running setup.py (path:/tmp/pip-GuFbUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:56:28 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)) 22:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:56:28 INFO - Running setup.py (path:/tmp/pip-jqur6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:56:29 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)) 22:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:56:29 INFO - Running setup.py (path:/tmp/pip-3wXBtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:56:29 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)) 22:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:56:29 INFO - Running setup.py (path:/tmp/pip-M_gwWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:56:29 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)) 22:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:29 INFO - Running setup.py (path:/tmp/pip-AugiUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:29 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)) 22:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:56:29 INFO - Running setup.py (path:/tmp/pip-UjokJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:56:29 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)) 22:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:56:29 INFO - Running setup.py (path:/tmp/pip-iZoLC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:56:29 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)) 22:56:29 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)) 22:56:29 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)) 22:56:29 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)) 22:56:29 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)) 22:56:29 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)) 22:56:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:56:29 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 22:56:29 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 22:56:29 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 22:56:29 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 22:56:29 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 22:56:29 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 22:56:31 INFO - Downloading blessings-1.6.tar.gz 22:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:56:31 INFO - Installing collected packages: blessings 22:56:31 INFO - Running setup.py install for blessings 22:56:31 INFO - Successfully installed blessings 22:56:31 INFO - Cleaning up... 22:56:31 INFO - Return code: 0 22:56:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:56:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:56:31 INFO - Reading from file tmpfile_stdout 22:56:31 INFO - Current package versions: 22:56:31 INFO - argparse == 1.2.1 22:56:31 INFO - blessings == 1.6 22:56:31 INFO - blobuploader == 1.2.4 22:56:31 INFO - docopt == 0.6.1 22:56:31 INFO - functools32 == 3.2.3-2 22:56:31 INFO - jsonschema == 2.5.1 22:56:31 INFO - manifestparser == 1.1 22:56:31 INFO - mozInstall == 1.12 22:56:31 INFO - mozcrash == 0.17 22:56:31 INFO - mozdebug == 0.1 22:56:31 INFO - mozdevice == 0.48 22:56:31 INFO - mozfile == 1.2 22:56:31 INFO - mozhttpd == 0.7 22:56:31 INFO - mozinfo == 0.9 22:56:31 INFO - mozleak == 0.1 22:56:31 INFO - mozlog == 3.4 22:56:31 INFO - moznetwork == 0.27 22:56:31 INFO - mozprocess == 0.23 22:56:31 INFO - mozprofile == 0.28 22:56:31 INFO - mozrunner == 6.12 22:56:31 INFO - mozscreenshot == 0.1 22:56:31 INFO - mozsystemmonitor == 0.3 22:56:31 INFO - moztest == 0.7 22:56:31 INFO - mozversion == 1.4 22:56:31 INFO - psutil == 3.1.1 22:56:31 INFO - requests == 1.2.3 22:56:31 INFO - wsgiref == 0.1.2 22:56:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:31 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')]} 22:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:31 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')]} 22:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:31 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 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:31 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 22:56:31 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 22:56:31 INFO - Using env: {'DISPLAY': ':0', 22:56:31 INFO - 'HOME': '/home/cltbld', 22:56:31 INFO - 'LANG': 'en_US.UTF-8', 22:56:31 INFO - 'LANGUAGE': 'en_US:en', 22:56:31 INFO - 'LOGNAME': 'cltbld', 22:56:31 INFO - 'MAIL': '/var/mail/cltbld', 22:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:31 INFO - 'MOZ_NO_REMOTE': '1', 22:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:31 INFO - 'NO_EM_RESTART': '1', 22:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:31 INFO - 'PWD': '/builds/slave/test', 22:56:31 INFO - 'SHELL': '/bin/bash', 22:56:31 INFO - 'SHLVL': '1', 22:56:31 INFO - 'TERM': 'linux', 22:56:31 INFO - 'TMOUT': '86400', 22:56:31 INFO - 'USER': 'cltbld', 22:56:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:31 INFO - '_': '/tools/buildbot/bin/python'} 22:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 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)) 22:56:32 INFO - Cleaning up... 22:56:32 INFO - Return code: 0 22:56:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:56: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')]} 22:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56: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')]} 22:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa877b6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e83ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, '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': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', '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 22:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:56:32 INFO - Using env: {'DISPLAY': ':0', 22:56:32 INFO - 'HOME': '/home/cltbld', 22:56:32 INFO - 'LANG': 'en_US.UTF-8', 22:56:32 INFO - 'LANGUAGE': 'en_US:en', 22:56:32 INFO - 'LOGNAME': 'cltbld', 22:56:32 INFO - 'MAIL': '/var/mail/cltbld', 22:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:32 INFO - 'MOZ_NO_REMOTE': '1', 22:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:32 INFO - 'NO_EM_RESTART': '1', 22:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:32 INFO - 'PWD': '/builds/slave/test', 22:56:32 INFO - 'SHELL': '/bin/bash', 22:56:32 INFO - 'SHLVL': '1', 22:56:32 INFO - 'TERM': 'linux', 22:56:32 INFO - 'TMOUT': '86400', 22:56:32 INFO - 'USER': 'cltbld', 22:56:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:32 INFO - '_': '/tools/buildbot/bin/python'} 22:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:56:32 INFO - Cleaning up... 22:56:32 INFO - Return code: 0 22:56:32 INFO - Running post-action listener: _resource_record_post_action 22:56:32 INFO - Running post-action listener: _start_resource_monitoring 22:56:32 INFO - Starting resource monitoring. 22:56:32 INFO - [mozharness: 2016-10-21 05:56:32.272156Z] Finished create-virtualenv step (success) 22:56:32 INFO - [mozharness: 2016-10-21 05:56:32.272611Z] Running install step. 22:56:32 INFO - Running pre-action listener: _resource_record_pre_action 22:56:32 INFO - Running main action method: install 22:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:56:32 INFO - Reading from file tmpfile_stdout 22:56:32 INFO - Detecting whether we're running mozinstall >=1.0... 22:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:56:32 INFO - Reading from file tmpfile_stdout 22:56:32 INFO - Output received: 22:56:32 INFO - Usage: mozinstall [options] installer 22:56:32 INFO - Options: 22:56:32 INFO - -h, --help show this help message and exit 22:56:32 INFO - -d DEST, --destination=DEST 22:56:32 INFO - Directory to install application into. [default: 22:56:32 INFO - "/builds/slave/test"] 22:56:32 INFO - --app=APP Application being installed. [default: firefox] 22:56:32 INFO - mkdir: /builds/slave/test/build/application 22:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:56:48 INFO - Reading from file tmpfile_stdout 22:56:48 INFO - Output received: 22:56:48 INFO - /builds/slave/test/build/application/firefox/firefox 22:56:48 INFO - Running post-action listener: _resource_record_post_action 22:56:48 INFO - [mozharness: 2016-10-21 05:56:48.523069Z] Finished install step (success) 22:56:48 INFO - [mozharness: 2016-10-21 05:56:48.523314Z] Running run-tests step. 22:56:48 INFO - Running pre-action listener: _resource_record_pre_action 22:56:48 INFO - Running main action method: run_tests 22:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:56:48 INFO - Python 2.7.3 22:56:48 INFO - Return code: 0 22:56:48 INFO - grabbing minidump binary from tooltool 22:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:48 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 0x1e80f60>, '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 0x1e81d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e821d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:56:48 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 22:56:48 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 22:56:48 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 22:56:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:56:48 INFO - Return code: 0 22:56:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:56:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:56:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:56:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:56:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 22:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 22:56:48 INFO - Using env: {'DISPLAY': ':0', 22:56:48 INFO - 'HOME': '/home/cltbld', 22:56:48 INFO - 'LANG': 'en_US.UTF-8', 22:56:48 INFO - 'LANGUAGE': 'en_US:en', 22:56:48 INFO - 'LOGNAME': 'cltbld', 22:56:48 INFO - 'MAIL': '/var/mail/cltbld', 22:56:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:56:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:48 INFO - 'MOZ_NO_REMOTE': '1', 22:56:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:48 INFO - 'NO_EM_RESTART': '1', 22:56:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:48 INFO - 'PWD': '/builds/slave/test', 22:56:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:56:48 INFO - 'SHELL': '/bin/bash', 22:56:48 INFO - 'SHLVL': '1', 22:56:48 INFO - 'TERM': 'linux', 22:56:48 INFO - 'TMOUT': '86400', 22:56:48 INFO - 'USER': 'cltbld', 22:56:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1477029353.760481-1240039752', 22:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:48 INFO - '_': '/tools/buildbot/bin/python'} 22:56:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 22:56:48 INFO - mozversion application_buildid: 20161020200849 22:56:48 INFO - mozversion application_changeset: 10be9d40fa865be7c3c203b9cd042722ab3069ca 22:56:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:56:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:56:48 INFO - mozversion application_name: Firefox 22:56:48 INFO - mozversion application_remotingname: firefox-dev 22:56:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:56:48 INFO - mozversion application_vendor: Mozilla 22:56:48 INFO - mozversion application_version: 51.0a2 22:56:48 INFO - mozversion platform_buildid: 20161020200849 22:56:48 INFO - mozversion platform_changeset: 10be9d40fa865be7c3c203b9cd042722ab3069ca 22:56:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:56:48 INFO - mozversion platform_version: 51.0a2 22:56:48 INFO - using testdate: 1477029408 22:56:48 INFO - actual date: 1477029408 22:56:48 INFO - starting webserver on 'localhost:33688' 22:56:48 INFO - SUITE-START | Running 2 tests 22:56:48 INFO - TEST-START | dromaeo_css 22:56:48 INFO - operating with platform_type : linux_ 22:56:48 INFO - Initialising browser for dromaeo_css test... 22:56:48 INFO - TEST-INFO | started process 20899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qsjpH/profile http://localhost:33688/getInfo.html) 22:56:52 INFO - PROCESS | 20899 | __metrics Screen width/height:1600/1200 22:56:52 INFO - PROCESS | 20899 | colorDepth:24 22:56:52 INFO - PROCESS | 20899 | Browser inner width/height: 1024/697 22:56:52 INFO - PROCESS | 20899 | __metrics 22:56:53 INFO - PROCESS | 20899 | 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" 22:56:53 INFO - PROCESS | 20899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:56:54 INFO - PROCESS | 20899 | console.error: PushService: 22:56:54 INFO - PROCESS | 20899 | stateChangeProcessEnqueue: Error transitioning state 22:56:54 INFO - PROCESS | 20899 | UnknownError 22:56:54 INFO - TEST-INFO | 20899: exit 0 22:56:54 INFO - Browser initialized. 22:56:54 INFO - Running cycle 1/1 for dromaeo_css test... 22:56:54 INFO - TEST-INFO | started process 20991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qsjpH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:06 INFO - PROCESS | 20991 | RSS: Main: 148004864 22:57:06 INFO - PROCESS | 20991 | 22:57:57 INFO - PROCESS | 20991 | 1477029477776 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] 23:00:07 INFO - PROCESS | 20991 | Cycle 1(1): loaded http://localhost:33688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33688/tests/dromaeo/cssquery-ext.html) 23:00:08 INFO - PROCESS | 20991 | RSS: Main: 243007488 23:00:08 INFO - PROCESS | 20991 | 23:03:10 INFO - PROCESS | 20991 | Cycle 1(1): loaded http://localhost:33688/tests/dromaeo/cssquery-ext.html (next: http://localhost:33688/tests/dromaeo/cssquery-jquery.html) 23:03:11 INFO - PROCESS | 20991 | RSS: Main: 230510592 23:03:11 INFO - PROCESS | 20991 | 23:06:13 INFO - PROCESS | 20991 | Cycle 1(1): loaded http://localhost:33688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33688/tests/dromaeo/cssquery-mootools.html) 23:06:13 INFO - PROCESS | 20991 | RSS: Main: 225120256 23:06:13 INFO - PROCESS | 20991 | 23:09:15 INFO - PROCESS | 20991 | Cycle 1(1): loaded http://localhost:33688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33688/tests/dromaeo/cssquery-prototype.html) 23:09:16 INFO - PROCESS | 20991 | RSS: Main: 176873472 23:09:16 INFO - PROCESS | 20991 | 23:12:18 INFO - PROCESS | 20991 | Cycle 1(1): loaded http://localhost:33688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33688/tests/dromaeo/cssquery-yui.html) 23:12:19 INFO - PROCESS | 20991 | RSS: Main: 179122176 23:12:19 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | Cycle 1(1): loaded http://localhost:33688/tests/dromaeo/cssquery-yui.html (next: http://localhost:33688/tests/dromaeo/cssquery-dojo.html) 23:15:22 INFO - PROCESS | 20991 | RSS: Main: 263512064 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | __start_tp_report 23:15:22 INFO - PROCESS | 20991 | _x_x_mozilla_page_load 23:15:22 INFO - PROCESS | 20991 | _x_x_mozilla_page_load_details 23:15:22 INFO - PROCESS | 20991 | |i|pagename|runs| 23:15:22 INFO - PROCESS | 20991 | |0;dojo.html;3158.147300228938;3207.5990501187352;3212.9518057229147;3226.6450690424062;3252.4145653782325;5721.570882183837;5748.5401167906575;5758;5794.362620111784;5795.82612521625;5621.690807005613;5666.631668941516;5668.234788303578;5680.31836179658;5680.721753056211;5113.054084994269;5114.539691427771;5123.66696164749;5143.408508021588;5186.3257776489;5129.2562578426105;5136.537711605954;5192.896142077157;5219.112750832349;5234.110201265775;5111.463296353885;5157.948420515803;5159.484051594829;5170.431252562215;5192.7403629818355;5266.236395722618;5273.894522109575;5276.947230527684;5280.788768449257;5322.467753224685;5062.594992400599;5103.489651034867;5175.792968281302;5198.766055527511;5225.08561001827;5509;5519.751611177467;5531.3362396512675;5573.749181286811;5609.80365687199;5935.258092738408;5985.670788106652;6045.395460453963;6050.939490605126;6054.909176362358;5993.130996005599;6092.634441933454;6100.084987251903;6114.2968558615885;6117.908231376533;5623.409541998113;5696.11710184922;5720.399358067426;5720.656760594336;5731.426857314319;6307.369263073656;6324.177856878577;6326.841828954221;6331.715072821734;6332.620042797447;5738.971305143447;6085.117657939662;6089.603310388689;6092.573519853568;6130.1724267224245;5858.882822343529;5871.148683440877;5917.911231331534;5924.526037916957;5990.520758339409;5952.9107063394085;5956.702164891738;5959.523238141025;5965.403459654;5988.281406231193;5894.145348924382;5919.911201331984;5971.790987315423;5972.492338151305;5993.820185394445;4602.217623004098;4617.330487079422;4617.976910115428;4669.112868555032;4717.622590192845;4180.770057646798;4190.015346393595;4196.832126714898;4216;4231.386448964883;5676.631018983753;5687.573431992617;5688.317401911714;5689.260396148474;5691.544676425876;5977.432143946318;6004.879902401927;6034.24571928509;6202.875942481125;6211.223597050369;5560.7219639018695;5710.457506536873;5712.457316554921;5748.051571490741;5753.194552762617;5244.9737751310995;5276.129438642658;5278.313819203479;5286;5294.126469132627;6059.939400606026;6107.84730381744;6280.089387038854;6325.58883672569;6352.14246076783;6099.359567245376;6110.558759196553;6115.027386288435;6139.522803442411;6187.381261873777;6376.585521941059;6388.93611063902;6391.680415979089;6394.136791533269;6396.584222025554;5658.632188907708;6059.242594675666;6063.605865618721;6064.514838812973;6069.787557435468;5885.73514191871;5918.467337939606;5957.255343082114;5964.224650795369;6020.51835853122;5874.060150375919;5878.941210587839;5882.088276317178;5882.794102206402;5887.61730487517;5873.060310350324;5886.705664716661;5893.410658934073;5895.498882594856;5901.409859014236;5647.5481961442165;5773.16289138081;5806.65160090396;5834;5864.706764661835;5932.762689492372;5938.8218353449465;5940.46535811779;5943.227380440515;5974.2830860297045;5572.721363931868;5613.158026295925;5785.8553536161935;5803.564732645153;5804.01331773591 23:15:22 INFO - PROCESS | 20991 | |1;ext.html;584.1442287049472;622.7540121651948;638.0684201066442;638.9329120442351;645.8094862015705;35312.82343588282;39237.99999999996;39251.41122883159;39255.60744392555;46108.30837537431;44348.556514434844;48754.26868596974;49022.26466603004;49059;49109.50890491103;9316.161545460924;9476.099770521823;9481.857772133424;9485.47829869357;9485.857712134324;8640.956795216016;8825.073367296405;8825.73522794314;9307.627694892197;11463.853614638552;11317.264377815456;11426.314421134717;11430.942845285763;11439.656810295704;11440.485178167002;11259.54961801527;11339.206255562114;11340.60307889224;11346.773064538704;11354.26197297173;8422.747317580483;8640.567971601395;8647.092055334162;11076.335419874833;11174.385408802513;36281.27437451263;43786.56213437857;44891.32663010057;44905.77547112276;49066.7546662268;3356.7314614830757;3567.678908898212;3922.882313530599;3963.7225394222414;4220;33922.32155356904;34144;34514.65485345139;34552.65447345519;34555.30889382198;4218.198542276958;4240.23675738367;4258.318669012943;4272.551382104865;4379.824807007748;338649;341179;341448;342413;342468;57676.71161644165;58947.70526147342;65216.34783652198;65759.67120164368;65903;68390.65804670945;69842.30157698358;69903.65048174726;76316.85524717133;76352;17521.386751463637;17701.911490442464;17704.645907081787;17707.911460442614;17718.82281177172;13422.194668319931;13506.594802155754;13518.121322114031;13521.459141634225;13523.053386262867;17629.7355539667;18051.638967220846;18977.525561861064;19432.804883491473;19484.610307793766;6466.385693359123;6678.33216678338;6710.362515561014;6718.49611279156;6835.111435513351;914.533587870191;995.586831464934;1007.0986467111894;1021.8313978193663;1130.7568872692411;33126.8343658285;33943.32113357719;34401.311973760385;34484;34586.65413345885;1078.735709751116;1091.3942761767137;1093.4805967165532;1119.776044791045;1146.5356530605118;17352.65294694124;17991.90129768965;18105.275788968556;18279.54301142482;18292.073203934302;534646;535961;536083;540663;541498;62263;62647;62693;62724.05913911295;62812;1288.4395288049727;1331.760283149023;1339.6918708697053;1421.4953691439803;1429.942802287897;34358.31283374268;36333;36523.634763653085;36871.815640921624;36920.44619330658;52910;53489.19766203588;53536;53599;53683.46316536941;414976;416928;417946;418340;523929;29245;31321;31385.37229255448;31545;31729.20676983094;40427.3935890956;40554.39168412535;40560.59439405686;40791.7960410196;40933.1813363737;41887.581124189586;42420.78789606032;42937.35593966155;43608.56391436045;44137;41992.160156797305;42302.36546451867;42486;44039.77980110079;44190.558094418644;42801.357979629705;43399.132017360105;43925;43973.340399893386;44108.33837492504;35232.29535409329;37758;37816;37834.24331513299;37861.43207851939;28464.43071138524;28872;29048.56427153637;29158.7084129156;29165.85417072986 23:15:22 INFO - PROCESS | 20991 | |2;jquery.html;392.2116545743059;425.544233441408;431.55118676576365;436.37598234524626;437.6148988889777;16022.919885400572;19437.805621943793;21571.24500642478;21865.344039678796;21868.89065554672;19427.805721942776;20761.792382076175;20839.583208335862;20850.89574552125;20900.268490602833;5964.910526342108;6022.126791615224;6232.283287421937;6260.154879091333;6261.499080073583;6066.6663333516635;6104.96947515264;6139.815805525842;6142.385761423867;6190.288116866551;5753.539716822645;5998.700064996733;6101.664408457533;6102.755889764404;6105.389461053904;6060.848478788043;6095.299040610343;6095.878082438371;6100.1154832549255;6103.206583144185;5847.707614619252;6135.539834512385;6175.536834737412;6205.696803671234;6209.782657607007;15223.695526089527;15505.767413488808;15632.06207627546;20635.58728825415;24550.631740523906;2381.8570885746913;2452.448199155194;2461.2001099642507;2514.8994040238367;2520.7101183363966;9796.216302695768;10131.189504839595;10189.59241630334;11023.669289921316;11304.208705390625;1961.2449207055245;1982.8017198280202;1987.8409727221788;2037.633226019316;2097.6643737002005;76411;81371.5931420345;86043.56978215132;88601.55699221526;89746.55126724325;10699.358038517714;10904.61833835812;10929.617463388744;11268.436578171058;11462.739098699136;15474.22628868552;15511;16369.754453683205;16444.506664800076;16974.15129243533;8188.181181881764;8553.14468553152;8743;8754;8773.298136149093;7776.572288524072;7833.804154896059;7866.410019248579;7954.085280192852;8028.879566806502;5049.873753156127;5142.948570514247;5212.218167274939;5262.236975638511;5266.473352664703;2065.5455799724036;2082.8125468707585;2103.3374487036535;2151.720276364094;2163.2320526212966;917.4266083697689;1047.0994944347856;1053.262716098734;1060.8567843341204;1090.4528117748848;20319.187232510532;20694.275700350718;20898.895505522374;21509.032093555827;21523.246686365903;972.873526441558;981.3326937682444;1004.352192835617;1019.938803671782;1078.44460103047;10381.792364152674;10598.25812193139;10944.4527773611;11008.284461509977;11260.662180134608;426509;442893;486707;488227;491583;98413.50793246132;100566;100861;100936;101445.49277253567;1023.8259495885717;1047.4553232319151;1055.2560444886337;1066.4667666166918;1070.0209308482806;17577;17827.643447131246;17969.640607188045;17992.370267041115;18329.81670183281;40698.796506018465;41704;41818.1636367277;42738.786306069516;43013.78493107514;61738.69130654498;62998;63222;63467.6826615864;63968.68015659892;8583.270422014199;8762.649494020168;9033.954830225806;9091.954540227256;9265;9429.952850235704;13424.530141445002;13981.650458738206;14167.291635418394;14273.71452570922;11091.944540277247;11304.886951130384;11331.150163737588;11359.54561817518;11425.37160456183;11146.331220126818;11550.422478876191;11643.126765492452;11709.707257318294;11734.413279335828;11942.462589183682;11945.283283003047;12044.277343359427;12099.213551119148;12200.389980501117;8977.775555611162;8982.236509896731;9050;9159.450432974043;9272.768180795265;8455.577221139041;10917.508712107816;12144.817827732768;12220.083493737828;12409.255444673348 23:15:22 INFO - PROCESS | 20991 | |3;mootools.html;1397.3362652739943;1530.1125347298564;1539.5689207022035;1700.7533907583402;1820.2082094288994;8046;8861.42400743952;9088.50013249271;9202.585883635236;9467.621295148187;9215.723528294146;9284;9290.117438843316;9293.860592091123;9297.721068367942;2385.427497400629;2407.1815582701965;2409;2413.4931664350506;2414.070582825616;2400.31590996566;2402.423418379594;2441.1578005588044;2445.119756887519;2449.497852940143;2389.223502361731;2389.354874183969;2401.9639705404347;2411.0837881605053;2416.2992732107755;2344.1443872986406;2349.9177528786495;2357.705286839145;2363.9409014774596;2394.724606670238;2339;2365.1721897335965;2366.715994080704;2372.9881350593137;2376.120835290936;8907.510086945216;9012.594433250519;9015.27877769777;9085.591148398338;9145.496997665126;5265.394479634852;5483.75323110461;5491.862703432406;5499.670019798785;5506.229127922094;3333.8999830005137;3338.7829791063505;3343.5151902973935;3368.5452463917304;3374.8650053997812;1144.7023773818785;1160.3444054109486;1172.208759087621;1179.799434096197;1181.8818118188199;12192.414986051845;12208.450619722134;12305;12315.261084334968;12317.630471085882;4302.677299202573;4352.368906508538;4461.821527138878;4487.080148569536;4559.316102584573;9869.062439068277;9876.35803672759;9877.308588398742;9881.752956176153;9883.258755593359;5243.606729495303;5248;5253.13323301651;5253.9211911820585;5259.053370393366;4274.658027357804;4416.84541041062;4778.354922085474;4896.1921282987905;4923.556879880756;4029.6373326400767;4052.068024354415;4125.5874412558505;4161.0845613964875;4167.437395951569;1256.5288016993627;1256.8743125687358;1263.0716423428773;1263.3304348695206;1276.3745764575292;936.5223735894742;987.9259055570861;1008.0625018732502;1009.268280496634;1015.9949200254099;5961.612495187799;6058.091286307089;6116.724747386378;6179.474744646665;6192.659403732748;467.6352445092833;474.70568247686657;481.4679778844397;492.9038837426667;495.00998003992015;3989.1423343981182;3992.740471869319;4002.799860006988;4095.877123686294;4138.896527586774;10708.250422470508;11037.613683521038;11083.667489975152;11115.221934464671;11131.888681113085;10993.6152234673;11034.227604067799;11047.502862371213;11068.446577671084;11078.944605276922;8097.514149151069;8323.875141872877;8421.368397370099;8424.073351931405;8430.199131082538;5744.942550574441;5794.710264486843;5824.068149096293;5860.589758716849;5988.341282459013;10273.434961077213;10275.383476991405;10287.382757034602;10321.225908057077;10366.326188797704;10241.539130738985;10512.106470950055;10699.144068474348;10702;10709.464526773785;6540.967295163494;6749.3250674932115;7292.708291668486;7440.888386674313;7513.060867391576;8340;8788.648454061766;8795.120487951153;8797.824043519222;8803.031666516807;7725.381969442544;7744.380449564134;7895.565743884142;8032.036155661358;8057.194280571896;7466.589337586485;7558.622068896643;7650.579218143055;7768.417368697484;7896.486728362638;6713.093732346266;6807.5575087619145;6831.351021652935;6841.144856892888;6841.555298905555;5018.824341148043;5019.071471777733;5022.648414610942;5073.949260507496;5300.734963251899;5212.296339994204;5232;5250.264962905273;5330.573554115584;5359.839204823861 23:15:22 INFO - PROCESS | 20991 | |4;prototype.html;319.53348111756833;329.4761329486117;335.0317582187479;338.52268301694613;342.02352284228544;5606.803761868336;5655.349634792;5675.574331925107;5701.002324593201;5702.45826646469;5557.416471270519;5585;5614.3718321686665;5618.185363122345;5630.521405680522;4039.7374170678813;4146.253674338618;4198.895027624303;4267.423897773791;4350.912981740364;4341.39220509129;4350.521442641307;4357.063231405247;4357.2592659248;4361.214981303364;4316.2446571849805;4321.416608757824;4321.9783901080455;4324.654027677794;4328.329108988112;4234.703570750049;4278.336857787048;4288.69979101463;4310.762908040057;4333.551543377997;3808.333541630231;3810.90472738181;3815.3704638734853;3815.8855234343014;3816.8282427290837;5418.187271909206;5422.40353561108;5442.591805614595;5491.341039075336;5508.586855985777;4874;4939.851804445872;4998;5018.197088465828;5050.646454748169;5747.885042299131;5766.7981620643495;5774.884502309972;5782.797602083949;5800.013997620373;4162.7502349859105;4166.625013745487;4195.181939521794;4202.096549241927;4224.78876056196;5916.178314673527;5927.911081333784;5982.367758186428;6015.909761353583;6032.832762799565;4310.956890431118;4322.740635561876;4328.9134217316105;4332.241857674894;4335.783210839509;4379.649628029813;4384.8903777405185;4395.63735242076;4405.911881762347;4410.794602698651;4672;4924.507549245119;4925.556699897026;4982;5043.46174416799;5824.825255242349;5826.941730582725;5830.5044071254415;5836.941630583639;5837.153612726216;1461.4519555166812;1474.1670955909876;1480.4448331875547;1482.3699927530972;1482.4885414531968;910.3945875992391;937.1471960515897;943.2689665509148;945.6548359848606;946.5882341181608;5510.862228444321;5618.887622247532;5619.072852979212;5640.689762063126;5659.585103724069;5965.343812180657;5972.25346831646;5974.283086029617;5976.491998180117;5983.700814959235;5386.461353864661;5492.1212605982855;5519.475649813261;5558.33300003994;5626.24045753818;3151.842407879597;3173;3179.140202981282;3183.2519357950864;3183.6657150998813;5950.523958083343;6136.140940268277;6140.662263575457;6161.291451483047;6162.887741690418;6082.695865206722;6085.756569737249;6097.512199024156;6103.23709536308;6168.475679567197;6110.755569777248;6119.867824452402;6120.17377654011;6134.938650613437;6142.232220972379;5727.799527016535;5906.527477801851;5931.733072011683;5944.256967879015;6013.188219590299;5838.912416313674;5865.35769984405;5908.113782932594;5954.851128721816;5957.523398128053;5850.7074646266665;6101.481374083252;6116.938830611637;6138.3861613840045;6158.753649853956;4244.893877653083;4260.169266992907;4260.360945858146;4264.914701705887;4297.978510107429;5961.91057134152;6019.277686677627;6051.606645568024;6052.152698622109;6056.606320589148;5570.693611851387;5866.770627161652;5886.411358864079;5915.674637894957;5922.437368449991;5884.852878678067;5888.498432899583;5913.048693930907;5922.230110085661;5927.673977931255;5673;5843.824685259449;5901.409859014064;5920.230370051866;5932.525397968066;5939.554533409925;5940.495057919952;5946.502468962959;5949.768836686243;5965.075413310944;5808.332041815245;5810.360860305278;5812.3263298882985;5837.211976383303;5838.474537291664 23:15:22 INFO - PROCESS | 20991 | |5;yui.html;645.6803882078369;702.4310308649993;748.9325960663539;854.688038865814;880.4321212817731;14319;14966.850331496682;15224.61938451538;15415.997960132583;15479.458218962338;15274.541763747106;15430;15469.071855688666;15479.14864682442;15509.612259693513;699.6606645776794;717.8313096422337;820.7783898347458;821.1624143373755;843.4433274039135;852.8550146475083;855.0167307596251;855.2772906893696;855.3200205836343;856;897.1880448194362;897.5781382750097;897.5960817632059;897.6454300551278;898.1333013641835;728.9161746399152;749.2058418076829;851.5827244650138;876.3558784293539;897.878786363839;649.5290914087296;650.4698670583507;650.6258901131868;651.1990251990079;651.2770824384929;14775.482858100022;14809.629759255997;14811.629709257248;14812.777808332883;14884.10695358282;14087.71824563503;14108.153510789385;14177.36201870908;14329.140251584939;14340.784888226684;13395.393340177186;13505.324733763273;13590.38843252056;13623.863761362458;13952.51166209188;4534.659900507475;4571.291449825282;4602.746848923308;4642.234031384817;4691.530846915315;82850.17149828485;84452.15547844504;84955.57522212411;86072.56963715205;87364.5631771837;11460.54157833694;11472.31166130035;11554.711132221593;11656.358900260397;11784.175107742547;21101.366958991253;21160.894195528923;21177.576448470943;21228.78771212268;21725;8587.27008204297;8596.699115530926;8658.437201581877;8828.38201325901;8889.111088891059;4850.80596776125;4929.827456039022;4935.975320123376;4957.82647607332;5024.949750502521;3166.825824579624;3256.348730253959;3270.3622793555505;3288.638249792521;3295.0609076413107;554.7143221241064;563.0512586292111;570.4609144358624;573.5211098732522;583.9591228613956;724.4313214126885;734.1557209209345;757.6590534259606;764.8890910817901;807.8101646113158;9733.707988760349;9752.95123524392;10000.399976001318;10328;10412.739681508023;604.3593790581909;644.4007073421762;668.6456178225549;673.9393454589012;771.0939645916138;4806.327114204014;4931.580815630711;4948.90102197954;5001.474845141281;5023.748812559357;76594;77926.61036694894;77929.22070779219;104551;129232;110898.44550777195;114592;115373;116364;117436.41281793536;97183;97734.5113274429;100114.49942750385;102051;103834.48082759688;9278.350515463853;9363.859542106738;9415.670451534163;9648.951755241178;9819.5090245486;39632.801835990635;42958;46420.53579464162;48880.26679599738;56906.7154664224;75382;76531;76896.61551692206;80337.19662803297;81851;12211.511539538318;12621.558245461365;12990.415431305424;13585.388657510239;13636.634963588234;14166.079204851652;14687.92656036713;14897.255137243312;15058.472953446577;15181.468648597245;13090.280034598189;13379.732405352033;13551.051426400452;13661.385237664528;14219.217943013233;13132.73734525285;13405.396757145756;13631;13867;14338.139711617336;13227.537036203687;13812;13908.235047072103;14559.19924404168;14586.124832510084;11135.944320278346;11284.943575282072;11819.763604728028;12090.335031573348;12202.755944880875;11305.152113591677;11543.307401555934;11684.009006774866;11696.590619328283;11896 23:15:22 INFO - PROCESS | 20991 | __end_tp_report 23:15:22 INFO - PROCESS | 20991 | __start_cc_report 23:15:22 INFO - PROCESS | 20991 | _x_x_mozilla_cycle_collect,923 23:15:22 INFO - PROCESS | 20991 | __end_cc_report 23:15:22 INFO - PROCESS | 20991 | __startTimestamp1477030522358__endTimestamp 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | ------- Summary: start ------- 23:15:22 INFO - PROCESS | 20991 | Number of tests: 6 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | [#0] dojo.html Cycles:165 Average:5623.23 Median:5803.56 stddev:637.18 (11.0%) stddev-sans-first:609.08 23:15:22 INFO - PROCESS | 20991 | Values: 3158.1 3207.6 3213.0 3226.6 3252.4 5721.6 5748.5 5758.0 5794.4 5795.8 5621.7 5666.6 5668.2 5680.3 5680.7 5113.1 5114.5 5123.7 5143.4 5186.3 5129.3 5136.5 5192.9 5219.1 5234.1 5111.5 5157.9 5159.5 5170.4 5192.7 5266.2 5273.9 5276.9 5280.8 5322.5 5062.6 5103.5 5175.8 5198.8 5225.1 5509.0 5519.8 5531.3 5573.7 5609.8 5935.3 5985.7 6045.4 6050.9 6054.9 5993.1 6092.6 6100.1 6114.3 6117.9 5623.4 5696.1 5720.4 5720.7 5731.4 6307.4 6324.2 6326.8 6331.7 6332.6 5739.0 6085.1 6089.6 6092.6 6130.2 5858.9 5871.1 5917.9 5924.5 5990.5 5952.9 5956.7 5959.5 5965.4 5988.3 5894.1 5919.9 5971.8 5972.5 5993.8 4602.2 4617.3 4618.0 4669.1 4717.6 4180.8 4190.0 4196.8 4216.0 4231.4 5676.6 5687.6 5688.3 5689.3 5691.5 5977.4 6004.9 6034.2 6202.9 6211.2 5560.7 5710.5 5712.5 5748.1 5753.2 5245.0 5276.1 5278.3 5286.0 5294.1 6059.9 6107.8 6280.1 6325.6 6352.1 6099.4 6110.6 6115.0 6139.5 6187.4 6376.6 6388.9 6391.7 6394.1 6396.6 5658.6 6059.2 6063.6 6064.5 6069.8 5885.7 5918.5 5957.3 5964.2 6020.5 5874.1 5878.9 5882.1 5882.8 5887.6 5873.1 5886.7 5893.4 5895.5 5901.4 5647.5 5773.2 5806.7 5834.0 5864.7 5932.8 5938.8 5940.5 5943.2 5974.3 5572.7 5613.2 5785.9 5803.6 5804.0 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | [#1] ext.html Cycles:180 Average:61394.97 Median:40490.89 stddev:118377.17 (292.4%) stddev-sans-first:118621.19 23:15:22 INFO - PROCESS | 20991 | Values: 584.1 622.8 638.1 638.9 645.8 35312.8 39238.0 39251.4 39255.6 46108.3 44348.6 48754.3 49022.3 49059.0 49109.5 9316.2 9476.1 9481.9 9485.5 9485.9 8641.0 8825.1 8825.7 9307.6 11463.9 11317.3 11426.3 11430.9 11439.7 11440.5 11259.5 11339.2 11340.6 11346.8 11354.3 8422.7 8640.6 8647.1 11076.3 11174.4 36281.3 43786.6 44891.3 44905.8 49066.8 3356.7 3567.7 3922.9 3963.7 4220.0 33922.3 34144.0 34514.7 34552.7 34555.3 4218.2 4240.2 4258.3 4272.6 4379.8 338649.0 341179.0 341448.0 342413.0 342468.0 57676.7 58947.7 65216.3 65759.7 65903.0 68390.7 69842.3 69903.7 76316.9 76352.0 17521.4 17701.9 17704.6 17707.9 17718.8 13422.2 13506.6 13518.1 13521.5 13523.1 17629.7 18051.6 18977.5 19432.8 19484.6 6466.4 6678.3 6710.4 6718.5 6835.1 914.5 995.6 1007.1 1021.8 1130.8 33126.8 33943.3 34401.3 34484.0 34586.7 1078.7 1091.4 1093.5 1119.8 1146.5 17352.7 17991.9 18105.3 18279.5 18292.1 534646.0 535961.0 536083.0 540663.0 541498.0 62263.0 62647.0 62693.0 62724.1 62812.0 1288.4 1331.8 1339.7 1421.5 1429.9 34358.3 36333.0 36523.6 36871.8 36920.4 52910.0 53489.2 53536.0 53599.0 53683.5 414976.0 416928.0 417946.0 418340.0 523929.0 29245.0 31321.0 31385.4 31545.0 31729.2 40427.4 40554.4 40560.6 40791.8 40933.2 41887.6 42420.8 42937.4 43608.6 44137.0 41992.2 42302.4 42486.0 44039.8 44190.6 42801.4 43399.1 43925.0 43973.3 44108.3 35232.3 37758.0 37816.0 37834.2 37861.4 28464.4 28872.0 29048.6 29158.7 29165.9 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | [#2] jquery.html Cycles:180 Average:28976.04 Median:21867.12 stddev:77594.94 (354.8%) stddev-sans-first:77782.94 23:15:22 INFO - PROCESS | 20991 | Values: 392.2 425.5 431.6 436.4 437.6 16022.9 19437.8 21571.2 21865.3 21868.9 19427.8 20761.8 20839.6 20850.9 20900.3 5964.9 6022.1 6232.3 6260.2 6261.5 6066.7 6105.0 6139.8 6142.4 6190.3 5753.5 5998.7 6101.7 6102.8 6105.4 6060.8 6095.3 6095.9 6100.1 6103.2 5847.7 6135.5 6175.5 6205.7 6209.8 15223.7 15505.8 15632.1 20635.6 24550.6 2381.9 2452.4 2461.2 2514.9 2520.7 9796.2 10131.2 10189.6 11023.7 11304.2 1961.2 1982.8 1987.8 2037.6 2097.7 76411.0 81371.6 86043.6 88601.6 89746.6 10699.4 10904.6 10929.6 11268.4 11462.7 15474.2 15511.0 16369.8 16444.5 16974.2 8188.2 8553.1 8743.0 8754.0 8773.3 7776.6 7833.8 7866.4 7954.1 8028.9 5049.9 5142.9 5212.2 5262.2 5266.5 2065.5 2082.8 2103.3 2151.7 2163.2 917.4 1047.1 1053.3 1060.9 1090.5 20319.2 20694.3 20898.9 21509.0 21523.2 972.9 981.3 1004.4 1019.9 1078.4 10381.8 10598.3 10944.5 11008.3 11260.7 426509.0 442893.0 486707.0 488227.0 491583.0 98413.5 100566.0 100861.0 100936.0 101445.5 1023.8 1047.5 1055.3 1066.5 1070.0 17577.0 17827.6 17969.6 17992.4 18329.8 40698.8 41704.0 41818.2 42738.8 43013.8 61738.7 62998.0 63222.0 63467.7 63968.7 8583.3 8762.6 9034.0 9092.0 9265.0 9430.0 13424.5 13981.7 14167.3 14273.7 11091.9 11304.9 11331.2 11359.5 11425.4 11146.3 11550.4 11643.1 11709.7 11734.4 11942.5 11945.3 12044.3 12099.2 12200.4 8977.8 8982.2 9050.0 9159.5 9272.8 8455.6 10917.5 12144.8 12220.1 12409.3 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | [#3] mootools.html Cycles:180 Average:5830.83 Median:471.17 stddev:3343.92 (709.7%) stddev-sans-first:3336.70 23:15:22 INFO - PROCESS | 20991 | Values: 1397.3 1530.1 1539.6 1700.8 1820.2 8046.0 8861.4 9088.5 9202.6 9467.6 9215.7 9284.0 9290.1 9293.9 9297.7 2385.4 2407.2 2409.0 2413.5 2414.1 2400.3 2402.4 2441.2 2445.1 2449.5 2389.2 2389.4 2402.0 2411.1 2416.3 2344.1 2349.9 2357.7 2363.9 2394.7 2339.0 2365.2 2366.7 2373.0 2376.1 8907.5 9012.6 9015.3 9085.6 9145.5 5265.4 5483.8 5491.9 5499.7 5506.2 3333.9 3338.8 3343.5 3368.5 3374.9 1144.7 1160.3 1172.2 1179.8 1181.9 12192.4 12208.5 12305.0 12315.3 12317.6 4302.7 4352.4 4461.8 4487.1 4559.3 9869.1 9876.4 9877.3 9881.8 9883.3 5243.6 5248.0 5253.1 5253.9 5259.1 4274.7 4416.8 4778.4 4896.2 4923.6 4029.6 4052.1 4125.6 4161.1 4167.4 1256.5 1256.9 1263.1 1263.3 1276.4 936.5 987.9 1008.1 1009.3 1016.0 5961.6 6058.1 6116.7 6179.5 6192.7 467.6 474.7 481.5 492.9 495.0 3989.1 3992.7 4002.8 4095.9 4138.9 10708.3 11037.6 11083.7 11115.2 11131.9 10993.6 11034.2 11047.5 11068.4 11078.9 8097.5 8323.9 8421.4 8424.1 8430.2 5744.9 5794.7 5824.1 5860.6 5988.3 10273.4 10275.4 10287.4 10321.2 10366.3 10241.5 10512.1 10699.1 10702.0 10709.5 6541.0 6749.3 7292.7 7440.9 7513.1 8340.0 8788.6 8795.1 8797.8 8803.0 7725.4 7744.4 7895.6 8032.0 8057.2 7466.6 7558.6 7650.6 7768.4 7896.5 6713.1 6807.6 6831.4 6841.1 6841.6 5018.8 5019.1 5022.6 5073.9 5300.7 5212.3 5232.0 5250.3 5330.6 5359.8 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | [#4] prototype.html Cycles:180 Average:4916.33 Median:5648.02 stddev:1453.10 (25.7%) stddev-sans-first:1415.62 23:15:22 INFO - PROCESS | 20991 | Values: 319.5 329.5 335.0 338.5 342.0 5606.8 5655.3 5675.6 5701.0 5702.5 5557.4 5585.0 5614.4 5618.2 5630.5 4039.7 4146.3 4198.9 4267.4 4350.9 4341.4 4350.5 4357.1 4357.3 4361.2 4316.2 4321.4 4322.0 4324.7 4328.3 4234.7 4278.3 4288.7 4310.8 4333.6 3808.3 3810.9 3815.4 3815.9 3816.8 5418.2 5422.4 5442.6 5491.3 5508.6 4874.0 4939.9 4998.0 5018.2 5050.6 5747.9 5766.8 5774.9 5782.8 5800.0 4162.8 4166.6 4195.2 4202.1 4224.8 5916.2 5927.9 5982.4 6015.9 6032.8 4311.0 4322.7 4328.9 4332.2 4335.8 4379.6 4384.9 4395.6 4405.9 4410.8 4672.0 4924.5 4925.6 4982.0 5043.5 5824.8 5826.9 5830.5 5836.9 5837.2 1461.5 1474.2 1480.4 1482.4 1482.5 910.4 937.1 943.3 945.7 946.6 5510.9 5618.9 5619.1 5640.7 5659.6 5965.3 5972.3 5974.3 5976.5 5983.7 5386.5 5492.1 5519.5 5558.3 5626.2 3151.8 3173.0 3179.1 3183.3 3183.7 5950.5 6136.1 6140.7 6161.3 6162.9 6082.7 6085.8 6097.5 6103.2 6168.5 6110.8 6119.9 6120.2 6134.9 6142.2 5727.8 5906.5 5931.7 5944.3 6013.2 5838.9 5865.4 5908.1 5954.9 5957.5 5850.7 6101.5 6116.9 6138.4 6158.8 4244.9 4260.2 4260.4 4264.9 4298.0 5961.9 6019.3 6051.6 6052.2 6056.6 5570.7 5866.8 5886.4 5915.7 5922.4 5884.9 5888.5 5913.0 5922.2 5927.7 5673.0 5843.8 5901.4 5920.2 5932.5 5939.6 5940.5 5946.5 5949.8 5965.1 5808.3 5810.4 5812.3 5837.2 5838.5 23:15:22 INFO - PROCESS | 20991 | 23:15:22 INFO - PROCESS | 20991 | [#5] yui.html Cycles:180 Average:21385.34 Median:4552.98 stddev:31167.62 (684.6%) stddev-sans-first:31216.15 23:15:22 INFO - PROCESS | 20991 | Values: 645.7 702.4 748.9 854.7 880.4 14319.0 14966.9 15224.6 15416.0 15479.5 15274.5 15430.0 15469.1 15479.1 15509.6 699.7 717.8 820.8 821.2 843.4 852.9 855.0 855.3 855.3 856.0 897.2 897.6 897.6 897.6 898.1 728.9 749.2 851.6 876.4 897.9 649.5 650.5 650.6 651.2 651.3 14775.5 14809.6 14811.6 14812.8 14884.1 14087.7 14108.2 14177.4 14329.1 14340.8 13395.4 13505.3 13590.4 13623.9 13952.5 4534.7 4571.3 4602.7 4642.2 4691.5 82850.2 84452.2 84955.6 86072.6 87364.6 11460.5 11472.3 11554.7 11656.4 11784.2 21101.4 21160.9 21177.6 21228.8 21725.0 8587.3 8596.7 8658.4 8828.4 8889.1 4850.8 4929.8 4936.0 4957.8 5024.9 3166.8 3256.3 3270.4 3288.6 3295.1 554.7 563.1 570.5 573.5 584.0 724.4 734.2 757.7 764.9 807.8 9733.7 9753.0 10000.4 10328.0 10412.7 604.4 644.4 668.6 673.9 771.1 4806.3 4931.6 4948.9 5001.5 5023.7 76594.0 77926.6 77929.2 104551.0 129232.0 110898.4 114592.0 115373.0 116364.0 117436.4 97183.0 97734.5 100114.5 102051.0 103834.5 9278.4 9363.9 9415.7 9649.0 9819.5 39632.8 42958.0 46420.5 48880.3 56906.7 75382.0 76531.0 76896.6 80337.2 81851.0 12211.5 12621.6 12990.4 13585.4 13636.6 14166.1 14687.9 14897.3 15058.5 15181.5 13090.3 13379.7 13551.1 13661.4 14219.2 13132.7 13405.4 13631.0 13867.0 14338.1 13227.5 13812.0 13908.2 14559.2 14586.1 11135.9 11284.9 11819.8 12090.3 12202.8 11305.2 11543.3 11684.0 11696.6 11896.0 23:15:22 INFO - PROCESS | 20991 | -------- Summary: end -------- 23:15:22 INFO - PROCESS | 20991 | 23:15:23 INFO - TEST-INFO | 20991: exit 0 23:15:23 INFO - TEST-OK | dromaeo_css | took 1114279ms 23:15:23 INFO - TEST-START | kraken 23:15:23 INFO - operating with platform_type : linux_ 23:15:23 INFO - Initialising browser for kraken test... 23:15:23 INFO - TEST-INFO | started process 21307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprHauxb/profile http://localhost:33688/getInfo.html) 23:15:27 INFO - PROCESS | 21307 | __metrics Screen width/height:1600/1200 23:15:27 INFO - PROCESS | 21307 | colorDepth:24 23:15:27 INFO - PROCESS | 21307 | Browser inner width/height: 1024/697 23:15:27 INFO - PROCESS | 21307 | __metrics 23:15:27 INFO - PROCESS | 21307 | 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" 23:15:27 INFO - PROCESS | 21307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:15:28 INFO - PROCESS | 21307 | console.error: PushService: 23:15:28 INFO - PROCESS | 21307 | stateChangeProcessEnqueue: Error transitioning state 23:15:28 INFO - PROCESS | 21307 | UnknownError 23:15:28 INFO - TEST-INFO | 21307: exit 0 23:15:28 INFO - Browser initialized. 23:15:28 INFO - Running cycle 1/1 for kraken test... 23:15:28 INFO - TEST-INFO | started process 21395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprHauxb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:15:40 INFO - PROCESS | 21395 | RSS: Main: 144764928 23:15:40 INFO - PROCESS | 21395 | 23:15:43 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33688/tests/kraken/driver.html?testName=audio-beat-detection) 23:15:44 INFO - PROCESS | 21395 | RSS: Main: 186806272 23:15:44 INFO - PROCESS | 21395 | 23:15:46 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33688/tests/kraken/driver.html?testName=audio-dft) 23:15:47 INFO - PROCESS | 21395 | RSS: Main: 175587328 23:15:47 INFO - PROCESS | 21395 | 23:15:50 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33688/tests/kraken/driver.html?testName=audio-fft) 23:15:50 INFO - PROCESS | 21395 | RSS: Main: 267714560 23:15:50 INFO - PROCESS | 21395 | 23:15:52 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33688/tests/kraken/driver.html?testName=audio-oscillator) 23:15:53 INFO - PROCESS | 21395 | RSS: Main: 173285376 23:15:53 INFO - PROCESS | 21395 | 23:15:55 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:15:55 INFO - PROCESS | 21395 | RSS: Main: 175079424 23:15:55 INFO - PROCESS | 21395 | 23:15:58 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33688/tests/kraken/driver.html?testName=imaging-darkroom) 23:15:59 INFO - PROCESS | 21395 | RSS: Main: 210780160 23:15:59 INFO - PROCESS | 21395 | 23:16:02 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33688/tests/kraken/driver.html?testName=imaging-desaturate) 23:16:03 INFO - PROCESS | 21395 | RSS: Main: 209772544 23:16:03 INFO - PROCESS | 21395 | 23:16:06 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33688/tests/kraken/driver.html?testName=json-parse-financial) 23:16:06 INFO - PROCESS | 21395 | RSS: Main: 209293312 23:16:06 INFO - PROCESS | 21395 | 23:16:08 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:16:08 INFO - PROCESS | 21395 | RSS: Main: 171982848 23:16:08 INFO - PROCESS | 21395 | 23:16:10 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:16:11 INFO - PROCESS | 21395 | RSS: Main: 179040256 23:16:11 INFO - PROCESS | 21395 | 23:16:13 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:16:13 INFO - PROCESS | 21395 | RSS: Main: 189009920 23:16:13 INFO - PROCESS | 21395 | 23:16:16 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:16:16 INFO - PROCESS | 21395 | RSS: Main: 196943872 23:16:16 INFO - PROCESS | 21395 | 23:16:19 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:16:20 INFO - PROCESS | 21395 | RSS: Main: 193757184 23:16:20 INFO - PROCESS | 21395 | 23:16:21 INFO - PROCESS | 21395 | Cycle 1(1): loaded http://localhost:33688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33688/tests/kraken/driver.html?testName=ai-astar) 23:16:22 INFO - PROCESS | 21395 | RSS: Main: 245608448 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | __start_tp_report 23:16:22 INFO - PROCESS | 21395 | _x_x_mozilla_page_load 23:16:22 INFO - PROCESS | 21395 | _x_x_mozilla_page_load_details 23:16:22 INFO - PROCESS | 21395 | |i|pagename|runs| 23:16:22 INFO - PROCESS | 21395 | |0;ai-astar;110;109;110;110;112;110;109;110;109;111 23:16:22 INFO - PROCESS | 21395 | |1;audio-beat-detection;148;120;118;164;120;120;119;122;146;119 23:16:22 INFO - PROCESS | 21395 | |2;audio-dft;161;160;160;161;161;161;161;161;161;161 23:16:22 INFO - PROCESS | 21395 | |3;audio-fft;75;76;76;106;75;77;76;77;99;75 23:16:22 INFO - PROCESS | 21395 | |4;audio-oscillator;83;81;115;82;82;82;115;83;82;116 23:16:22 INFO - PROCESS | 21395 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 23:16:22 INFO - PROCESS | 21395 | |6;imaging-darkroom;146;145;145;146;146;145;148;145;145;144 23:16:22 INFO - PROCESS | 21395 | |7;imaging-desaturate;95;94;94;96;95;95;95;95;95;95 23:16:22 INFO - PROCESS | 21395 | |8;json-parse-financial;51;48;48;49;49;50;50;50;50;50 23:16:22 INFO - PROCESS | 21395 | |9;json-stringify-tinderbox;58;59;58;60;58;57;57;58;60;59 23:16:22 INFO - PROCESS | 21395 | |10;stanford-crypto-aes;79;72;73;73;76;79;79;73;74;72 23:16:22 INFO - PROCESS | 21395 | |11;stanford-crypto-ccm;122;134;123;122;125;130;121;119;162;119 23:16:22 INFO - PROCESS | 21395 | |12;stanford-crypto-pbkdf2;155;152;153;152;151;150;150;150;152;152 23:16:22 INFO - PROCESS | 21395 | |13;stanford-crypto-sha256-iterative;63;63;65;62;63;63;61;62;63;71 23:16:22 INFO - PROCESS | 21395 | __end_tp_report 23:16:22 INFO - PROCESS | 21395 | __start_cc_report 23:16:22 INFO - PROCESS | 21395 | _x_x_mozilla_cycle_collect,1624 23:16:22 INFO - PROCESS | 21395 | __end_cc_report 23:16:22 INFO - PROCESS | 21395 | __startTimestamp1477030582089__endTimestamp 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | ------- Summary: start ------- 23:16:22 INFO - PROCESS | 21395 | Number of tests: 14 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:0.94 (0.9%) stddev-sans-first:1.00 23:16:22 INFO - PROCESS | 21395 | Values: 110.0 109.0 110.0 110.0 112.0 110.0 109.0 110.0 109.0 111.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:121.00 stddev:16.61 (13.7%) stddev-sans-first:16.23 23:16:22 INFO - PROCESS | 21395 | Values: 148.0 120.0 118.0 164.0 120.0 120.0 119.0 122.0 146.0 119.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 23:16:22 INFO - PROCESS | 21395 | Values: 161.0 160.0 160.0 161.0 161.0 161.0 161.0 161.0 161.0 161.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.37 (15.0%) stddev-sans-first:11.84 23:16:22 INFO - PROCESS | 21395 | Values: 75.0 76.0 76.0 106.0 75.0 77.0 76.0 77.0 99.0 75.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:82.00 stddev:16.04 (19.6%) stddev-sans-first:16.68 23:16:22 INFO - PROCESS | 21395 | Values: 83.0 81.0 115.0 82.0 82.0 82.0 115.0 83.0 82.0 116.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:16:22 INFO - PROCESS | 21395 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 23:16:22 INFO - PROCESS | 21395 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 148.0 145.0 145.0 144.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 23:16:22 INFO - PROCESS | 21395 | Values: 95.0 94.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:50.00 stddev:0.97 (1.9%) stddev-sans-first:0.87 23:16:22 INFO - PROCESS | 21395 | Values: 51.0 48.0 48.0 49.0 49.0 50.0 50.0 50.0 50.0 50.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:1.07 (1.8%) stddev-sans-first:1.13 23:16:22 INFO - PROCESS | 21395 | Values: 58.0 59.0 58.0 60.0 58.0 57.0 57.0 58.0 60.0 59.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:2.98 (4.0%) stddev-sans-first:2.79 23:16:22 INFO - PROCESS | 21395 | Values: 79.0 72.0 73.0 73.0 76.0 79.0 79.0 73.0 74.0 72.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:124.00 stddev:12.96 (10.5%) stddev-sans-first:13.58 23:16:22 INFO - PROCESS | 21395 | Values: 122.0 134.0 123.0 122.0 125.0 130.0 121.0 119.0 162.0 119.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:152.00 stddev:1.57 (1.0%) stddev-sans-first:1.12 23:16:22 INFO - PROCESS | 21395 | Values: 155.0 152.0 153.0 152.0 151.0 150.0 150.0 150.0 152.0 152.0 23:16:22 INFO - PROCESS | 21395 | 23:16:22 INFO - PROCESS | 21395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.80 (4.4%) stddev-sans-first:2.96 23:16:22 INFO - PROCESS | 21395 | Values: 63.0 63.0 65.0 62.0 63.0 63.0 61.0 62.0 63.0 71.0 23:16:22 INFO - PROCESS | 21395 | -------- Summary: end -------- 23:16:22 INFO - PROCESS | 21395 | 23:16:23 INFO - TEST-INFO | 21395: exit 0 23:16:23 INFO - TEST-OK | kraken | took 60020ms 23:16:23 INFO - SUITE-END | took 1174s 23:16:23 INFO - Completed test suite (00:19:34) 23:16:23 INFO - javascript benchmark 23:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.147300228938, 3207.5990501187352, 3212.9518057229147, 3226.6450690424062, 3252.4145653782325, 5721.570882183837, 5748.5401167906575, 5758.0, 5794.362620111784, 5795.82612521625, 5621.690807005613, 5666.631668941516, 5668.234788303578, 5680.31836179658, 5680.721753056211, 5113.054084994269, 5114.539691427771, 5123.66696164749, 5143.408508021588, 5186.3257776489, 5129.2562578426105, 5136.537711605954, 5192.896142077157, 5219.112750832349, 5234.110201265775, 5111.463296353885, 5157.948420515803, 5159.484051594829, 5170.431252562215, 5192.7403629818355, 5266.236395722618, 5273.894522109575, 5276.947230527684, 5280.788768449257, 5322.467753224685, 5062.594992400599, 5103.489651034867, 5175.792968281302, 5198.766055527511, 5225.08561001827, 5509.0, 5519.751611177467, 5531.3362396512675, 5573.749181286811, 5609.80365687199, 5935.258092738408, 5985.670788106652, 6045.395460453963, 6050.939490605126, 6054.909176362358, 5993.130996005599, 6092.634441933454, 6100.084987251903, 6114.2968558615885, 6117.908231376533, 5623.409541998113, 5696.11710184922, 5720.399358067426, 5720.656760594336, 5731.426857314319, 6307.369263073656, 6324.177856878577, 6326.841828954221, 6331.715072821734, 6332.620042797447, 5738.971305143447, 6085.117657939662, 6089.603310388689, 6092.573519853568, 6130.1724267224245, 5858.882822343529, 5871.148683440877, 5917.911231331534, 5924.526037916957, 5990.520758339409, 5952.9107063394085, 5956.702164891738, 5959.523238141025, 5965.403459654, 5988.281406231193, 5894.145348924382, 5919.911201331984, 5971.790987315423, 5972.492338151305, 5993.820185394445, 4602.217623004098, 4617.330487079422, 4617.976910115428, 4669.112868555032, 4717.622590192845, 4180.770057646798, 4190.015346393595, 4196.832126714898, 4216.0, 4231.386448964883, 5676.631018983753, 5687.573431992617, 5688.317401911714, 5689.260396148474, 5691.544676425876, 5977.432143946318, 6004.879902401927, 6034.24571928509, 6202.875942481125, 6211.223597050369, 5560.7219639018695, 5710.457506536873, 5712.457316554921, 5748.051571490741, 5753.194552762617, 5244.9737751310995, 5276.129438642658, 5278.313819203479, 5286.0, 5294.126469132627, 6059.939400606026, 6107.84730381744, 6280.089387038854, 6325.58883672569, 6352.14246076783, 6099.359567245376, 6110.558759196553, 6115.027386288435, 6139.522803442411, 6187.381261873777, 6376.585521941059, 6388.93611063902, 6391.680415979089, 6394.136791533269, 6396.584222025554, 5658.632188907708, 6059.242594675666, 6063.605865618721, 6064.514838812973, 6069.787557435468, 5885.73514191871, 5918.467337939606, 5957.255343082114, 5964.224650795369, 6020.51835853122, 5874.060150375919, 5878.941210587839, 5882.088276317178, 5882.794102206402, 5887.61730487517, 5873.060310350324, 5886.705664716661, 5893.410658934073, 5895.498882594856, 5901.409859014236, 5647.5481961442165, 5773.16289138081, 5806.65160090396, 5834.0, 5864.706764661835, 5932.762689492372, 5938.8218353449465, 5940.46535811779, 5943.227380440515, 5974.2830860297045, 5572.721363931868, 5613.158026295925, 5785.8553536161935, 5803.564732645153, 5804.01331773591], "value": 5580.019303747159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1442287049472, 622.7540121651948, 638.0684201066442, 638.9329120442351, 645.8094862015705, 35312.82343588282, 39237.99999999996, 39251.41122883159, 39255.60744392555, 46108.30837537431, 44348.556514434844, 48754.26868596974, 49022.26466603004, 49059.0, 49109.50890491103, 9316.161545460924, 9476.099770521823, 9481.857772133424, 9485.47829869357, 9485.857712134324, 8640.956795216016, 8825.073367296405, 8825.73522794314, 9307.627694892197, 11463.853614638552, 11317.264377815456, 11426.314421134717, 11430.942845285763, 11439.656810295704, 11440.485178167002, 11259.54961801527, 11339.206255562114, 11340.60307889224, 11346.773064538704, 11354.26197297173, 8422.747317580483, 8640.567971601395, 8647.092055334162, 11076.335419874833, 11174.385408802513, 36281.27437451263, 43786.56213437857, 44891.32663010057, 44905.77547112276, 49066.7546662268, 3356.7314614830757, 3567.678908898212, 3922.882313530599, 3963.7225394222414, 4220.0, 33922.32155356904, 34144.0, 34514.65485345139, 34552.65447345519, 34555.30889382198, 4218.198542276958, 4240.23675738367, 4258.318669012943, 4272.551382104865, 4379.824807007748, 338649.0, 341179.0, 341448.0, 342413.0, 342468.0, 57676.71161644165, 58947.70526147342, 65216.34783652198, 65759.67120164368, 65903.0, 68390.65804670945, 69842.30157698358, 69903.65048174726, 76316.85524717133, 76352.0, 17521.386751463637, 17701.911490442464, 17704.645907081787, 17707.911460442614, 17718.82281177172, 13422.194668319931, 13506.594802155754, 13518.121322114031, 13521.459141634225, 13523.053386262867, 17629.7355539667, 18051.638967220846, 18977.525561861064, 19432.804883491473, 19484.610307793766, 6466.385693359123, 6678.33216678338, 6710.362515561014, 6718.49611279156, 6835.111435513351, 914.533587870191, 995.586831464934, 1007.0986467111894, 1021.8313978193663, 1130.7568872692411, 33126.8343658285, 33943.32113357719, 34401.311973760385, 34484.0, 34586.65413345885, 1078.735709751116, 1091.3942761767137, 1093.4805967165532, 1119.776044791045, 1146.5356530605118, 17352.65294694124, 17991.90129768965, 18105.275788968556, 18279.54301142482, 18292.073203934302, 534646.0, 535961.0, 536083.0, 540663.0, 541498.0, 62263.0, 62647.0, 62693.0, 62724.05913911295, 62812.0, 1288.4395288049727, 1331.760283149023, 1339.6918708697053, 1421.4953691439803, 1429.942802287897, 34358.31283374268, 36333.0, 36523.634763653085, 36871.815640921624, 36920.44619330658, 52910.0, 53489.19766203588, 53536.0, 53599.0, 53683.46316536941, 414976.0, 416928.0, 417946.0, 418340.0, 523929.0, 29245.0, 31321.0, 31385.37229255448, 31545.0, 31729.20676983094, 40427.3935890956, 40554.39168412535, 40560.59439405686, 40791.7960410196, 40933.1813363737, 41887.581124189586, 42420.78789606032, 42937.35593966155, 43608.56391436045, 44137.0, 41992.160156797305, 42302.36546451867, 42486.0, 44039.77980110079, 44190.558094418644, 42801.357979629705, 43399.132017360105, 43925.0, 43973.340399893386, 44108.33837492504, 35232.29535409329, 37758.0, 37816.0, 37834.24331513299, 37861.43207851939, 28464.43071138524, 28872.0, 29048.56427153637, 29158.7084129156, 29165.85417072986], "value": 21059.20018867021, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2116545743059, 425.544233441408, 431.55118676576365, 436.37598234524626, 437.6148988889777, 16022.919885400572, 19437.805621943793, 21571.24500642478, 21865.344039678796, 21868.89065554672, 19427.805721942776, 20761.792382076175, 20839.583208335862, 20850.89574552125, 20900.268490602833, 5964.910526342108, 6022.126791615224, 6232.283287421937, 6260.154879091333, 6261.499080073583, 6066.6663333516635, 6104.96947515264, 6139.815805525842, 6142.385761423867, 6190.288116866551, 5753.539716822645, 5998.700064996733, 6101.664408457533, 6102.755889764404, 6105.389461053904, 6060.848478788043, 6095.299040610343, 6095.878082438371, 6100.1154832549255, 6103.206583144185, 5847.707614619252, 6135.539834512385, 6175.536834737412, 6205.696803671234, 6209.782657607007, 15223.695526089527, 15505.767413488808, 15632.06207627546, 20635.58728825415, 24550.631740523906, 2381.8570885746913, 2452.448199155194, 2461.2001099642507, 2514.8994040238367, 2520.7101183363966, 9796.216302695768, 10131.189504839595, 10189.59241630334, 11023.669289921316, 11304.208705390625, 1961.2449207055245, 1982.8017198280202, 1987.8409727221788, 2037.633226019316, 2097.6643737002005, 76411.0, 81371.5931420345, 86043.56978215132, 88601.55699221526, 89746.55126724325, 10699.358038517714, 10904.61833835812, 10929.617463388744, 11268.436578171058, 11462.739098699136, 15474.22628868552, 15511.0, 16369.754453683205, 16444.506664800076, 16974.15129243533, 8188.181181881764, 8553.14468553152, 8743.0, 8754.0, 8773.298136149093, 7776.572288524072, 7833.804154896059, 7866.410019248579, 7954.085280192852, 8028.879566806502, 5049.873753156127, 5142.948570514247, 5212.218167274939, 5262.236975638511, 5266.473352664703, 2065.5455799724036, 2082.8125468707585, 2103.3374487036535, 2151.720276364094, 2163.2320526212966, 917.4266083697689, 1047.0994944347856, 1053.262716098734, 1060.8567843341204, 1090.4528117748848, 20319.187232510532, 20694.275700350718, 20898.895505522374, 21509.032093555827, 21523.246686365903, 972.873526441558, 981.3326937682444, 1004.352192835617, 1019.938803671782, 1078.44460103047, 10381.792364152674, 10598.25812193139, 10944.4527773611, 11008.284461509977, 11260.662180134608, 426509.0, 442893.0, 486707.0, 488227.0, 491583.0, 98413.50793246132, 100566.0, 100861.0, 100936.0, 101445.49277253567, 1023.8259495885717, 1047.4553232319151, 1055.2560444886337, 1066.4667666166918, 1070.0209308482806, 17577.0, 17827.643447131246, 17969.640607188045, 17992.370267041115, 18329.81670183281, 40698.796506018465, 41704.0, 41818.1636367277, 42738.786306069516, 43013.78493107514, 61738.69130654498, 62998.0, 63222.0, 63467.6826615864, 63968.68015659892, 8583.270422014199, 8762.649494020168, 9033.954830225806, 9091.954540227256, 9265.0, 9429.952850235704, 13424.530141445002, 13981.650458738206, 14167.291635418394, 14273.71452570922, 11091.944540277247, 11304.886951130384, 11331.150163737588, 11359.54561817518, 11425.37160456183, 11146.331220126818, 11550.422478876191, 11643.126765492452, 11709.707257318294, 11734.413279335828, 11942.462589183682, 11945.283283003047, 12044.277343359427, 12099.213551119148, 12200.389980501117, 8977.775555611162, 8982.236509896731, 9050.0, 9159.450432974043, 9272.768180795265, 8455.577221139041, 10917.508712107816, 12144.817827732768, 12220.083493737828, 12409.255444673348], "value": 9515.397326905078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.3362652739943, 1530.1125347298564, 1539.5689207022035, 1700.7533907583402, 1820.2082094288994, 8046.0, 8861.42400743952, 9088.50013249271, 9202.585883635236, 9467.621295148187, 9215.723528294146, 9284.0, 9290.117438843316, 9293.860592091123, 9297.721068367942, 2385.427497400629, 2407.1815582701965, 2409.0, 2413.4931664350506, 2414.070582825616, 2400.31590996566, 2402.423418379594, 2441.1578005588044, 2445.119756887519, 2449.497852940143, 2389.223502361731, 2389.354874183969, 2401.9639705404347, 2411.0837881605053, 2416.2992732107755, 2344.1443872986406, 2349.9177528786495, 2357.705286839145, 2363.9409014774596, 2394.724606670238, 2339.0, 2365.1721897335965, 2366.715994080704, 2372.9881350593137, 2376.120835290936, 8907.510086945216, 9012.594433250519, 9015.27877769777, 9085.591148398338, 9145.496997665126, 5265.394479634852, 5483.75323110461, 5491.862703432406, 5499.670019798785, 5506.229127922094, 3333.8999830005137, 3338.7829791063505, 3343.5151902973935, 3368.5452463917304, 3374.8650053997812, 1144.7023773818785, 1160.3444054109486, 1172.208759087621, 1179.799434096197, 1181.8818118188199, 12192.414986051845, 12208.450619722134, 12305.0, 12315.261084334968, 12317.630471085882, 4302.677299202573, 4352.368906508538, 4461.821527138878, 4487.080148569536, 4559.316102584573, 9869.062439068277, 9876.35803672759, 9877.308588398742, 9881.752956176153, 9883.258755593359, 5243.606729495303, 5248.0, 5253.13323301651, 5253.9211911820585, 5259.053370393366, 4274.658027357804, 4416.84541041062, 4778.354922085474, 4896.1921282987905, 4923.556879880756, 4029.6373326400767, 4052.068024354415, 4125.5874412558505, 4161.0845613964875, 4167.437395951569, 1256.5288016993627, 1256.8743125687358, 1263.0716423428773, 1263.3304348695206, 1276.3745764575292, 936.5223735894742, 987.9259055570861, 1008.0625018732502, 1009.268280496634, 1015.9949200254099, 5961.612495187799, 6058.091286307089, 6116.724747386378, 6179.474744646665, 6192.659403732748, 467.6352445092833, 474.70568247686657, 481.4679778844397, 492.9038837426667, 495.00998003992015, 3989.1423343981182, 3992.740471869319, 4002.799860006988, 4095.877123686294, 4138.896527586774, 10708.250422470508, 11037.613683521038, 11083.667489975152, 11115.221934464671, 11131.888681113085, 10993.6152234673, 11034.227604067799, 11047.502862371213, 11068.446577671084, 11078.944605276922, 8097.514149151069, 8323.875141872877, 8421.368397370099, 8424.073351931405, 8430.199131082538, 5744.942550574441, 5794.710264486843, 5824.068149096293, 5860.589758716849, 5988.341282459013, 10273.434961077213, 10275.383476991405, 10287.382757034602, 10321.225908057077, 10366.326188797704, 10241.539130738985, 10512.106470950055, 10699.144068474348, 10702.0, 10709.464526773785, 6540.967295163494, 6749.3250674932115, 7292.708291668486, 7440.888386674313, 7513.060867391576, 8340.0, 8788.648454061766, 8795.120487951153, 8797.824043519222, 8803.031666516807, 7725.381969442544, 7744.380449564134, 7895.565743884142, 8032.036155661358, 8057.194280571896, 7466.589337586485, 7558.622068896643, 7650.579218143055, 7768.417368697484, 7896.486728362638, 6713.093732346266, 6807.5575087619145, 6831.351021652935, 6841.144856892888, 6841.555298905555, 5018.824341148043, 5019.071471777733, 5022.648414610942, 5073.949260507496, 5300.734963251899, 5212.296339994204, 5232.0, 5250.264962905273, 5330.573554115584, 5359.839204823861], "value": 4598.117993358413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.53348111756833, 329.4761329486117, 335.0317582187479, 338.52268301694613, 342.02352284228544, 5606.803761868336, 5655.349634792, 5675.574331925107, 5701.002324593201, 5702.45826646469, 5557.416471270519, 5585.0, 5614.3718321686665, 5618.185363122345, 5630.521405680522, 4039.7374170678813, 4146.253674338618, 4198.895027624303, 4267.423897773791, 4350.912981740364, 4341.39220509129, 4350.521442641307, 4357.063231405247, 4357.2592659248, 4361.214981303364, 4316.2446571849805, 4321.416608757824, 4321.9783901080455, 4324.654027677794, 4328.329108988112, 4234.703570750049, 4278.336857787048, 4288.69979101463, 4310.762908040057, 4333.551543377997, 3808.333541630231, 3810.90472738181, 3815.3704638734853, 3815.8855234343014, 3816.8282427290837, 5418.187271909206, 5422.40353561108, 5442.591805614595, 5491.341039075336, 5508.586855985777, 4874.0, 4939.851804445872, 4998.0, 5018.197088465828, 5050.646454748169, 5747.885042299131, 5766.7981620643495, 5774.884502309972, 5782.797602083949, 5800.013997620373, 4162.7502349859105, 4166.625013745487, 4195.181939521794, 4202.096549241927, 4224.78876056196, 5916.178314673527, 5927.911081333784, 5982.367758186428, 6015.909761353583, 6032.832762799565, 4310.956890431118, 4322.740635561876, 4328.9134217316105, 4332.241857674894, 4335.783210839509, 4379.649628029813, 4384.8903777405185, 4395.63735242076, 4405.911881762347, 4410.794602698651, 4672.0, 4924.507549245119, 4925.556699897026, 4982.0, 5043.46174416799, 5824.825255242349, 5826.941730582725, 5830.5044071254415, 5836.941630583639, 5837.153612726216, 1461.4519555166812, 1474.1670955909876, 1480.4448331875547, 1482.3699927530972, 1482.4885414531968, 910.3945875992391, 937.1471960515897, 943.2689665509148, 945.6548359848606, 946.5882341181608, 5510.862228444321, 5618.887622247532, 5619.072852979212, 5640.689762063126, 5659.585103724069, 5965.343812180657, 5972.25346831646, 5974.283086029617, 5976.491998180117, 5983.700814959235, 5386.461353864661, 5492.1212605982855, 5519.475649813261, 5558.33300003994, 5626.24045753818, 3151.842407879597, 3173.0, 3179.140202981282, 3183.2519357950864, 3183.6657150998813, 5950.523958083343, 6136.140940268277, 6140.662263575457, 6161.291451483047, 6162.887741690418, 6082.695865206722, 6085.756569737249, 6097.512199024156, 6103.23709536308, 6168.475679567197, 6110.755569777248, 6119.867824452402, 6120.17377654011, 6134.938650613437, 6142.232220972379, 5727.799527016535, 5906.527477801851, 5931.733072011683, 5944.256967879015, 6013.188219590299, 5838.912416313674, 5865.35769984405, 5908.113782932594, 5954.851128721816, 5957.523398128053, 5850.7074646266665, 6101.481374083252, 6116.938830611637, 6138.3861613840045, 6158.753649853956, 4244.893877653083, 4260.169266992907, 4260.360945858146, 4264.914701705887, 4297.978510107429, 5961.91057134152, 6019.277686677627, 6051.606645568024, 6052.152698622109, 6056.606320589148, 5570.693611851387, 5866.770627161652, 5886.411358864079, 5915.674637894957, 5922.437368449991, 5884.852878678067, 5888.498432899583, 5913.048693930907, 5922.230110085661, 5927.673977931255, 5673.0, 5843.824685259449, 5901.409859014064, 5920.230370051866, 5932.525397968066, 5939.554533409925, 5940.495057919952, 5946.502468962959, 5949.768836686243, 5965.075413310944, 5808.332041815245, 5810.360860305278, 5812.3263298882985, 5837.211976383303, 5838.474537291664], "value": 4442.686135827679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6803882078369, 702.4310308649993, 748.9325960663539, 854.688038865814, 880.4321212817731, 14319.0, 14966.850331496682, 15224.61938451538, 15415.997960132583, 15479.458218962338, 15274.541763747106, 15430.0, 15469.071855688666, 15479.14864682442, 15509.612259693513, 699.6606645776794, 717.8313096422337, 820.7783898347458, 821.1624143373755, 843.4433274039135, 852.8550146475083, 855.0167307596251, 855.2772906893696, 855.3200205836343, 856.0, 897.1880448194362, 897.5781382750097, 897.5960817632059, 897.6454300551278, 898.1333013641835, 728.9161746399152, 749.2058418076829, 851.5827244650138, 876.3558784293539, 897.878786363839, 649.5290914087296, 650.4698670583507, 650.6258901131868, 651.1990251990079, 651.2770824384929, 14775.482858100022, 14809.629759255997, 14811.629709257248, 14812.777808332883, 14884.10695358282, 14087.71824563503, 14108.153510789385, 14177.36201870908, 14329.140251584939, 14340.784888226684, 13395.393340177186, 13505.324733763273, 13590.38843252056, 13623.863761362458, 13952.51166209188, 4534.659900507475, 4571.291449825282, 4602.746848923308, 4642.234031384817, 4691.530846915315, 82850.17149828485, 84452.15547844504, 84955.57522212411, 86072.56963715205, 87364.5631771837, 11460.54157833694, 11472.31166130035, 11554.711132221593, 11656.358900260397, 11784.175107742547, 21101.366958991253, 21160.894195528923, 21177.576448470943, 21228.78771212268, 21725.0, 8587.27008204297, 8596.699115530926, 8658.437201581877, 8828.38201325901, 8889.111088891059, 4850.80596776125, 4929.827456039022, 4935.975320123376, 4957.82647607332, 5024.949750502521, 3166.825824579624, 3256.348730253959, 3270.3622793555505, 3288.638249792521, 3295.0609076413107, 554.7143221241064, 563.0512586292111, 570.4609144358624, 573.5211098732522, 583.9591228613956, 724.4313214126885, 734.1557209209345, 757.6590534259606, 764.8890910817901, 807.8101646113158, 9733.707988760349, 9752.95123524392, 10000.399976001318, 10328.0, 10412.739681508023, 604.3593790581909, 644.4007073421762, 668.6456178225549, 673.9393454589012, 771.0939645916138, 4806.327114204014, 4931.580815630711, 4948.90102197954, 5001.474845141281, 5023.748812559357, 76594.0, 77926.61036694894, 77929.22070779219, 104551.0, 129232.0, 110898.44550777195, 114592.0, 115373.0, 116364.0, 117436.41281793536, 97183.0, 97734.5113274429, 100114.49942750385, 102051.0, 103834.48082759688, 9278.350515463853, 9363.859542106738, 9415.670451534163, 9648.951755241178, 9819.5090245486, 39632.801835990635, 42958.0, 46420.53579464162, 48880.26679599738, 56906.7154664224, 75382.0, 76531.0, 76896.61551692206, 80337.19662803297, 81851.0, 12211.511539538318, 12621.558245461365, 12990.415431305424, 13585.388657510239, 13636.634963588234, 14166.079204851652, 14687.92656036713, 14897.255137243312, 15058.472953446577, 15181.468648597245, 13090.280034598189, 13379.732405352033, 13551.051426400452, 13661.385237664528, 14219.217943013233, 13132.73734525285, 13405.396757145756, 13631.0, 13867.0, 14338.139711617336, 13227.537036203687, 13812.0, 13908.235047072103, 14559.19924404168, 14586.124832510084, 11135.944320278346, 11284.943575282072, 11819.763604728028, 12090.335031573348, 12202.755944880875, 11305.152113591677, 11543.307401555934, 11684.009006774866, 11696.590619328283, 11896.0], "value": 7701.093613960533, "unit": "score"}], "name": "dromaeo_css", "value": 7485.506704942497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 110.0, 110.0, 112.0, 110.0, 109.0, 110.0, 109.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 118.0, 164.0, 120.0, 120.0, 119.0, 122.0, 146.0, 119.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 75.0, 77.0, 76.0, 77.0, 99.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 115.0, 82.0, 82.0, 82.0, 115.0, 83.0, 82.0, 116.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 148.0, 145.0, 145.0, 144.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 48.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 60.0, 58.0, 57.0, 57.0, 58.0, 60.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 73.0, 73.0, 76.0, 79.0, 79.0, 73.0, 74.0, 72.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 134.0, 123.0, 122.0, 125.0, 130.0, 121.0, 119.0, 162.0, 119.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 152.0, 153.0, 152.0, 151.0, 150.0, 150.0, 150.0, 152.0, 152.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 62.0, 63.0, 63.0, 61.0, 62.0, 63.0, 71.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1456.8, "alertThreshold": 2.0}]} 23:16:23 INFO - Return code: 0 23:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:16:23 INFO - # TBPL SUCCESS # 23:16:23 INFO - Running post-action listener: _resource_record_post_action 23:16:23 INFO - [mozharness: 2016-10-21 06:16:23.364446Z] Finished run-tests step (success) 23:16:23 INFO - Running post-run listener: _resource_record_post_run 23:16:23 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360325120; Read time: 200; Write time: 362324 23:16:23 INFO - TinderboxPrint: CPU usage
13.0% 23:16:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 200 23:16:23 INFO - TinderboxPrint: I/O write bytes / time
360,325,120 / 362,324 23:16:23 INFO - TinderboxPrint: CPU idle
8,273.9 (87.0%) 23:16:23 INFO - TinderboxPrint: CPU user
1,185.2 (12.5%) 23:16:23 INFO - TinderboxPrint: Swap in / out
0 / 0 23:16:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111575040; Read time: 200; Write time: 157340 23:16:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 248750080; Read time: 0; Write time: 204984 23:16:23 INFO - Running post-run listener: _upload_blobber_files 23:16:23 INFO - Blob upload gear active. 23:16:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:16:23 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 23:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:16:24 INFO - (blobuploader) - INFO - Open directory for files ... 23:16:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:16:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:16:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:16:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:16:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:16:25 INFO - (blobuploader) - INFO - Done attempting. 23:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:16:29 INFO - (blobuploader) - INFO - Done attempting. 23:16:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:16:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:16:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:16:30 INFO - (blobuploader) - INFO - Done attempting. 23:16:30 INFO - (blobuploader) - INFO - Iteration through files over. 23:16:30 INFO - Return code: 0 23:16:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:16:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:16:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36afedea46666272ac44ed124372148c5ed7914e93d1032c7872bf2825f0c2254c2818f8e18bf26ad8a92147c83736c559fb707bbe8528dab41d61e443880f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae7a7cb84ecef36b8a9e3b22a427801f8012e0fcea2540ce7785bbe89ca7d52c7eb733375a58fcaf6949fe72dbd500ded33865d3f924fe77d9fff59789e40874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0143fa5b945bc9a28be430f862725fb6480a48b41de4e7e1c39e3ecb888e27b977244c0ef159e82dfd24f6840d3a1314fbbc5445b749489bf910fa265567b880"} 23:16:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:16:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:16:30 INFO - Contents: 23:16:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36afedea46666272ac44ed124372148c5ed7914e93d1032c7872bf2825f0c2254c2818f8e18bf26ad8a92147c83736c559fb707bbe8528dab41d61e443880f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae7a7cb84ecef36b8a9e3b22a427801f8012e0fcea2540ce7785bbe89ca7d52c7eb733375a58fcaf6949fe72dbd500ded33865d3f924fe77d9fff59789e40874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0143fa5b945bc9a28be430f862725fb6480a48b41de4e7e1c39e3ecb888e27b977244c0ef159e82dfd24f6840d3a1314fbbc5445b749489bf910fa265567b880"} 23:16:30 INFO - Running post-run listener: copy_logs_to_upload_dir 23:16:30 INFO - Copying logs to upload dir... 23:16:30 INFO - mkdir: /builds/slave/test/build/upload/logs 23:16:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.709476 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-20 23:16:30.105862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 23:16:30.109628) ========= 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=4300f881736b422476174874000001bc-1477029353.760481-1240039752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36afedea46666272ac44ed124372148c5ed7914e93d1032c7872bf2825f0c2254c2818f8e18bf26ad8a92147c83736c559fb707bbe8528dab41d61e443880f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae7a7cb84ecef36b8a9e3b22a427801f8012e0fcea2540ce7785bbe89ca7d52c7eb733375a58fcaf6949fe72dbd500ded33865d3f924fe77d9fff59789e40874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0143fa5b945bc9a28be430f862725fb6480a48b41de4e7e1c39e3ecb888e27b977244c0ef159e82dfd24f6840d3a1314fbbc5445b749489bf910fa265567b880"} build_url:https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/RD-2jhwbRxmfWgkexKe4Og/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36afedea46666272ac44ed124372148c5ed7914e93d1032c7872bf2825f0c2254c2818f8e18bf26ad8a92147c83736c559fb707bbe8528dab41d61e443880f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae7a7cb84ecef36b8a9e3b22a427801f8012e0fcea2540ce7785bbe89ca7d52c7eb733375a58fcaf6949fe72dbd500ded33865d3f924fe77d9fff59789e40874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0143fa5b945bc9a28be430f862725fb6480a48b41de4e7e1c39e3ecb888e27b977244c0ef159e82dfd24f6840d3a1314fbbc5445b749489bf910fa265567b880"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 23:16:30.136692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 23:16:30.137077) ========= 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=4300f881736b422476174874000001bc-1477029353.760481-1240039752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 23:16:30.222540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 23:16:30.222892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 23:16:30.223335) ========= ========= Total master_lag: 0.18 =========