builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1480439944.04 results: success (0) buildid: 20161129062927 builduid: 0da61bd7eb514695b9c47523cd39a1c8 revision: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.041535) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.042900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.043170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.058257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.058586) ========= 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=745a4373a2a16df560f216e000000264-1480431465.189675-248410963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 09:19:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.2M=0s 2016-11-29 09:19:04 (66.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.177131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.177495) ========= 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=745a4373a2a16df560f216e000000264-1480431465.189675-248410963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:04.228931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 09:19:04.229521) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e --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 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e --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=745a4373a2a16df560f216e000000264-1480431465.189675-248410963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 09:19:05,038 truncating revision to first 12 chars 2016-11-29 09:19:05,038 Setting DEBUG logging. 2016-11-29 09:19:05,038 attempt 1/10 2016-11-29 09:19:05,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/55c4ba0e73cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 09:19:06,154 unpacking tar archive at: mozilla-aurora-55c4ba0e73cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 09:19:05.685478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.685912) ========= script_repo_revision: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.686343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.686650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 09:19:05.696957) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-29 09:19:05.697407) ========= /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=745a4373a2a16df560f216e000000264-1480431465.189675-248410963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:06 INFO - MultiFileLogger online at 20161129 09:19:06 in /builds/slave/test 09:19:06 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 09:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:06 INFO - {'append_to_log': False, 09:19:06 INFO - 'base_work_dir': '/builds/slave/test', 09:19:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:06 INFO - 'branch': 'Mozilla-Aurora', 09:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:06 INFO - 'config_files': ('talos/linux_config.py',), 09:19:06 INFO - 'default_actions': ('clobber', 09:19:06 INFO - 'read-buildbot-config', 09:19:06 INFO - 'download-and-extract', 09:19:06 INFO - 'populate-webroot', 09:19:06 INFO - 'create-virtualenv', 09:19:06 INFO - 'install', 09:19:06 INFO - 'run-tests'), 09:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:06 INFO - 'download_minidump_stackwalk': True, 09:19:06 INFO - 'download_symbols': 'ondemand', 09:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:06 INFO - 'installer_path': 'installer.exe', 09:19:06 INFO - 'log_level': 'info', 09:19:06 INFO - 'log_name': 'talos', 09:19:06 INFO - 'log_to_console': True, 09:19:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:06 INFO - 'opt_config_files': (), 09:19:06 INFO - 'pip_index': False, 09:19:06 INFO - 'sps_profile': False, 09:19:06 INFO - 'sps_profile_interval': 0, 09:19:06 INFO - 'suite': 'dromaeojs', 09:19:06 INFO - 'system_bits': '32', 09:19:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:06 INFO - 'title': 'talos-linux64-ix-032', 09:19:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:06 INFO - 'use_talos_json': True, 09:19:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:06 INFO - 'work_dir': 'build'} 09:19:06 INFO - [mozharness: 2016-11-29 17:19:06.612257Z] Running clobber step. 09:19:06 INFO - Running pre-action listener: _resource_record_pre_action 09:19:06 INFO - Running main action method: clobber 09:19:06 INFO - rmtree: /builds/slave/test/build 09:19:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:07 INFO - Running post-action listener: _resource_record_post_action 09:19:07 INFO - [mozharness: 2016-11-29 17:19:07.592931Z] Finished clobber step (success) 09:19:07 INFO - [mozharness: 2016-11-29 17:19:07.593030Z] Running read-buildbot-config step. 09:19:07 INFO - Running pre-action listener: _resource_record_pre_action 09:19:07 INFO - Running main action method: read_buildbot_config 09:19:07 INFO - Using buildbot properties: 09:19:07 INFO - { 09:19:07 INFO - "project": "", 09:19:07 INFO - "product": "firefox", 09:19:07 INFO - "script_repo_revision": "production", 09:19:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:19:07 INFO - "repository": "", 09:19:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:19:07 INFO - "buildid": "20161129062927", 09:19:07 INFO - "pgo_build": "True", 09:19:07 INFO - "basedir": "/builds/slave/test", 09:19:07 INFO - "buildnumber": 933, 09:19:07 INFO - "slavename": "talos-linux64-ix-032", 09:19:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:07 INFO - "platform": "ubuntu64_hw", 09:19:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:19:07 INFO - "branch": "mozilla-aurora", 09:19:07 INFO - "repo_path": "releases/mozilla-aurora", 09:19:07 INFO - "revision": "55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e", 09:19:07 INFO - "stage_platform": "linux64-pgo", 09:19:07 INFO - "builduid": "0da61bd7eb514695b9c47523cd39a1c8", 09:19:07 INFO - "slavebuilddir": "test" 09:19:07 INFO - } 09:19:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:19:07 INFO - Running post-action listener: _resource_record_post_action 09:19:07 INFO - [mozharness: 2016-11-29 17:19:07.595445Z] Finished read-buildbot-config step (success) 09:19:07 INFO - [mozharness: 2016-11-29 17:19:07.595533Z] Running download-and-extract step. 09:19:07 INFO - Running pre-action listener: _resource_record_pre_action 09:19:07 INFO - Running main action method: download_and_extract 09:19:07 INFO - mkdir: /builds/slave/test/build/tests 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - trying https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:19:07 INFO - Downloading https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:19:08 INFO - Downloaded 1361 bytes. 09:19:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:19:08 INFO - Using the following test package requirements: 09:19:08 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:19:08 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:19:08 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:19:08 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'jsshell-linux-x86_64.zip'], 09:19:08 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:19:08 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:19:08 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:19:08 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:19:08 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:19:08 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:19:08 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:19:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:19:08 INFO - Http code: 200 09:19:08 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 09:19:08 INFO - x-amz-cf-id: D8Hz2OEaIXGmSTttE4okvTJaUyoaMRm5_1awlJSsz8COmrpLrdpGfw== 09:19:08 INFO - x-amz-version-id: 5H.DJwryyoq008EuFVT7t2ldlEniuVJW 09:19:08 INFO - Expected file size: 21955864 09:19:08 INFO - Obtained file size: 21955864 09:19:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:19:13 INFO - Http code: 200 09:19:13 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:19:13 INFO - x-amz-cf-id: 7-AyH0vUh5fBaOExEJEre9yogOwqS58Ala2k54RKTQtyG0hxSpgkFQ== 09:19:13 INFO - x-amz-version-id: 5H.DJwryyoq008EuFVT7t2ldlEniuVJW 09:19:13 INFO - Expected file size: 21955864 09:19:13 INFO - Obtained file size: 21955864 09:19:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:19:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:19:18 INFO - Fetch https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:19:19 INFO - Http code: 200 09:19:19 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:19:19 INFO - x-amz-cf-id: g2reSX65Cfv4lXlRpJMm-P7TQVVBzfx-CxHO2cA-rtqWJON0xiMygA== 09:19:19 INFO - x-amz-version-id: G2lj_VQINAG.4Wces3zkscOlOw2AHWMl 09:19:19 INFO - Expected file size: 14409038 09:19:19 INFO - Obtained file size: 14409038 09:19:19 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')]} 09:19:19 INFO - trying https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:19 INFO - Downloading https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:19:20 INFO - Downloaded 63956415 bytes. 09:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:20 INFO - mkdir: /builds/slave/test/properties 09:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:20 INFO - Contents: 09:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:19:21 INFO - Running post-action listener: _resource_record_post_action 09:19:21 INFO - Running post-action listener: set_extra_try_arguments 09:19:21 INFO - [mozharness: 2016-11-29 17:19:21.430804Z] Finished download-and-extract step (success) 09:19:21 INFO - [mozharness: 2016-11-29 17:19:21.431030Z] Running populate-webroot step. 09:19:21 INFO - Running pre-action listener: _resource_record_pre_action 09:19:21 INFO - Running main action method: populate_webroot 09:19:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:21 INFO - '--tppagecycles', 09:19:21 INFO - '7'], 09:19:21 INFO - 'tests': ['tsvgm']}}, 09:19:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['damp', 'tps']}, 09:19:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'tests': ['damp', 'tps']}, 09:19:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['dromaeo_dom']}, 09:19:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['basic_compositor_video']}, 09:19:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['a11yr', 09:19:21 INFO - 'ts_paint', 09:19:21 INFO - 'tpaint', 09:19:21 INFO - 'sessionrestore', 09:19:21 INFO - 'sessionrestore_no_auto_restore', 09:19:21 INFO - 'tabpaint']}, 09:19:21 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:21 INFO - 'ts_paint', 09:19:21 INFO - 'tpaint', 09:19:21 INFO - 'sessionrestore', 09:19:21 INFO - 'sessionrestore_no_auto_restore', 09:19:21 INFO - 'tabpaint']}, 09:19:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:21 INFO - 'ts_paint', 09:19:21 INFO - 'tpaint', 09:19:21 INFO - 'sessionrestore', 09:19:21 INFO - 'sessionrestore_no_auto_restore', 09:19:21 INFO - 'tabpaint']}, 09:19:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:21 INFO - 'ts_paint', 09:19:21 INFO - 'tpaint', 09:19:21 INFO - 'sessionrestore', 09:19:21 INFO - 'sessionrestore_no_auto_restore', 09:19:21 INFO - 'tabpaint']}, 09:19:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['a11yr', 09:19:21 INFO - 'ts_paint', 09:19:21 INFO - 'tpaint', 09:19:21 INFO - 'sessionrestore', 09:19:21 INFO - 'sessionrestore_no_auto_restore', 09:19:21 INFO - 'tabpaint']}, 09:19:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['a11yr', 09:19:21 INFO - 'ts_paint', 09:19:21 INFO - 'tpaint', 09:19:21 INFO - 'sessionrestore', 09:19:21 INFO - 'sessionrestore_no_auto_restore', 09:19:21 INFO - 'tabpaint']}, 09:19:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['tsvgx', 09:19:21 INFO - 'tsvgr_opacity', 09:19:21 INFO - 'tart', 09:19:21 INFO - 'tscrollx', 09:19:21 INFO - 'cart']}, 09:19:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:21 INFO - 'tsvgr_opacity', 09:19:21 INFO - 'tart', 09:19:21 INFO - 'tscrollx', 09:19:21 INFO - 'cart']}, 09:19:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'talos_options': ['--disable-e10s'], 09:19:21 INFO - 'tests': ['tp5o']}, 09:19:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'tests': ['tp5o']}, 09:19:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'talos_options': ['--disable-e10s', 09:19:21 INFO - '--xperf_path', 09:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:21 INFO - 'tests': ['tp5n']}, 09:19:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:21 INFO - 'talos_options': ['--xperf_path', 09:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:21 INFO - 'tests': ['tp5n']}}, 09:19:21 INFO - 'talos.zip': {'path': '', 09:19:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:21 INFO - Running post-action listener: _resource_record_post_action 09:19:21 INFO - [mozharness: 2016-11-29 17:19:21.450945Z] Finished populate-webroot step (success) 09:19:21 INFO - [mozharness: 2016-11-29 17:19:21.451034Z] Running create-virtualenv step. 09:19:21 INFO - Running pre-action listener: _resource_record_pre_action 09:19:21 INFO - Running main action method: create_virtualenv 09:19:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:21 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 09:19:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:21 INFO - Using real prefix '/usr' 09:19:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:24 INFO - Installing pip.................done. 09:19:24 INFO - Return code: 0 09:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:24 INFO - Reading from file tmpfile_stdout 09:19:24 INFO - Output received: 09:19:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:19:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:24 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 09:19:24 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 09:19:24 INFO - Using env: {'DISPLAY': ':0', 09:19:24 INFO - 'HOME': '/home/cltbld', 09:19:24 INFO - 'LANG': 'en_US.UTF-8', 09:19:24 INFO - 'LANGUAGE': 'en_US:en', 09:19:24 INFO - 'LOGNAME': 'cltbld', 09:19:24 INFO - 'MAIL': '/var/mail/cltbld', 09:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:24 INFO - 'MOZ_NO_REMOTE': '1', 09:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:24 INFO - 'NO_EM_RESTART': '1', 09:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:24 INFO - 'PWD': '/builds/slave/test', 09:19:24 INFO - 'SHELL': '/bin/bash', 09:19:24 INFO - 'SHLVL': '1', 09:19:24 INFO - 'TERM': 'linux', 09:19:24 INFO - 'TMOUT': '86400', 09:19:24 INFO - 'USER': 'cltbld', 09:19:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:24 INFO - '_': '/tools/buildbot/bin/python'} 09:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:24 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 09:19:24 INFO - Cleaning up... 09:19:24 INFO - Return code: 0 09:19:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:24 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 09:19:24 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 09:19:24 INFO - Using env: {'DISPLAY': ':0', 09:19:24 INFO - 'HOME': '/home/cltbld', 09:19:24 INFO - 'LANG': 'en_US.UTF-8', 09:19:24 INFO - 'LANGUAGE': 'en_US:en', 09:19:24 INFO - 'LOGNAME': 'cltbld', 09:19:24 INFO - 'MAIL': '/var/mail/cltbld', 09:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:24 INFO - 'MOZ_NO_REMOTE': '1', 09:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:24 INFO - 'NO_EM_RESTART': '1', 09:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:24 INFO - 'PWD': '/builds/slave/test', 09:19:24 INFO - 'SHELL': '/bin/bash', 09:19:24 INFO - 'SHLVL': '1', 09:19:24 INFO - 'TERM': 'linux', 09:19:24 INFO - 'TMOUT': '86400', 09:19:24 INFO - 'USER': 'cltbld', 09:19:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:24 INFO - '_': '/tools/buildbot/bin/python'} 09:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:24 INFO - Downloading/unpacking psutil>=3.1.1 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 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 09:19:24 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 09:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:26 INFO - Installing collected packages: psutil 09:19:26 INFO - Running setup.py install for psutil 09:19:26 INFO - building 'psutil._psutil_linux' extension 09:19:26 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 09:19:26 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 09:19:27 INFO - building 'psutil._psutil_posix' extension 09:19:27 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 09:19:27 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 09:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:27 INFO - Successfully installed psutil 09:19:27 INFO - Cleaning up... 09:19:27 INFO - Return code: 0 09:19:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:27 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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:27 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 09:19:27 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 09:19:27 INFO - Using env: {'DISPLAY': ':0', 09:19:27 INFO - 'HOME': '/home/cltbld', 09:19:27 INFO - 'LANG': 'en_US.UTF-8', 09:19:27 INFO - 'LANGUAGE': 'en_US:en', 09:19:27 INFO - 'LOGNAME': 'cltbld', 09:19:27 INFO - 'MAIL': '/var/mail/cltbld', 09:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:27 INFO - 'MOZ_NO_REMOTE': '1', 09:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:27 INFO - 'NO_EM_RESTART': '1', 09:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:27 INFO - 'PWD': '/builds/slave/test', 09:19:27 INFO - 'SHELL': '/bin/bash', 09:19:27 INFO - 'SHLVL': '1', 09:19:27 INFO - 'TERM': 'linux', 09:19:27 INFO - 'TMOUT': '86400', 09:19:27 INFO - 'USER': 'cltbld', 09:19:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:27 INFO - '_': '/tools/buildbot/bin/python'} 09:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:27 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 09:19:27 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 09:19:27 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 09:19:27 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 09:19:27 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 09:19:27 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 09:19:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:29 INFO - Installing collected packages: mozsystemmonitor 09:19:29 INFO - Running setup.py install for mozsystemmonitor 09:19:29 INFO - Successfully installed mozsystemmonitor 09:19:29 INFO - Cleaning up... 09:19:29 INFO - Return code: 0 09:19:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:19:29 INFO - Using env: {'DISPLAY': ':0', 09:19:29 INFO - 'HOME': '/home/cltbld', 09:19:29 INFO - 'LANG': 'en_US.UTF-8', 09:19:29 INFO - 'LANGUAGE': 'en_US:en', 09:19:29 INFO - 'LOGNAME': 'cltbld', 09:19:29 INFO - 'MAIL': '/var/mail/cltbld', 09:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:29 INFO - 'MOZ_NO_REMOTE': '1', 09:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:29 INFO - 'NO_EM_RESTART': '1', 09:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:29 INFO - 'PWD': '/builds/slave/test', 09:19:29 INFO - 'SHELL': '/bin/bash', 09:19:29 INFO - 'SHLVL': '1', 09:19:29 INFO - 'TERM': 'linux', 09:19:29 INFO - 'TMOUT': '86400', 09:19:29 INFO - 'USER': 'cltbld', 09:19:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:29 INFO - '_': '/tools/buildbot/bin/python'} 09:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:31 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 09:19:31 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 09:19:31 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 09:19:31 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 09:19:31 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 09:19:31 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 09:19:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:32 INFO - warning: no files found matching '*.txt' 09:19:32 INFO - no previously-included directories found matching 'build' 09:19:32 INFO - no previously-included directories found matching 'dist' 09:19:32 INFO - no previously-included directories found matching '.git*' 09:19:32 INFO - Installing collected packages: jsonschema, functools32 09:19:32 INFO - Running setup.py install for functools32 09:19:32 INFO - warning: no files found matching '*.txt' 09:19:32 INFO - no previously-included directories found matching 'build' 09:19:32 INFO - no previously-included directories found matching 'dist' 09:19:32 INFO - no previously-included directories found matching '.git*' 09:19:32 INFO - Successfully installed jsonschema functools32 09:19:32 INFO - Cleaning up... 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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', '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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:19: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 functools32==3.2.3-2 09:19:32 INFO - Using env: {'DISPLAY': ':0', 09:19:32 INFO - 'HOME': '/home/cltbld', 09:19:32 INFO - 'LANG': 'en_US.UTF-8', 09:19:32 INFO - 'LANGUAGE': 'en_US:en', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MAIL': '/var/mail/cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SHLVL': '1', 09:19:32 INFO - 'TERM': 'linux', 09:19:32 INFO - 'TMOUT': '86400', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - '_': '/tools/buildbot/bin/python'} 09:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:32 INFO - Cleaning up... 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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', '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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:19: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 blobuploader==1.2.4 09:19:32 INFO - Using env: {'DISPLAY': ':0', 09:19:32 INFO - 'HOME': '/home/cltbld', 09:19:32 INFO - 'LANG': 'en_US.UTF-8', 09:19:32 INFO - 'LANGUAGE': 'en_US:en', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MAIL': '/var/mail/cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SHLVL': '1', 09:19:32 INFO - 'TERM': 'linux', 09:19:32 INFO - 'TMOUT': '86400', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - '_': '/tools/buildbot/bin/python'} 09:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:35 INFO - Downloading docopt-0.6.1.tar.gz 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:35 INFO - Running setup.py install for blobuploader 09:19:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:35 INFO - Running setup.py install for requests 09:19:36 INFO - Running setup.py install for docopt 09:19:36 INFO - Successfully installed blobuploader requests docopt 09:19:36 INFO - Cleaning up... 09:19:36 INFO - Return code: 0 09:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:36 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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:36 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 09:19:36 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 09:19:36 INFO - Using env: {'DISPLAY': ':0', 09:19:36 INFO - 'HOME': '/home/cltbld', 09:19:36 INFO - 'LANG': 'en_US.UTF-8', 09:19:36 INFO - 'LANGUAGE': 'en_US:en', 09:19:36 INFO - 'LOGNAME': 'cltbld', 09:19:36 INFO - 'MAIL': '/var/mail/cltbld', 09:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:36 INFO - 'MOZ_NO_REMOTE': '1', 09:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:36 INFO - 'NO_EM_RESTART': '1', 09:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:36 INFO - 'PWD': '/builds/slave/test', 09:19:36 INFO - 'SHELL': '/bin/bash', 09:19:36 INFO - 'SHLVL': '1', 09:19:36 INFO - 'TERM': 'linux', 09:19:36 INFO - 'TMOUT': '86400', 09:19:36 INFO - 'USER': 'cltbld', 09:19:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:36 INFO - '_': '/tools/buildbot/bin/python'} 09:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:36 INFO - Running setup.py (path:/tmp/pip-rNAPQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:36 INFO - Running setup.py (path:/tmp/pip-mgBWSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:36 INFO - Running setup.py (path:/tmp/pip-o7vCAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:36 INFO - Running setup.py (path:/tmp/pip-oDIAto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:36 INFO - Running setup.py (path:/tmp/pip-pI1K3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:36 INFO - Running setup.py (path:/tmp/pip-qPOKWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:36 INFO - Running setup.py (path:/tmp/pip-kCDf7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:36 INFO - Running setup.py (path:/tmp/pip-C0VEFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:37 INFO - Running setup.py (path:/tmp/pip-6dOiRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:37 INFO - Running setup.py (path:/tmp/pip-VzYQzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:37 INFO - Running setup.py (path:/tmp/pip-ZXWYQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:37 INFO - Running setup.py (path:/tmp/pip-A8uCUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:37 INFO - Running setup.py (path:/tmp/pip-MYjt1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:37 INFO - Running setup.py (path:/tmp/pip-S5fyPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:37 INFO - Running setup.py (path:/tmp/pip-qly67f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:37 INFO - Running setup.py (path:/tmp/pip-qxe9z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:37 INFO - Running setup.py (path:/tmp/pip-WyRnvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:37 INFO - Running setup.py install for manifestparser 09:19:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozcrash 09:19:37 INFO - Running setup.py install for mozdebug 09:19:37 INFO - Running setup.py install for mozdevice 09:19:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozfile 09:19:38 INFO - Running setup.py install for mozhttpd 09:19:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozinfo 09:19:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozInstall 09:19:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozleak 09:19:38 INFO - Running setup.py install for mozlog 09:19:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for moznetwork 09:19:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozprocess 09:19:38 INFO - Running setup.py install for mozprofile 09:19:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Running setup.py install for mozrunner 09:19:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Running setup.py install for mozscreenshot 09:19:39 INFO - Running setup.py install for moztest 09:19:39 INFO - Running setup.py install for mozversion 09:19:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:39 INFO - Cleaning up... 09:19:39 INFO - Return code: 0 09:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:39 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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:39 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 09:19:39 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 09:19:39 INFO - Using env: {'DISPLAY': ':0', 09:19:39 INFO - 'HOME': '/home/cltbld', 09:19:39 INFO - 'LANG': 'en_US.UTF-8', 09:19:39 INFO - 'LANGUAGE': 'en_US:en', 09:19:39 INFO - 'LOGNAME': 'cltbld', 09:19:39 INFO - 'MAIL': '/var/mail/cltbld', 09:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:39 INFO - 'MOZ_NO_REMOTE': '1', 09:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:39 INFO - 'NO_EM_RESTART': '1', 09:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:39 INFO - 'PWD': '/builds/slave/test', 09:19:39 INFO - 'SHELL': '/bin/bash', 09:19:39 INFO - 'SHLVL': '1', 09:19:39 INFO - 'TERM': 'linux', 09:19:39 INFO - 'TMOUT': '86400', 09:19:39 INFO - 'USER': 'cltbld', 09:19:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:39 INFO - '_': '/tools/buildbot/bin/python'} 09:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:39 INFO - Running setup.py (path:/tmp/pip-J1sigW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:39 INFO - Running setup.py (path:/tmp/pip-2FhyIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 INFO - Running setup.py (path:/tmp/pip-ZMDHTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 INFO - Running setup.py (path:/tmp/pip-mLWV0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:40 INFO - Running setup.py (path:/tmp/pip-mLOoHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:40 INFO - Running setup.py (path:/tmp/pip-aHq7J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:40 INFO - Running setup.py (path:/tmp/pip-YMMoAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:40 INFO - Running setup.py (path:/tmp/pip-xqy7t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:40 INFO - Running setup.py (path:/tmp/pip-8ohO3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:40 INFO - Running setup.py (path:/tmp/pip-9Pi72R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:40 INFO - Running setup.py (path:/tmp/pip-WRnIhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:40 INFO - Running setup.py (path:/tmp/pip-SfpI0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 INFO - Running setup.py (path:/tmp/pip-KM3Rrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 INFO - Running setup.py (path:/tmp/pip-BLd3JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 INFO - Running setup.py (path:/tmp/pip-muVBUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:40 INFO - Running setup.py (path:/tmp/pip-Xgmz0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:40 INFO - Running setup.py (path:/tmp/pip-ieaOlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:40 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)) 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:42 INFO - Downloading blessings-1.6.tar.gz 09:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:43 INFO - Installing collected packages: blessings 09:19:43 INFO - Running setup.py install for blessings 09:19:43 INFO - Successfully installed blessings 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:43 INFO - Reading from file tmpfile_stdout 09:19:43 INFO - Current package versions: 09:19:43 INFO - argparse == 1.2.1 09:19:43 INFO - blessings == 1.6 09:19:43 INFO - blobuploader == 1.2.4 09:19:43 INFO - docopt == 0.6.1 09:19:43 INFO - functools32 == 3.2.3-2 09:19:43 INFO - jsonschema == 2.5.1 09:19:43 INFO - manifestparser == 1.1 09:19:43 INFO - mozInstall == 1.12 09:19:43 INFO - mozcrash == 1.0 09:19:43 INFO - mozdebug == 0.1 09:19:43 INFO - mozdevice == 0.48 09:19:43 INFO - mozfile == 1.2 09:19:43 INFO - mozhttpd == 0.7 09:19:43 INFO - mozinfo == 0.9 09:19:43 INFO - mozleak == 0.1 09:19:43 INFO - mozlog == 3.4 09:19:43 INFO - moznetwork == 0.27 09:19:43 INFO - mozprocess == 0.23 09:19:43 INFO - mozprofile == 0.28 09:19:43 INFO - mozrunner == 6.13 09:19:43 INFO - mozscreenshot == 0.1 09:19:43 INFO - mozsystemmonitor == 0.3 09:19:43 INFO - moztest == 0.7 09:19:43 INFO - mozversion == 1.4 09:19:43 INFO - psutil == 3.1.1 09:19:43 INFO - requests == 1.2.3 09:19:43 INFO - wsgiref == 0.1.2 09:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 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 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:43 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 09:19:43 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 09:19:43 INFO - Using env: {'DISPLAY': ':0', 09:19:43 INFO - 'HOME': '/home/cltbld', 09:19:43 INFO - 'LANG': 'en_US.UTF-8', 09:19:43 INFO - 'LANGUAGE': 'en_US:en', 09:19:43 INFO - 'LOGNAME': 'cltbld', 09:19:43 INFO - 'MAIL': '/var/mail/cltbld', 09:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:43 INFO - 'MOZ_NO_REMOTE': '1', 09:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:43 INFO - 'NO_EM_RESTART': '1', 09:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:43 INFO - 'PWD': '/builds/slave/test', 09:19:43 INFO - 'SHELL': '/bin/bash', 09:19:43 INFO - 'SHLVL': '1', 09:19:43 INFO - 'TERM': 'linux', 09:19:43 INFO - 'TMOUT': '86400', 09:19:43 INFO - 'USER': 'cltbld', 09:19:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:43 INFO - '_': '/tools/buildbot/bin/python'} 09:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92a1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, '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': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', '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 09:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:43 INFO - Using env: {'DISPLAY': ':0', 09:19:43 INFO - 'HOME': '/home/cltbld', 09:19:43 INFO - 'LANG': 'en_US.UTF-8', 09:19:43 INFO - 'LANGUAGE': 'en_US:en', 09:19:43 INFO - 'LOGNAME': 'cltbld', 09:19:43 INFO - 'MAIL': '/var/mail/cltbld', 09:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:43 INFO - 'MOZ_NO_REMOTE': '1', 09:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:43 INFO - 'NO_EM_RESTART': '1', 09:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:43 INFO - 'PWD': '/builds/slave/test', 09:19:43 INFO - 'SHELL': '/bin/bash', 09:19:43 INFO - 'SHLVL': '1', 09:19:43 INFO - 'TERM': 'linux', 09:19:43 INFO - 'TMOUT': '86400', 09:19:43 INFO - 'USER': 'cltbld', 09:19:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:43 INFO - '_': '/tools/buildbot/bin/python'} 09:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Running post-action listener: _resource_record_post_action 09:19:43 INFO - Running post-action listener: _start_resource_monitoring 09:19:43 INFO - Starting resource monitoring. 09:19:43 INFO - [mozharness: 2016-11-29 17:19:43.908310Z] Finished create-virtualenv step (success) 09:19:43 INFO - [mozharness: 2016-11-29 17:19:43.908817Z] Running install step. 09:19:43 INFO - Running pre-action listener: _resource_record_pre_action 09:19:43 INFO - Running main action method: install 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Output received: 09:19:44 INFO - Usage: mozinstall [options] installer 09:19:44 INFO - Options: 09:19:44 INFO - -h, --help show this help message and exit 09:19:44 INFO - -d DEST, --destination=DEST 09:19:44 INFO - Directory to install application into. [default: 09:19:44 INFO - "/builds/slave/test"] 09:19:44 INFO - --app=APP Application being installed. [default: firefox] 09:19:44 INFO - mkdir: /builds/slave/test/build/application 09:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:20:01 INFO - Reading from file tmpfile_stdout 09:20:01 INFO - Output received: 09:20:01 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:01 INFO - Running post-action listener: _resource_record_post_action 09:20:01 INFO - [mozharness: 2016-11-29 17:20:01.192817Z] Finished install step (success) 09:20:01 INFO - [mozharness: 2016-11-29 17:20:01.193060Z] Running run-tests step. 09:20:01 INFO - Running pre-action listener: _resource_record_pre_action 09:20:01 INFO - Running main action method: run_tests 09:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:01 INFO - Python 2.7.3 09:20:01 INFO - Return code: 0 09:20:01 INFO - grabbing minidump binary from tooltool 09:20:01 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')]} 09:20:01 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 0x2008f60>, '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 0x2009d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:01 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 09:20:01 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 09:20:01 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 09:20:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:01 INFO - Return code: 0 09:20:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:01 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/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 09:20:01 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/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 09:20:01 INFO - Using env: {'DISPLAY': ':0', 09:20:01 INFO - 'HOME': '/home/cltbld', 09:20:01 INFO - 'LANG': 'en_US.UTF-8', 09:20:01 INFO - 'LANGUAGE': 'en_US:en', 09:20:01 INFO - 'LOGNAME': 'cltbld', 09:20:01 INFO - 'MAIL': '/var/mail/cltbld', 09:20:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:01 INFO - 'MOZ_NO_REMOTE': '1', 09:20:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:01 INFO - 'NO_EM_RESTART': '1', 09:20:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:01 INFO - 'PWD': '/builds/slave/test', 09:20:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:01 INFO - 'SHELL': '/bin/bash', 09:20:01 INFO - 'SHLVL': '1', 09:20:01 INFO - 'TERM': 'linux', 09:20:01 INFO - 'TMOUT': '86400', 09:20:01 INFO - 'USER': 'cltbld', 09:20:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480431465.189675-248410963', 09:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:01 INFO - '_': '/tools/buildbot/bin/python'} 09:20:01 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/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 09:20:01 INFO - mozversion application_buildid: 20161129062927 09:20:01 INFO - mozversion application_changeset: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e 09:20:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:20:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:01 INFO - mozversion application_name: Firefox 09:20:01 INFO - mozversion application_remotingname: firefox-dev 09:20:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:01 INFO - mozversion application_vendor: Mozilla 09:20:01 INFO - mozversion application_version: 52.0a2 09:20:01 INFO - mozversion platform_buildid: 20161129062927 09:20:01 INFO - mozversion platform_changeset: 55c4ba0e73cdae6e2cfc93f7d195273b15f2f56e 09:20:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:01 INFO - mozversion platform_version: 52.0a2 09:20:01 INFO - using testdate: 1480440001 09:20:01 INFO - actual date: 1480440001 09:20:01 INFO - starting webserver on 'localhost:49993' 09:20:01 INFO - SUITE-START | Running 2 tests 09:20:01 INFO - TEST-START | dromaeo_css 09:20:01 INFO - operating with platform_type : linux_ 09:20:01 INFO - Initialising browser for dromaeo_css test... 09:20:01 INFO - TEST-INFO | started process 3646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH0NLqU/profile http://localhost:49993/getInfo.html) 09:20:06 INFO - PROCESS | 3646 | __metrics Screen width/height:1600/1200 09:20:06 INFO - PROCESS | 3646 | colorDepth:24 09:20:06 INFO - PROCESS | 3646 | Browser inner width/height: 1024/697 09:20:06 INFO - PROCESS | 3646 | __metrics 09:20:06 INFO - PROCESS | 3646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:20:06 INFO - PROCESS | 3646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:07 INFO - PROCESS | 3646 | console.error: PushService: 09:20:07 INFO - PROCESS | 3646 | stateChangeProcessEnqueue: Error transitioning state 09:20:07 INFO - PROCESS | 3646 | UnknownError 09:20:07 INFO - TEST-INFO | 3646: exit 0 09:20:07 INFO - Browser initialized. 09:20:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:07 INFO - TEST-INFO | started process 3741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH0NLqU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:19 INFO - PROCESS | 3741 | RSS: Main: 145137664 09:20:19 INFO - PROCESS | 3741 | 09:21:11 INFO - PROCESS | 3741 | 1480440071387 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] 09:23:21 INFO - PROCESS | 3741 | Cycle 1(1): loaded http://localhost:49993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49993/tests/dromaeo/cssquery-ext.html) 09:23:23 INFO - PROCESS | 3741 | RSS: Main: 245714944 09:23:23 INFO - PROCESS | 3741 | 09:26:25 INFO - PROCESS | 3741 | Cycle 1(1): loaded http://localhost:49993/tests/dromaeo/cssquery-ext.html (next: http://localhost:49993/tests/dromaeo/cssquery-jquery.html) 09:26:25 INFO - PROCESS | 3741 | RSS: Main: 223309824 09:26:25 INFO - PROCESS | 3741 | 09:29:27 INFO - PROCESS | 3741 | Cycle 1(1): loaded http://localhost:49993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49993/tests/dromaeo/cssquery-mootools.html) 09:29:28 INFO - PROCESS | 3741 | RSS: Main: 216829952 09:29:28 INFO - PROCESS | 3741 | 09:32:30 INFO - PROCESS | 3741 | Cycle 1(1): loaded http://localhost:49993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49993/tests/dromaeo/cssquery-prototype.html) 09:32:31 INFO - PROCESS | 3741 | RSS: Main: 173281280 09:32:31 INFO - PROCESS | 3741 | 09:35:33 INFO - PROCESS | 3741 | Cycle 1(1): loaded http://localhost:49993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49993/tests/dromaeo/cssquery-yui.html) 09:35:34 INFO - PROCESS | 3741 | RSS: Main: 174034944 09:35:34 INFO - PROCESS | 3741 | 09:38:36 INFO - PROCESS | 3741 | Cycle 1(1): loaded http://localhost:49993/tests/dromaeo/cssquery-yui.html (next: http://localhost:49993/tests/dromaeo/cssquery-dojo.html) 09:38:37 INFO - PROCESS | 3741 | RSS: Main: 262807552 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | __start_tp_report 09:38:37 INFO - PROCESS | 3741 | _x_x_mozilla_page_load 09:38:37 INFO - PROCESS | 3741 | _x_x_mozilla_page_load_details 09:38:37 INFO - PROCESS | 3741 | |i|pagename|runs| 09:38:37 INFO - PROCESS | 3741 | |0;dojo.html;3216.9195770105744;3247.3667634811222;3259.445894197986;3267.9673203267967;3277.9672203277973;5687.886242275157;5733.111367737997;5744.942550574493;5763.5389168866495;5773.682447465388;5707.429257074291;5797.855053623662;5805.24531810864;5820.679862607565;5846.298444186704;5161.458046905077;5197.974010129953;5221.190715439113;5256.710880901549;5292.073887069767;5039.571636410909;5054.292399064134;5297.337832770903;5319.5478384337375;5332.786688532454;5154.098032844256;5160.483951604847;5198.896022079556;5214.973925130369;5242;5256.737163141846;5289;5337.306150200449;5354.839354819362;5362.8123015694655;5016.974915125437;5115.616328775357;5237.607179461517;5243.370795504526;5358.223057656618;5602.943970560324;5628.71856407178;5635.71821408932;5656.349519805234;5667.433256674341;6078.240219972504;6157.7536898524;6178.536609754242;6181.907271390933;6190.876182476325;5838.591298609099;5856.853578660525;6230.59501132425;6242.781502647385;6252.843678908018;5657.066584013674;5659.745311460994;5664.0937450007805;5696.715164241771;5727.599068065196;6224.719887605069;6241.188645476059;6252.6873656317;6260.217472815898;6267.185265915402;5862.062070068769;5925.614835035709;5987.431194036647;6011.519078473799;6043;6059.242594675666;6112.716259964451;6136.846578835475;6180.907286390708;6191.318954914956;6162.599431037058;6167.136600875881;6173.96913015441;6174.876502469925;6176.938230617637;5941;6110.664716950083;6183.84540386494;6188.8762224755255;6191.659458729813;4600.079984003212;4612.7462989535225;4613.2388155953895;4623.583877451046;4689.43726752785;4158.8336466540995;4175.081482073939;4176.644985176294;4190.015346393595;4206.305959516645;5797.159411885337;5801.8549536261935;5802.622829516068;5804.187413762077;5809.419058094157;5890.3815099414805;5939.613925094855;5950.67271300074;5995.52035837132;6124.877502449926;5733.254676891977;5733.799317023884;5740.569457290637;5746.42535746422;5773.653580785166;5195.922061169085;5222.55608273301;5225.3207083079715;5227.790888364499;5238.397584277781;6133.938660613426;6151.876962460815;6228.377162283736;6252.812415627538;6296.496280297657;6106.6946652668075;6205.596636218631;6208.317085120723;6208.937910621016;6209.658468784261;6416.45460135875;6420.325865784025;6423.29343772194;6434.131392262172;6434.967825160844;5766;5882.294124704892;6068.666223357758;6075.453209211192;6079.209702738615;5995.310539287863;6058.939410605837;6061.696915154136;6097.451229389376;6143.511877689543;6020.819375418744;6024.277086749618;6030.396960303934;6031.396860313934;6043.909341359795;5913.763449461973;5982.611130276518;5984.371640977634;6002.609830361012;6005.279366476051;5757.625754325955;5773.336066352255;5806.390329015392;5816.272965879265;5820.359760426434;5947.791827286024;5952.910706339495;5968.731407086779;5980.5514586405325;5990.850228744316;5692.032354499828;5754.395788442153;5759.94240057594;5813.738381772915;5826.504747096375 09:38:37 INFO - PROCESS | 3741 | |1;ext.html;576.5272476569212;613.4540259169339;644.3105876711917;647.9935200647992;666.6733300682668;32304.192395190104;32752.836235818817;35288.64711352882;42630.57369426305;43155.56844431555;45282.320765188466;45304.77347613266;45671.31493027607;45674;45729.31406028912;8695.217430431276;8912.287017038621;8935.910640893573;8945.73162805117;8950;8325.333973282153;8505.404621676485;8785;10349.120324772404;10591.099756520705;10713.303635263723;10780.083692886114;10780.838287425695;10805.621803236889;10816.621418250363;10596.099331556788;10682.038616524473;10691.732706682318;10696.304740191941;10708.089812365959;10573.418461984587;10624.840627390595;10638.680839574825;10641.255112142153;10652.62715804943;42474;42595.787021064694;42683.57316426827;42710.14579708388;42777.144457110684;3567.982160089183;3664.120611053355;3692.6307369263127;3715.516982792247;3913.7651740895635;31685.683143168735;31736.365272694416;32264.516032259537;32292.192695182574;32397.190070248198;4284.914301713949;4306.849260275875;4394.516603173648;4396.824127034914;4535.863924082283;332110;332326;332378;332604;332821;63115.68442157852;63308.683456582425;63625;63707;63781;37664;39016;39280.80359598184;42178.36732449016;42180.57819421828;17085.572860678334;17174.74237886433;17184;17208.225629846685;17210.655786884192;12685.175463594836;13955.441782328593;14038.85961140396;14074.507392241427;14079.718405632035;17987.370442034466;19297.51756206078;19983.800161998486;20054.298099566444;21094.261700840398;7354.154272258758;7381.335679788845;7565.6217189140325;7654.96172519145;7685.5004424712215;948.2982592881356;1053.5417093564324;1108.4402376799665;1138.4137169357787;1179.7699448607439;31926.680733192836;33939.66060339365;35098.64901350954;35125.47311790325;37707.434388484195;1007.1288335589662;1096.7970925378831;1101.9173561982884;1152.3374059915413;1211.5820042085466;15873.68252634964;18017.045312539158;18108.275668973092;18575.72136417955;18710;520194;522185;522698;522918;523635;60150.39849601448;60593.09110363348;60716;60809.695951519956;60854;1259.3954901647078;1325.2313658078292;1360.081944687332;1394.4422231107637;1415.610707055568;30096;34636.307273853876;34676;34833.47749783705;35028.88852457331;51102.74448627733;51798.48201517937;51819;51868.740656296475;51902.74048629884;449545;452631;453408;453720;453792;29021.7097829019;29463;30452.695473044987;30894;31704.682953171097;47936.28095578639;47990.97898922717;48157.27764083471;48481;49275.50724492709;37550.62449375581;37956.24087518289;38110.61889381071;38830.2233955325;38906.4164037534;41242.17540050563;41737.58262417458;42030;42323.365149522164;42676.573234267256;41671.37492937669;42326.36510452284;42391.15217695691;42971.35542966796;43042.35436468518;35854.46218306675;37271;37334.81332593429;37466.81266593649;37701.62298377091;28434.57348139821;28596.714032859407;28653.713462865937;28767.568486473137;28972.420551588428 09:38:37 INFO - PROCESS | 3741 | |2;jquery.html;402.5591976785419;415.279490084703;420.5710175620867;428.4793975319986;447.72688659917446;15030.473933412333;19165;19582.804171958294;20462.89768551155;20672.896635516838;19586.70619940702;20287.695684564707;20338.491537711565;20478.795212047877;20643.69034464484;5598.860028499279;5818.679972601505;5827.796027139051;5828.533717302626;5830.679312637824;5407.783688652449;5706.971465142689;5725.370209276976;5744.138379243105;5746.9712651436685;5723.399043100477;5740.311162660487;5741.885162296751;5750.079987202049;5752.28096487939;5709.571782116337;5957;5975.462208401243;6042.305134909498;6050.757969681207;5126.384833819965;5390.245365648812;5880.147378630118;5882.617629854089;5894.4989675877605;14803.0378025428;14945.40218391263;18368.98970556619;23678.763212367827;24065.759342406527;2381.38084098134;2452.2152911068465;2483.081259933818;2588.909388171424;2859.442408730298;10208.132308753764;10606.52270647815;10947.34315941046;12879.871201288055;14675.26623668823;1919.3953904520172;1957.2073310309347;1962.8527860410527;1963.1558429875147;2020.595880823841;84047;85694.57152714259;86427;87784.99999999936;89463;10050.145737612385;10906.563737450571;10952.507137178845;11002.174836887265;11299.322040677585;14398.568042958728;14652.926735366467;15370;15398.15310157952;15911.681766364607;7838.960805195938;8114.8782768258525;8165.265126138676;8239.546824924566;8279.089300176976;8184.345252379914;8190.180981901882;8221.83556328882;8224.876626850602;8623.223909848019;4461.174682683714;4549.09018196362;4727.125481785881;4788.760561971888;4995.275685025651;1907.5707965707882;1929.5947850951177;1974.0820518458697;1974.6544354737864;1993.7109119177637;953.4517652349926;982.9066238707311;1009.5608410341525;1025.4411345816548;1101.2181351240708;19945.700814487795;20492.487687807625;20499.38501844947;20551.4862128445;20858;1002.7944271424486;1021.0912288063629;1022.9693109206736;1032.5461331844967;1033.6227277043974;10625.203109766799;11425.2002359834;11650.88349116515;11719.179657424069;11735.41322933867;479892;483392;497774;498487;499358;92382.53808731047;95509;95914;96939.51530242445;98410;1019.4902548725637;1053.357451954292;1062.2245760594808;1072.7425417899804;1076.9246152769388;17675.823241767932;17822.5544361392;18131.728024079912;18229.54426139357;18509;45059;45173.32240016468;45362.546374535836;45568.772156139006;46593.06813863772;59740.70129649324;62283;62736;63824;64201;8352.665893364197;8588;8814.955925220333;8940.68707595231;9474.24206063527;12502.812457812957;13514.729705406033;13903.165810051429;14053.437862485795;14312;11163.553457861919;11411;11496;11765.705857353292;12225.205361651464;11803.468843901874;11839.704007399883;12084.516619335129;12250.264984100626;12258.448369823202;11767.882321177021;11972.281663100242;11983.880161198276;12141.69645758863;12612.180208286432;9116.498592577473;9140.63437462494;9248.491332976751;9264.675736349196;9320.72037838866;10640.361578305326;11384.658460246206;11461.885381146416;11582.07343412508;12114.818277726017 09:38:37 INFO - PROCESS | 3741 | |3;mootools.html;1404.3189053309136;1507.5402002389267;1530.033906430237;1677.882548221625;1800.3788692900953;7769.261920117587;8506.574671266435;8850.159234872677;8871.600777964999;9086.273098152149;8887.644494220223;8967.461952282867;8975.326850486206;8981.146791054856;8985.550722463884;2425.86657733825;2459.446624509489;2460.8400453970435;2461.716902556202;2462.064415522099;2390.4422069596158;2463.716672582658;2468.888899999495;2469.80241580674;2471.3574470637673;2403.960868527797;2412.95174096518;2456.3736247256925;2459.0286836699493;2459.0286836699493;2343.238447504568;2359.4337359033707;2391.3782416571644;2396.209250947183;2415.2029830156007;2385.2367242482414;2401.087586717036;2427.9757202427927;2433.148398060682;2436.439618887648;8776.692815751418;8841.513716745576;8871.822563548758;8888;8919.42023768453;5162.638615296931;5416.51251387377;5425.782968681248;5427.43011983744;5428.891422171574;3519.6832285094465;3595.2989167112423;3635.6909662678704;3698.9815050924844;3721.441783732435;1174.0900801878527;1176.9882301176965;1207.408369898752;1214.9574764883187;1224.2287358963886;12379.690507737288;12401.62795116148;12466.252024878537;12477.064220183522;12484.812727809;4312.956870431318;4650.093231819763;4654.418197725285;4694.389729335233;4740.715557066587;9425.670101546413;9433.103855133751;9445.716628501155;9450.149486546245;9457.243420526342;5323.494268044529;5330.706811125426;5334.546563542065;5339.172428273624;5351.143816989263;4256.5105012923295;4426.092651006536;4560.885977850514;4564.589186973189;5024.447310795809;3921.058945852975;3987.900302492461;4107.67138628909;4128.050548373831;4133.9793301033305;1202.8255902894032;1214.5931113077042;1219.810929305959;1220.560598184653;1244.3467179730715;854.9007508994263;956.7034219392011;965.1554889471712;1009.9394036357695;1029.1869423155772;6152.507799376039;6190.690465476709;6199.628022318675;6417.422431981051;6502.414782669488;951.1879868849852;966.8018056298442;989.8663680403198;999.7950420163849;1023.2195978996492;4122.814473348706;4262.403263543107;4365.301551751704;4392.407025051641;4404.1411924674385;10839.187060970458;11173.162012848907;11190.104791616652;11255.212135150625;11299.717507062389;11130.610428634958;11159.442027898573;11264.267822591506;11317.207795454238;11336.206465547497;8044.2760151586635;8329.5418751968;8355.122712115262;8467.872981905277;8534.103919088406;5867.911981320198;6116.204893364013;6116.3272040076445;6131.509479241561;6431.163948686641;9621.27840411986;10376.533056012346;10402.323848949794;10426;10551.472426378803;9537.47543885093;9741.659041933783;9868.259880509135;10366.585336586753;10465;8059.798505037421;8150.3072238857985;8196.50820950721;8222.465539739898;8308.584570771316;8428.367872409472;8582.699605514026;8593.140685931607;8605.741827745178;8610.956945215234;7648.158702542604;7707.499012564165;7853.842923141619;7957.244061814118;7965.4822436541435;7651.846963060819;7744.728934487266;7747.418943579141;7771.533707977539;7836.608169591612;7067.5052746307265;7154.284571542804;7183.317584829433;7186.928130718626;7198.6040767756185;5380.677159370451;5528.640638358494;5536.889262214652;5595.8880822384135;5640.943590564042;5450.700211488406;5525.640833345819;5658.066419040977;5662.716864156858;5709.25779648643 09:38:37 INFO - PROCESS | 3741 | |4;prototype.html;344.936186805441;349.13066464503396;349.3153419298175;354.0264273248566;354.89885382665943;5333.226682131089;5363.704996225206;5374.865628359293;5376.193570964358;5376.865578360543;5268.710220937847;5290.232916227144;5317.2821669074665;5338.893222135555;5343.984642917843;4058.4521089652962;4094.3858421236755;4106.322456794625;4149.730267532601;4177.749335039907;4204.11713540157;4206.621404073633;4224.704270701052;4255.723377980421;4258.403823464718;4189.07840275139;4201.39079833424;4201.70588058836;4215.430916826235;4222.619964203221;3931.783751893645;3933.567307596162;4186.706930514865;4186.890474024386;4226.112516371566;3681.4109742441346;3684;3685.4103343464917;3707.4624179494094;3709.239605880788;5109.9489005109845;5113.718745468997;5156.716380599066;5160.974195129001;5180.48195180479;4528.43394575678;4709.434867815884;4750.406199225097;4771.421433924556;4780.856574302777;5468.72656367184;5484.561235101182;5497.945020549823;5504.504594586467;5515.531179849718;4067.796610169509;4077.673786097105;4087.202995415895;4094.754314741125;4097.692673049503;5430.91853622196;5673.914891276634;5692.943070569283;5715.742791574389;5718.714064296769;4133.739209541059;4142.606452387018;4150.3566947123245;4155.397467367215;4175.457190565267;4223.796218077833;4233.238017156879;4236.555161707976;4239.918820700702;4249.46881639795;4511.6014035648395;4700.482946875841;4790;4793.257045158006;4795.18481858078;5559.193916882029;5574.247476590608;5575.1915972184615;5576.302962129734;5579.525740312119;1400.4175281931352;1406.8804151647225;1412.8304603447652;1414.957551273443;1416.390951890697;967.3712087143413;1000.4197565412044;1000.6797824696027;1001.4241810958728;1024.1243736605245;5166.844994650167;5249.42256351801;5319.547838433777;5440.986834871044;5450.209719590637;5693.28833895763;5697.544196464273;5709.972959599366;5726.398728133569;5734.168545560954;5176.171812509981;5384.353877534721;5409.513143817076;5438.564914806806;5468.26178465902;2896.493113705093;2907.433050555164;2909.2145120817686;2910.272431892027;2911.3696330055236;5688.004599195125;5688.9759843227785;5690.264469336809;5703.686297253608;5742.28221472316;5305.893882122413;5533.3083364579425;5537.065355361665;5551.805686800943;5588.720563971785;5698.544116470673;5706.4864162225595;5708.571857110816;5710.65736055838;5728.656280623176;5128.333316668809;5462.644928079662;5496.300662933294;5501.441829549119;5536.58817001662;5359.678419294854;5381.892362152813;5403.5136837684795;5413.891722165614;5420.674759514442;5636.323641163087;5657.688827114548;5686.857828554319;5696.601237913306;5793.406813126424;3957.6240257176673;4024.577419370924;4051.311277082844;4053.3919912012257;4088.672906167559;5426.050441172858;5436.891262174655;5462.596457558661;5467;5491.897078150832;5357.544608708147;5363.383210930637;5374.785008599612;5383.838484845461;5393.9730301348245;5072.681102913195;5295.828710228788;5310.601704872072;5379.488948549882;5396.325459317585;5236.245857637734;5247.4490178530705;5292.417834038176;5301.296338867129;5309.36287645485;5301.6818990860675;5431.972840135774;5436.510714035756;5580.581456390706;5585.82152960354;5426.8371948841595;5445.972770136124;5462.071447853954;5469.589780766379;5472.2065300531995 09:38:37 INFO - PROCESS | 3741 | |5;yui.html;732.5275197497617;750.114864459937;780.8984831971843;827.9461834980726;842.2461896602539;14921.701565968688;15409.46066887659;15797.368105275775;15852.920735396321;16110.838891611109;14076.436942522287;14417.639559011004;14423.278836058182;14426;14442.494512692032;835.7952301686096;840.1304649687575;849.8512760266959;861.336770686571;865.3639574912465;847.6778824046853;847.7583888591753;849.9447535910177;850.4259624753298;850.9446885952424;905.1943770044666;906.0169715858269;906.1618003346911;906.8458362078462;907.8184363127401;897.8967418746862;898.23201163006;898.27239935652;898.3442087276293;898.7932775461647;650.3561474140566;654.8035589323232;655.9278479367266;656.711047139262;657.5462930577886;14367.568972930725;14652.633684157874;14728.705425891421;14795.112293262331;14842.851571484363;11398.430078496125;13699.383527741276;14485.42058317666;14681.48614798477;14703.63240918975;10782.946085269523;10876.782464350668;11030.50362733671;11388.14588905827;11449.255798373162;3764.811759412046;3781.2800709986946;3792.7724336539895;3818.961810381916;3870.8645197418236;65067;66618;67624.66187669079;67707.32292677059;68324.65837670829;10733.195010374253;10782.622608208674;10924.836127457935;10980.341179529254;11092.223544351818;20704.48238794012;20727.79272207289;20750.48123796887;20780;21036.26373076935;7600.239976002355;7632.656530456032;7657.961710191414;8056.274935255738;8119.512829230147;4453.309736990772;4530.433695788027;4557.179707652588;4610.631149508032;4769.6661233714;3430.8627654894026;3506.24615707619;3528.9117772055906;3538.239278555123;3561.394562924309;638.5083485716066;646.1793522226745;660.6300471735843;660.725798793505;673.9224989126313;666.2637785247329;668.8963210702349;677.2482544375739;677.7255211639294;691.6368906324119;8735.301175905912;9149.359544831797;9174.357794954289;9272.30457715674;9449.622015119456;691.029104108728;691.7475121580687;697.6023666510142;708.553611224925;721.9566825990457;4314.56854314566;4480.14877173336;4481.5070342262325;4483.843065492757;4534.682572219979;92689.5365523168;92879;93139;94309;94461;50938.23592646113;57917.710411447675;66295.33704662988;69851.3014869855;81111;67918;68911.65544172247;69416.6529167351;71042.28957710564;71112.2888771116;9448.669296574586;9741;9788.314817962959;9878.209743220668;9935.20518358544;43909.341359878985;44963.55036449594;45040.54959450495;45182.54817451783;46160.30759538543;56659.43340566542;56804.43195567992;62896;63463.68268158814;65764;12274.140810143204;12578.30819304947;12628.368581570701;13156.210627362389;13419.664508387368;14414.927925360305;14431.494897678951;14733.116013039253;14768.966172367831;14825.258737062888;13402.0618556704;13724.862751372359;13808;13903.165810051429;15191.696166076837;13562.93218533901;13816.792748108586;13954.09298395601;14421.495247666282;14486;13298.867011329763;13756.105853119516;13765.242911639956;14044.438222470986;14500.057496262709;10573.577056917637;11352.148588856035;11663.358515281741;11791.587294444653;12144.696382590153;11722.531098756295;11797.587084452003;12420.627381178218;12537.373131343214;12623.621291361274 09:38:37 INFO - PROCESS | 3741 | __end_tp_report 09:38:37 INFO - PROCESS | 3741 | __start_cc_report 09:38:37 INFO - PROCESS | 3741 | _x_x_mozilla_cycle_collect,978 09:38:37 INFO - PROCESS | 3741 | __end_cc_report 09:38:37 INFO - PROCESS | 3741 | __startTimestamp1480441117002__endTimestamp 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | ------- Summary: start ------- 09:38:37 INFO - PROCESS | 3741 | Number of tests: 6 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | [#0] dojo.html Cycles:165 Average:5670.07 Median:5820.36 stddev:649.39 (11.2%) stddev-sans-first:622.22 09:38:37 INFO - PROCESS | 3741 | Values: 3216.9 3247.4 3259.4 3268.0 3278.0 5687.9 5733.1 5744.9 5763.5 5773.7 5707.4 5797.9 5805.2 5820.7 5846.3 5161.5 5198.0 5221.2 5256.7 5292.1 5039.6 5054.3 5297.3 5319.5 5332.8 5154.1 5160.5 5198.9 5215.0 5242.0 5256.7 5289.0 5337.3 5354.8 5362.8 5017.0 5115.6 5237.6 5243.4 5358.2 5602.9 5628.7 5635.7 5656.3 5667.4 6078.2 6157.8 6178.5 6181.9 6190.9 5838.6 5856.9 6230.6 6242.8 6252.8 5657.1 5659.7 5664.1 5696.7 5727.6 6224.7 6241.2 6252.7 6260.2 6267.2 5862.1 5925.6 5987.4 6011.5 6043.0 6059.2 6112.7 6136.8 6180.9 6191.3 6162.6 6167.1 6174.0 6174.9 6176.9 5941.0 6110.7 6183.8 6188.9 6191.7 4600.1 4612.7 4613.2 4623.6 4689.4 4158.8 4175.1 4176.6 4190.0 4206.3 5797.2 5801.9 5802.6 5804.2 5809.4 5890.4 5939.6 5950.7 5995.5 6124.9 5733.3 5733.8 5740.6 5746.4 5773.7 5195.9 5222.6 5225.3 5227.8 5238.4 6133.9 6151.9 6228.4 6252.8 6296.5 6106.7 6205.6 6208.3 6208.9 6209.7 6416.5 6420.3 6423.3 6434.1 6435.0 5766.0 5882.3 6068.7 6075.5 6079.2 5995.3 6058.9 6061.7 6097.5 6143.5 6020.8 6024.3 6030.4 6031.4 6043.9 5913.8 5982.6 5984.4 6002.6 6005.3 5757.6 5773.3 5806.4 5816.3 5820.4 5947.8 5952.9 5968.7 5980.6 5990.9 5692.0 5754.4 5759.9 5813.7 5826.5 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | [#1] ext.html Cycles:180 Average:59866.25 Median:37508.72 stddev:117250.15 (312.6%) stddev-sans-first:117494.56 09:38:37 INFO - PROCESS | 3741 | Values: 576.5 613.5 644.3 648.0 666.7 32304.2 32752.8 35288.6 42630.6 43155.6 45282.3 45304.8 45671.3 45674.0 45729.3 8695.2 8912.3 8935.9 8945.7 8950.0 8325.3 8505.4 8785.0 10349.1 10591.1 10713.3 10780.1 10780.8 10805.6 10816.6 10596.1 10682.0 10691.7 10696.3 10708.1 10573.4 10624.8 10638.7 10641.3 10652.6 42474.0 42595.8 42683.6 42710.1 42777.1 3568.0 3664.1 3692.6 3715.5 3913.8 31685.7 31736.4 32264.5 32292.2 32397.2 4284.9 4306.8 4394.5 4396.8 4535.9 332110.0 332326.0 332378.0 332604.0 332821.0 63115.7 63308.7 63625.0 63707.0 63781.0 37664.0 39016.0 39280.8 42178.4 42180.6 17085.6 17174.7 17184.0 17208.2 17210.7 12685.2 13955.4 14038.9 14074.5 14079.7 17987.4 19297.5 19983.8 20054.3 21094.3 7354.2 7381.3 7565.6 7655.0 7685.5 948.3 1053.5 1108.4 1138.4 1179.8 31926.7 33939.7 35098.6 35125.5 37707.4 1007.1 1096.8 1101.9 1152.3 1211.6 15873.7 18017.0 18108.3 18575.7 18710.0 520194.0 522185.0 522698.0 522918.0 523635.0 60150.4 60593.1 60716.0 60809.7 60854.0 1259.4 1325.2 1360.1 1394.4 1415.6 30096.0 34636.3 34676.0 34833.5 35028.9 51102.7 51798.5 51819.0 51868.7 51902.7 449545.0 452631.0 453408.0 453720.0 453792.0 29021.7 29463.0 30452.7 30894.0 31704.7 47936.3 47991.0 48157.3 48481.0 49275.5 37550.6 37956.2 38110.6 38830.2 38906.4 41242.2 41737.6 42030.0 42323.4 42676.6 41671.4 42326.4 42391.2 42971.4 43042.4 35854.5 37271.0 37334.8 37466.8 37701.6 28434.6 28596.7 28653.7 28767.6 28972.4 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | [#2] jquery.html Cycles:180 Average:29650.97 Median:22268.38 stddev:81319.21 (365.2%) stddev-sans-first:81517.68 09:38:37 INFO - PROCESS | 3741 | Values: 402.6 415.3 420.6 428.5 447.7 15030.5 19165.0 19582.8 20462.9 20672.9 19586.7 20287.7 20338.5 20478.8 20643.7 5598.9 5818.7 5827.8 5828.5 5830.7 5407.8 5707.0 5725.4 5744.1 5747.0 5723.4 5740.3 5741.9 5750.1 5752.3 5709.6 5957.0 5975.5 6042.3 6050.8 5126.4 5390.2 5880.1 5882.6 5894.5 14803.0 14945.4 18369.0 23678.8 24065.8 2381.4 2452.2 2483.1 2588.9 2859.4 10208.1 10606.5 10947.3 12879.9 14675.3 1919.4 1957.2 1962.9 1963.2 2020.6 84047.0 85694.6 86427.0 87785.0 89463.0 10050.1 10906.6 10952.5 11002.2 11299.3 14398.6 14652.9 15370.0 15398.2 15911.7 7839.0 8114.9 8165.3 8239.5 8279.1 8184.3 8190.2 8221.8 8224.9 8623.2 4461.2 4549.1 4727.1 4788.8 4995.3 1907.6 1929.6 1974.1 1974.7 1993.7 953.5 982.9 1009.6 1025.4 1101.2 19945.7 20492.5 20499.4 20551.5 20858.0 1002.8 1021.1 1023.0 1032.5 1033.6 10625.2 11425.2 11650.9 11719.2 11735.4 479892.0 483392.0 497774.0 498487.0 499358.0 92382.5 95509.0 95914.0 96939.5 98410.0 1019.5 1053.4 1062.2 1072.7 1076.9 17675.8 17822.6 18131.7 18229.5 18509.0 45059.0 45173.3 45362.5 45568.8 46593.1 59740.7 62283.0 62736.0 63824.0 64201.0 8352.7 8588.0 8815.0 8940.7 9474.2 12502.8 13514.7 13903.2 14053.4 14312.0 11163.6 11411.0 11496.0 11765.7 12225.2 11803.5 11839.7 12084.5 12250.3 12258.4 11767.9 11972.3 11983.9 12141.7 12612.2 9116.5 9140.6 9248.5 9264.7 9320.7 10640.4 11384.7 11461.9 11582.1 12114.8 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | [#3] mootools.html Cycles:180 Average:5898.92 Median:5327.10 stddev:3290.46 (61.8%) stddev-sans-first:3282.35 09:38:37 INFO - PROCESS | 3741 | Values: 1404.3 1507.5 1530.0 1677.9 1800.4 7769.3 8506.6 8850.2 8871.6 9086.3 8887.6 8967.5 8975.3 8981.1 8985.6 2425.9 2459.4 2460.8 2461.7 2462.1 2390.4 2463.7 2468.9 2469.8 2471.4 2404.0 2413.0 2456.4 2459.0 2459.0 2343.2 2359.4 2391.4 2396.2 2415.2 2385.2 2401.1 2428.0 2433.1 2436.4 8776.7 8841.5 8871.8 8888.0 8919.4 5162.6 5416.5 5425.8 5427.4 5428.9 3519.7 3595.3 3635.7 3699.0 3721.4 1174.1 1177.0 1207.4 1215.0 1224.2 12379.7 12401.6 12466.3 12477.1 12484.8 4313.0 4650.1 4654.4 4694.4 4740.7 9425.7 9433.1 9445.7 9450.1 9457.2 5323.5 5330.7 5334.5 5339.2 5351.1 4256.5 4426.1 4560.9 4564.6 5024.4 3921.1 3987.9 4107.7 4128.1 4134.0 1202.8 1214.6 1219.8 1220.6 1244.3 854.9 956.7 965.2 1009.9 1029.2 6152.5 6190.7 6199.6 6417.4 6502.4 951.2 966.8 989.9 999.8 1023.2 4122.8 4262.4 4365.3 4392.4 4404.1 10839.2 11173.2 11190.1 11255.2 11299.7 11130.6 11159.4 11264.3 11317.2 11336.2 8044.3 8329.5 8355.1 8467.9 8534.1 5867.9 6116.2 6116.3 6131.5 6431.2 9621.3 10376.5 10402.3 10426.0 10551.5 9537.5 9741.7 9868.3 10366.6 10465.0 8059.8 8150.3 8196.5 8222.5 8308.6 8428.4 8582.7 8593.1 8605.7 8611.0 7648.2 7707.5 7853.8 7957.2 7965.5 7651.8 7744.7 7747.4 7771.5 7836.6 7067.5 7154.3 7183.3 7186.9 7198.6 5380.7 5528.6 5536.9 5595.9 5640.9 5450.7 5525.6 5658.1 5662.7 5709.3 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | [#4] prototype.html Cycles:180 Average:4628.97 Median:5301.49 stddev:1325.02 (25.0%) stddev-sans-first:1289.13 09:38:37 INFO - PROCESS | 3741 | Values: 344.9 349.1 349.3 354.0 354.9 5333.2 5363.7 5374.9 5376.2 5376.9 5268.7 5290.2 5317.3 5338.9 5344.0 4058.5 4094.4 4106.3 4149.7 4177.7 4204.1 4206.6 4224.7 4255.7 4258.4 4189.1 4201.4 4201.7 4215.4 4222.6 3931.8 3933.6 4186.7 4186.9 4226.1 3681.4 3684.0 3685.4 3707.5 3709.2 5109.9 5113.7 5156.7 5161.0 5180.5 4528.4 4709.4 4750.4 4771.4 4780.9 5468.7 5484.6 5497.9 5504.5 5515.5 4067.8 4077.7 4087.2 4094.8 4097.7 5430.9 5673.9 5692.9 5715.7 5718.7 4133.7 4142.6 4150.4 4155.4 4175.5 4223.8 4233.2 4236.6 4239.9 4249.5 4511.6 4700.5 4790.0 4793.3 4795.2 5559.2 5574.2 5575.2 5576.3 5579.5 1400.4 1406.9 1412.8 1415.0 1416.4 967.4 1000.4 1000.7 1001.4 1024.1 5166.8 5249.4 5319.5 5441.0 5450.2 5693.3 5697.5 5710.0 5726.4 5734.2 5176.2 5384.4 5409.5 5438.6 5468.3 2896.5 2907.4 2909.2 2910.3 2911.4 5688.0 5689.0 5690.3 5703.7 5742.3 5305.9 5533.3 5537.1 5551.8 5588.7 5698.5 5706.5 5708.6 5710.7 5728.7 5128.3 5462.6 5496.3 5501.4 5536.6 5359.7 5381.9 5403.5 5413.9 5420.7 5636.3 5657.7 5686.9 5696.6 5793.4 3957.6 4024.6 4051.3 4053.4 4088.7 5426.1 5436.9 5462.6 5467.0 5491.9 5357.5 5363.4 5374.8 5383.8 5394.0 5072.7 5295.8 5310.6 5379.5 5396.3 5236.2 5247.4 5292.4 5301.3 5309.4 5301.7 5432.0 5436.5 5580.6 5585.8 5426.8 5446.0 5462.1 5469.6 5472.2 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - PROCESS | 3741 | [#5] yui.html Cycles:180 Average:17946.10 Median:4545.93 stddev:23480.05 (516.5%) stddev-sans-first:23510.34 09:38:37 INFO - PROCESS | 3741 | Values: 732.5 750.1 780.9 827.9 842.2 14921.7 15409.5 15797.4 15852.9 16110.8 14076.4 14417.6 14423.3 14426.0 14442.5 835.8 840.1 849.9 861.3 865.4 847.7 847.8 849.9 850.4 850.9 905.2 906.0 906.2 906.8 907.8 897.9 898.2 898.3 898.3 898.8 650.4 654.8 655.9 656.7 657.5 14367.6 14652.6 14728.7 14795.1 14842.9 11398.4 13699.4 14485.4 14681.5 14703.6 10782.9 10876.8 11030.5 11388.1 11449.3 3764.8 3781.3 3792.8 3819.0 3870.9 65067.0 66618.0 67624.7 67707.3 68324.7 10733.2 10782.6 10924.8 10980.3 11092.2 20704.5 20727.8 20750.5 20780.0 21036.3 7600.2 7632.7 7658.0 8056.3 8119.5 4453.3 4530.4 4557.2 4610.6 4769.7 3430.9 3506.2 3528.9 3538.2 3561.4 638.5 646.2 660.6 660.7 673.9 666.3 668.9 677.2 677.7 691.6 8735.3 9149.4 9174.4 9272.3 9449.6 691.0 691.7 697.6 708.6 722.0 4314.6 4480.1 4481.5 4483.8 4534.7 92689.5 92879.0 93139.0 94309.0 94461.0 50938.2 57917.7 66295.3 69851.3 81111.0 67918.0 68911.7 69416.7 71042.3 71112.3 9448.7 9741.0 9788.3 9878.2 9935.2 43909.3 44963.6 45040.5 45182.5 46160.3 56659.4 56804.4 62896.0 63463.7 65764.0 12274.1 12578.3 12628.4 13156.2 13419.7 14414.9 14431.5 14733.1 14769.0 14825.3 13402.1 13724.9 13808.0 13903.2 15191.7 13562.9 13816.8 13954.1 14421.5 14486.0 13298.9 13756.1 13765.2 14044.4 14500.1 10573.6 11352.1 11663.4 11791.6 12144.7 11722.5 11797.6 12420.6 12537.4 12623.6 09:38:37 INFO - PROCESS | 3741 | -------- Summary: end -------- 09:38:37 INFO - PROCESS | 3741 | 09:38:37 INFO - TEST-INFO | 3741: exit 0 09:38:37 INFO - TEST-OK | dromaeo_css | took 1116336ms 09:38:37 INFO - TEST-START | kraken 09:38:37 INFO - operating with platform_type : linux_ 09:38:37 INFO - Initialising browser for kraken test... 09:38:37 INFO - TEST-INFO | started process 4057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI8AItN/profile http://localhost:49993/getInfo.html) 09:38:42 INFO - PROCESS | 4057 | __metrics Screen width/height:1600/1200 09:38:42 INFO - PROCESS | 4057 | colorDepth:24 09:38:42 INFO - PROCESS | 4057 | Browser inner width/height: 1024/697 09:38:42 INFO - PROCESS | 4057 | __metrics 09:38:42 INFO - PROCESS | 4057 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:42 INFO - PROCESS | 4057 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:43 INFO - PROCESS | 4057 | console.error: PushService: 09:38:43 INFO - PROCESS | 4057 | stateChangeProcessEnqueue: Error transitioning state 09:38:43 INFO - PROCESS | 4057 | UnknownError 09:38:43 INFO - TEST-INFO | 4057: exit 0 09:38:43 INFO - Browser initialized. 09:38:43 INFO - Running cycle 1/1 for kraken test... 09:38:43 INFO - TEST-INFO | started process 4149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI8AItN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:55 INFO - PROCESS | 4149 | RSS: Main: 144523264 09:38:55 INFO - PROCESS | 4149 | 09:38:58 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49993/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:59 INFO - PROCESS | 4149 | RSS: Main: 186646528 09:38:59 INFO - PROCESS | 4149 | 09:39:01 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49993/tests/kraken/driver.html?testName=audio-dft) 09:39:02 INFO - PROCESS | 4149 | RSS: Main: 176738304 09:39:02 INFO - PROCESS | 4149 | 09:39:05 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49993/tests/kraken/driver.html?testName=audio-fft) 09:39:05 INFO - PROCESS | 4149 | RSS: Main: 267464704 09:39:05 INFO - PROCESS | 4149 | 09:39:07 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49993/tests/kraken/driver.html?testName=audio-oscillator) 09:39:08 INFO - PROCESS | 4149 | RSS: Main: 173387776 09:39:08 INFO - PROCESS | 4149 | 09:39:10 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:10 INFO - PROCESS | 4149 | RSS: Main: 175988736 09:39:10 INFO - PROCESS | 4149 | 09:39:13 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49993/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:14 INFO - PROCESS | 4149 | RSS: Main: 214519808 09:39:14 INFO - PROCESS | 4149 | 09:39:17 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49993/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:18 INFO - PROCESS | 4149 | RSS: Main: 213405696 09:39:18 INFO - PROCESS | 4149 | 09:39:21 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49993/tests/kraken/driver.html?testName=json-parse-financial) 09:39:21 INFO - PROCESS | 4149 | RSS: Main: 212410368 09:39:21 INFO - PROCESS | 4149 | 09:39:23 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:23 INFO - PROCESS | 4149 | RSS: Main: 174600192 09:39:23 INFO - PROCESS | 4149 | 09:39:25 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:26 INFO - PROCESS | 4149 | RSS: Main: 181886976 09:39:26 INFO - PROCESS | 4149 | 09:39:28 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:28 INFO - PROCESS | 4149 | RSS: Main: 190865408 09:39:28 INFO - PROCESS | 4149 | 09:39:31 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:31 INFO - PROCESS | 4149 | RSS: Main: 199036928 09:39:31 INFO - PROCESS | 4149 | 09:39:34 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:35 INFO - PROCESS | 4149 | RSS: Main: 195641344 09:39:35 INFO - PROCESS | 4149 | 09:39:36 INFO - PROCESS | 4149 | Cycle 1(1): loaded http://localhost:49993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49993/tests/kraken/driver.html?testName=ai-astar) 09:39:37 INFO - PROCESS | 4149 | RSS: Main: 247472128 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | __start_tp_report 09:39:37 INFO - PROCESS | 4149 | _x_x_mozilla_page_load 09:39:37 INFO - PROCESS | 4149 | _x_x_mozilla_page_load_details 09:39:37 INFO - PROCESS | 4149 | |i|pagename|runs| 09:39:37 INFO - PROCESS | 4149 | |0;ai-astar;102;112;111;111;112;110;110;111;109;110 09:39:37 INFO - PROCESS | 4149 | |1;audio-beat-detection;150;122;123;162;121;122;122;120;149;128 09:39:37 INFO - PROCESS | 4149 | |2;audio-dft;163;159;161;160;161;162;162;160;161;162 09:39:37 INFO - PROCESS | 4149 | |3;audio-fft;74;76;75;115;75;76;76;76;98;76 09:39:37 INFO - PROCESS | 4149 | |4;audio-oscillator;82;81;113;83;82;82;99;83;82;114 09:39:37 INFO - PROCESS | 4149 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;118;117;117 09:39:37 INFO - PROCESS | 4149 | |6;imaging-darkroom;147;146;146;146;146;147;147;146;147;146 09:39:37 INFO - PROCESS | 4149 | |7;imaging-desaturate;84;84;85;85;84;84;84;85;85;86 09:39:37 INFO - PROCESS | 4149 | |8;json-parse-financial;53;55;53;49;51;51;52;50;51;50 09:39:37 INFO - PROCESS | 4149 | |9;json-stringify-tinderbox;59;60;60;59;61;60;60;60;60;60 09:39:37 INFO - PROCESS | 4149 | |10;stanford-crypto-aes;77;77;75;77;76;91;76;80;80;78 09:39:37 INFO - PROCESS | 4149 | |11;stanford-crypto-ccm;126;126;131;128;124;127;126;125;168;125 09:39:37 INFO - PROCESS | 4149 | |12;stanford-crypto-pbkdf2;156;157;155;154;156;159;158;154;160;155 09:39:37 INFO - PROCESS | 4149 | |13;stanford-crypto-sha256-iterative;62;62;63;61;62;62;62;60;61;64 09:39:37 INFO - PROCESS | 4149 | __end_tp_report 09:39:37 INFO - PROCESS | 4149 | __start_cc_report 09:39:37 INFO - PROCESS | 4149 | _x_x_mozilla_cycle_collect,1619 09:39:37 INFO - PROCESS | 4149 | __end_cc_report 09:39:37 INFO - PROCESS | 4149 | __startTimestamp1480441177097__endTimestamp 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | ------- Summary: start ------- 09:39:37 INFO - PROCESS | 4149 | Number of tests: 14 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.90 (2.6%) stddev-sans-first:1.00 09:39:37 INFO - PROCESS | 4149 | Values: 102.0 112.0 111.0 111.0 112.0 110.0 110.0 111.0 109.0 110.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:125.50 stddev:15.55 (12.4%) stddev-sans-first:15.05 09:39:37 INFO - PROCESS | 4149 | Values: 150.0 122.0 123.0 162.0 121.0 122.0 122.0 120.0 149.0 128.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.05 09:39:37 INFO - PROCESS | 4149 | Values: 163.0 159.0 161.0 160.0 161.0 162.0 162.0 160.0 161.0 162.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:13.69 (18.0%) stddev-sans-first:14.23 09:39:37 INFO - PROCESS | 4149 | Values: 74.0 76.0 75.0 115.0 75.0 76.0 76.0 76.0 98.0 76.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.42 (16.4%) stddev-sans-first:13.91 09:39:37 INFO - PROCESS | 4149 | Values: 82.0 81.0 113.0 83.0 82.0 82.0 99.0 83.0 82.0 114.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:39:37 INFO - PROCESS | 4149 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:39:37 INFO - PROCESS | 4149 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 09:39:37 INFO - PROCESS | 4149 | Values: 84.0 84.0 85.0 85.0 84.0 84.0 84.0 85.0 85.0 86.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.78 (3.5%) stddev-sans-first:1.80 09:39:37 INFO - PROCESS | 4149 | Values: 53.0 55.0 53.0 49.0 51.0 51.0 52.0 50.0 51.0 50.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 09:39:37 INFO - PROCESS | 4149 | Values: 59.0 60.0 60.0 59.0 61.0 60.0 60.0 60.0 60.0 60.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:77.50 stddev:4.62 (6.0%) stddev-sans-first:4.86 09:39:37 INFO - PROCESS | 4149 | Values: 77.0 77.0 75.0 77.0 76.0 91.0 76.0 80.0 80.0 78.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:126.50 stddev:13.28 (10.5%) stddev-sans-first:13.99 09:39:37 INFO - PROCESS | 4149 | Values: 126.0 126.0 131.0 128.0 124.0 127.0 126.0 125.0 168.0 125.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:156.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 09:39:37 INFO - PROCESS | 4149 | Values: 156.0 157.0 155.0 154.0 156.0 159.0 158.0 154.0 160.0 155.0 09:39:37 INFO - PROCESS | 4149 | 09:39:37 INFO - PROCESS | 4149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 09:39:37 INFO - PROCESS | 4149 | Values: 62.0 62.0 63.0 61.0 62.0 62.0 62.0 60.0 61.0 64.0 09:39:37 INFO - PROCESS | 4149 | -------- Summary: end -------- 09:39:37 INFO - PROCESS | 4149 | 09:39:38 INFO - TEST-INFO | 4149: exit 0 09:39:38 INFO - TEST-OK | kraken | took 60354ms 09:39:38 INFO - SUITE-END | took 1176s 09:39:38 INFO - Completed test suite (00:19:36) 09:39:38 INFO - javascript benchmark 09:39:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3216.9195770105744, 3247.3667634811222, 3259.445894197986, 3267.9673203267967, 3277.9672203277973, 5687.886242275157, 5733.111367737997, 5744.942550574493, 5763.5389168866495, 5773.682447465388, 5707.429257074291, 5797.855053623662, 5805.24531810864, 5820.679862607565, 5846.298444186704, 5161.458046905077, 5197.974010129953, 5221.190715439113, 5256.710880901549, 5292.073887069767, 5039.571636410909, 5054.292399064134, 5297.337832770903, 5319.5478384337375, 5332.786688532454, 5154.098032844256, 5160.483951604847, 5198.896022079556, 5214.973925130369, 5242.0, 5256.737163141846, 5289.0, 5337.306150200449, 5354.839354819362, 5362.8123015694655, 5016.974915125437, 5115.616328775357, 5237.607179461517, 5243.370795504526, 5358.223057656618, 5602.943970560324, 5628.71856407178, 5635.71821408932, 5656.349519805234, 5667.433256674341, 6078.240219972504, 6157.7536898524, 6178.536609754242, 6181.907271390933, 6190.876182476325, 5838.591298609099, 5856.853578660525, 6230.59501132425, 6242.781502647385, 6252.843678908018, 5657.066584013674, 5659.745311460994, 5664.0937450007805, 5696.715164241771, 5727.599068065196, 6224.719887605069, 6241.188645476059, 6252.6873656317, 6260.217472815898, 6267.185265915402, 5862.062070068769, 5925.614835035709, 5987.431194036647, 6011.519078473799, 6043.0, 6059.242594675666, 6112.716259964451, 6136.846578835475, 6180.907286390708, 6191.318954914956, 6162.599431037058, 6167.136600875881, 6173.96913015441, 6174.876502469925, 6176.938230617637, 5941.0, 6110.664716950083, 6183.84540386494, 6188.8762224755255, 6191.659458729813, 4600.079984003212, 4612.7462989535225, 4613.2388155953895, 4623.583877451046, 4689.43726752785, 4158.8336466540995, 4175.081482073939, 4176.644985176294, 4190.015346393595, 4206.305959516645, 5797.159411885337, 5801.8549536261935, 5802.622829516068, 5804.187413762077, 5809.419058094157, 5890.3815099414805, 5939.613925094855, 5950.67271300074, 5995.52035837132, 6124.877502449926, 5733.254676891977, 5733.799317023884, 5740.569457290637, 5746.42535746422, 5773.653580785166, 5195.922061169085, 5222.55608273301, 5225.3207083079715, 5227.790888364499, 5238.397584277781, 6133.938660613426, 6151.876962460815, 6228.377162283736, 6252.812415627538, 6296.496280297657, 6106.6946652668075, 6205.596636218631, 6208.317085120723, 6208.937910621016, 6209.658468784261, 6416.45460135875, 6420.325865784025, 6423.29343772194, 6434.131392262172, 6434.967825160844, 5766.0, 5882.294124704892, 6068.666223357758, 6075.453209211192, 6079.209702738615, 5995.310539287863, 6058.939410605837, 6061.696915154136, 6097.451229389376, 6143.511877689543, 6020.819375418744, 6024.277086749618, 6030.396960303934, 6031.396860313934, 6043.909341359795, 5913.763449461973, 5982.611130276518, 5984.371640977634, 6002.609830361012, 6005.279366476051, 5757.625754325955, 5773.336066352255, 5806.390329015392, 5816.272965879265, 5820.359760426434, 5947.791827286024, 5952.910706339495, 5968.731407086779, 5980.5514586405325, 5990.850228744316, 5692.032354499828, 5754.395788442153, 5759.94240057594, 5813.738381772915, 5826.504747096375], "value": 5625.649740136625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.5272476569212, 613.4540259169339, 644.3105876711917, 647.9935200647992, 666.6733300682668, 32304.192395190104, 32752.836235818817, 35288.64711352882, 42630.57369426305, 43155.56844431555, 45282.320765188466, 45304.77347613266, 45671.31493027607, 45674.0, 45729.31406028912, 8695.217430431276, 8912.287017038621, 8935.910640893573, 8945.73162805117, 8950.0, 8325.333973282153, 8505.404621676485, 8785.0, 10349.120324772404, 10591.099756520705, 10713.303635263723, 10780.083692886114, 10780.838287425695, 10805.621803236889, 10816.621418250363, 10596.099331556788, 10682.038616524473, 10691.732706682318, 10696.304740191941, 10708.089812365959, 10573.418461984587, 10624.840627390595, 10638.680839574825, 10641.255112142153, 10652.62715804943, 42474.0, 42595.787021064694, 42683.57316426827, 42710.14579708388, 42777.144457110684, 3567.982160089183, 3664.120611053355, 3692.6307369263127, 3715.516982792247, 3913.7651740895635, 31685.683143168735, 31736.365272694416, 32264.516032259537, 32292.192695182574, 32397.190070248198, 4284.914301713949, 4306.849260275875, 4394.516603173648, 4396.824127034914, 4535.863924082283, 332110.0, 332326.0, 332378.0, 332604.0, 332821.0, 63115.68442157852, 63308.683456582425, 63625.0, 63707.0, 63781.0, 37664.0, 39016.0, 39280.80359598184, 42178.36732449016, 42180.57819421828, 17085.572860678334, 17174.74237886433, 17184.0, 17208.225629846685, 17210.655786884192, 12685.175463594836, 13955.441782328593, 14038.85961140396, 14074.507392241427, 14079.718405632035, 17987.370442034466, 19297.51756206078, 19983.800161998486, 20054.298099566444, 21094.261700840398, 7354.154272258758, 7381.335679788845, 7565.6217189140325, 7654.96172519145, 7685.5004424712215, 948.2982592881356, 1053.5417093564324, 1108.4402376799665, 1138.4137169357787, 1179.7699448607439, 31926.680733192836, 33939.66060339365, 35098.64901350954, 35125.47311790325, 37707.434388484195, 1007.1288335589662, 1096.7970925378831, 1101.9173561982884, 1152.3374059915413, 1211.5820042085466, 15873.68252634964, 18017.045312539158, 18108.275668973092, 18575.72136417955, 18710.0, 520194.0, 522185.0, 522698.0, 522918.0, 523635.0, 60150.39849601448, 60593.09110363348, 60716.0, 60809.695951519956, 60854.0, 1259.3954901647078, 1325.2313658078292, 1360.081944687332, 1394.4422231107637, 1415.610707055568, 30096.0, 34636.307273853876, 34676.0, 34833.47749783705, 35028.88852457331, 51102.74448627733, 51798.48201517937, 51819.0, 51868.740656296475, 51902.74048629884, 449545.0, 452631.0, 453408.0, 453720.0, 453792.0, 29021.7097829019, 29463.0, 30452.695473044987, 30894.0, 31704.682953171097, 47936.28095578639, 47990.97898922717, 48157.27764083471, 48481.0, 49275.50724492709, 37550.62449375581, 37956.24087518289, 38110.61889381071, 38830.2233955325, 38906.4164037534, 41242.17540050563, 41737.58262417458, 42030.0, 42323.365149522164, 42676.573234267256, 41671.37492937669, 42326.36510452284, 42391.15217695691, 42971.35542966796, 43042.35436468518, 35854.46218306675, 37271.0, 37334.81332593429, 37466.81266593649, 37701.62298377091, 28434.57348139821, 28596.714032859407, 28653.713462865937, 28767.568486473137, 28972.420551588428], "value": 20584.889745883724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.5591976785419, 415.279490084703, 420.5710175620867, 428.4793975319986, 447.72688659917446, 15030.473933412333, 19165.0, 19582.804171958294, 20462.89768551155, 20672.896635516838, 19586.70619940702, 20287.695684564707, 20338.491537711565, 20478.795212047877, 20643.69034464484, 5598.860028499279, 5818.679972601505, 5827.796027139051, 5828.533717302626, 5830.679312637824, 5407.783688652449, 5706.971465142689, 5725.370209276976, 5744.138379243105, 5746.9712651436685, 5723.399043100477, 5740.311162660487, 5741.885162296751, 5750.079987202049, 5752.28096487939, 5709.571782116337, 5957.0, 5975.462208401243, 6042.305134909498, 6050.757969681207, 5126.384833819965, 5390.245365648812, 5880.147378630118, 5882.617629854089, 5894.4989675877605, 14803.0378025428, 14945.40218391263, 18368.98970556619, 23678.763212367827, 24065.759342406527, 2381.38084098134, 2452.2152911068465, 2483.081259933818, 2588.909388171424, 2859.442408730298, 10208.132308753764, 10606.52270647815, 10947.34315941046, 12879.871201288055, 14675.26623668823, 1919.3953904520172, 1957.2073310309347, 1962.8527860410527, 1963.1558429875147, 2020.595880823841, 84047.0, 85694.57152714259, 86427.0, 87784.99999999936, 89463.0, 10050.145737612385, 10906.563737450571, 10952.507137178845, 11002.174836887265, 11299.322040677585, 14398.568042958728, 14652.926735366467, 15370.0, 15398.15310157952, 15911.681766364607, 7838.960805195938, 8114.8782768258525, 8165.265126138676, 8239.546824924566, 8279.089300176976, 8184.345252379914, 8190.180981901882, 8221.83556328882, 8224.876626850602, 8623.223909848019, 4461.174682683714, 4549.09018196362, 4727.125481785881, 4788.760561971888, 4995.275685025651, 1907.5707965707882, 1929.5947850951177, 1974.0820518458697, 1974.6544354737864, 1993.7109119177637, 953.4517652349926, 982.9066238707311, 1009.5608410341525, 1025.4411345816548, 1101.2181351240708, 19945.700814487795, 20492.487687807625, 20499.38501844947, 20551.4862128445, 20858.0, 1002.7944271424486, 1021.0912288063629, 1022.9693109206736, 1032.5461331844967, 1033.6227277043974, 10625.203109766799, 11425.2002359834, 11650.88349116515, 11719.179657424069, 11735.41322933867, 479892.0, 483392.0, 497774.0, 498487.0, 499358.0, 92382.53808731047, 95509.0, 95914.0, 96939.51530242445, 98410.0, 1019.4902548725637, 1053.357451954292, 1062.2245760594808, 1072.7425417899804, 1076.9246152769388, 17675.823241767932, 17822.5544361392, 18131.728024079912, 18229.54426139357, 18509.0, 45059.0, 45173.32240016468, 45362.546374535836, 45568.772156139006, 46593.06813863772, 59740.70129649324, 62283.0, 62736.0, 63824.0, 64201.0, 8352.665893364197, 8588.0, 8814.955925220333, 8940.68707595231, 9474.24206063527, 12502.812457812957, 13514.729705406033, 13903.165810051429, 14053.437862485795, 14312.0, 11163.553457861919, 11411.0, 11496.0, 11765.705857353292, 12225.205361651464, 11803.468843901874, 11839.704007399883, 12084.516619335129, 12250.264984100626, 12258.448369823202, 11767.882321177021, 11972.281663100242, 11983.880161198276, 12141.69645758863, 12612.180208286432, 9116.498592577473, 9140.63437462494, 9248.491332976751, 9264.675736349196, 9320.72037838866, 10640.361578305326, 11384.658460246206, 11461.885381146416, 11582.07343412508, 12114.818277726017], "value": 9466.853265572703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.3189053309136, 1507.5402002389267, 1530.033906430237, 1677.882548221625, 1800.3788692900953, 7769.261920117587, 8506.574671266435, 8850.159234872677, 8871.600777964999, 9086.273098152149, 8887.644494220223, 8967.461952282867, 8975.326850486206, 8981.146791054856, 8985.550722463884, 2425.86657733825, 2459.446624509489, 2460.8400453970435, 2461.716902556202, 2462.064415522099, 2390.4422069596158, 2463.716672582658, 2468.888899999495, 2469.80241580674, 2471.3574470637673, 2403.960868527797, 2412.95174096518, 2456.3736247256925, 2459.0286836699493, 2459.0286836699493, 2343.238447504568, 2359.4337359033707, 2391.3782416571644, 2396.209250947183, 2415.2029830156007, 2385.2367242482414, 2401.087586717036, 2427.9757202427927, 2433.148398060682, 2436.439618887648, 8776.692815751418, 8841.513716745576, 8871.822563548758, 8888.0, 8919.42023768453, 5162.638615296931, 5416.51251387377, 5425.782968681248, 5427.43011983744, 5428.891422171574, 3519.6832285094465, 3595.2989167112423, 3635.6909662678704, 3698.9815050924844, 3721.441783732435, 1174.0900801878527, 1176.9882301176965, 1207.408369898752, 1214.9574764883187, 1224.2287358963886, 12379.690507737288, 12401.62795116148, 12466.252024878537, 12477.064220183522, 12484.812727809, 4312.956870431318, 4650.093231819763, 4654.418197725285, 4694.389729335233, 4740.715557066587, 9425.670101546413, 9433.103855133751, 9445.716628501155, 9450.149486546245, 9457.243420526342, 5323.494268044529, 5330.706811125426, 5334.546563542065, 5339.172428273624, 5351.143816989263, 4256.5105012923295, 4426.092651006536, 4560.885977850514, 4564.589186973189, 5024.447310795809, 3921.058945852975, 3987.900302492461, 4107.67138628909, 4128.050548373831, 4133.9793301033305, 1202.8255902894032, 1214.5931113077042, 1219.810929305959, 1220.560598184653, 1244.3467179730715, 854.9007508994263, 956.7034219392011, 965.1554889471712, 1009.9394036357695, 1029.1869423155772, 6152.507799376039, 6190.690465476709, 6199.628022318675, 6417.422431981051, 6502.414782669488, 951.1879868849852, 966.8018056298442, 989.8663680403198, 999.7950420163849, 1023.2195978996492, 4122.814473348706, 4262.403263543107, 4365.301551751704, 4392.407025051641, 4404.1411924674385, 10839.187060970458, 11173.162012848907, 11190.104791616652, 11255.212135150625, 11299.717507062389, 11130.610428634958, 11159.442027898573, 11264.267822591506, 11317.207795454238, 11336.206465547497, 8044.2760151586635, 8329.5418751968, 8355.122712115262, 8467.872981905277, 8534.103919088406, 5867.911981320198, 6116.204893364013, 6116.3272040076445, 6131.509479241561, 6431.163948686641, 9621.27840411986, 10376.533056012346, 10402.323848949794, 10426.0, 10551.472426378803, 9537.47543885093, 9741.659041933783, 9868.259880509135, 10366.585336586753, 10465.0, 8059.798505037421, 8150.3072238857985, 8196.50820950721, 8222.465539739898, 8308.584570771316, 8428.367872409472, 8582.699605514026, 8593.140685931607, 8605.741827745178, 8610.956945215234, 7648.158702542604, 7707.499012564165, 7853.842923141619, 7957.244061814118, 7965.4822436541435, 7651.846963060819, 7744.728934487266, 7747.418943579141, 7771.533707977539, 7836.608169591612, 7067.5052746307265, 7154.284571542804, 7183.317584829433, 7186.928130718626, 7198.6040767756185, 5380.677159370451, 5528.640638358494, 5536.889262214652, 5595.8880822384135, 5640.943590564042, 5450.700211488406, 5525.640833345819, 5658.066419040977, 5662.716864156858, 5709.25779648643], "value": 4747.321589013553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.936186805441, 349.13066464503396, 349.3153419298175, 354.0264273248566, 354.89885382665943, 5333.226682131089, 5363.704996225206, 5374.865628359293, 5376.193570964358, 5376.865578360543, 5268.710220937847, 5290.232916227144, 5317.2821669074665, 5338.893222135555, 5343.984642917843, 4058.4521089652962, 4094.3858421236755, 4106.322456794625, 4149.730267532601, 4177.749335039907, 4204.11713540157, 4206.621404073633, 4224.704270701052, 4255.723377980421, 4258.403823464718, 4189.07840275139, 4201.39079833424, 4201.70588058836, 4215.430916826235, 4222.619964203221, 3931.783751893645, 3933.567307596162, 4186.706930514865, 4186.890474024386, 4226.112516371566, 3681.4109742441346, 3684.0, 3685.4103343464917, 3707.4624179494094, 3709.239605880788, 5109.9489005109845, 5113.718745468997, 5156.716380599066, 5160.974195129001, 5180.48195180479, 4528.43394575678, 4709.434867815884, 4750.406199225097, 4771.421433924556, 4780.856574302777, 5468.72656367184, 5484.561235101182, 5497.945020549823, 5504.504594586467, 5515.531179849718, 4067.796610169509, 4077.673786097105, 4087.202995415895, 4094.754314741125, 4097.692673049503, 5430.91853622196, 5673.914891276634, 5692.943070569283, 5715.742791574389, 5718.714064296769, 4133.739209541059, 4142.606452387018, 4150.3566947123245, 4155.397467367215, 4175.457190565267, 4223.796218077833, 4233.238017156879, 4236.555161707976, 4239.918820700702, 4249.46881639795, 4511.6014035648395, 4700.482946875841, 4790.0, 4793.257045158006, 4795.18481858078, 5559.193916882029, 5574.247476590608, 5575.1915972184615, 5576.302962129734, 5579.525740312119, 1400.4175281931352, 1406.8804151647225, 1412.8304603447652, 1414.957551273443, 1416.390951890697, 967.3712087143413, 1000.4197565412044, 1000.6797824696027, 1001.4241810958728, 1024.1243736605245, 5166.844994650167, 5249.42256351801, 5319.547838433777, 5440.986834871044, 5450.209719590637, 5693.28833895763, 5697.544196464273, 5709.972959599366, 5726.398728133569, 5734.168545560954, 5176.171812509981, 5384.353877534721, 5409.513143817076, 5438.564914806806, 5468.26178465902, 2896.493113705093, 2907.433050555164, 2909.2145120817686, 2910.272431892027, 2911.3696330055236, 5688.004599195125, 5688.9759843227785, 5690.264469336809, 5703.686297253608, 5742.28221472316, 5305.893882122413, 5533.3083364579425, 5537.065355361665, 5551.805686800943, 5588.720563971785, 5698.544116470673, 5706.4864162225595, 5708.571857110816, 5710.65736055838, 5728.656280623176, 5128.333316668809, 5462.644928079662, 5496.300662933294, 5501.441829549119, 5536.58817001662, 5359.678419294854, 5381.892362152813, 5403.5136837684795, 5413.891722165614, 5420.674759514442, 5636.323641163087, 5657.688827114548, 5686.857828554319, 5696.601237913306, 5793.406813126424, 3957.6240257176673, 4024.577419370924, 4051.311277082844, 4053.3919912012257, 4088.672906167559, 5426.050441172858, 5436.891262174655, 5462.596457558661, 5467.0, 5491.897078150832, 5357.544608708147, 5363.383210930637, 5374.785008599612, 5383.838484845461, 5393.9730301348245, 5072.681102913195, 5295.828710228788, 5310.601704872072, 5379.488948549882, 5396.325459317585, 5236.245857637734, 5247.4490178530705, 5292.417834038176, 5301.296338867129, 5309.36287645485, 5301.6818990860675, 5431.972840135774, 5436.510714035756, 5580.581456390706, 5585.82152960354, 5426.8371948841595, 5445.972770136124, 5462.071447853954, 5469.589780766379, 5472.2065300531995], "value": 4214.781707279087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5275197497617, 750.114864459937, 780.8984831971843, 827.9461834980726, 842.2461896602539, 14921.701565968688, 15409.46066887659, 15797.368105275775, 15852.920735396321, 16110.838891611109, 14076.436942522287, 14417.639559011004, 14423.278836058182, 14426.0, 14442.494512692032, 835.7952301686096, 840.1304649687575, 849.8512760266959, 861.336770686571, 865.3639574912465, 847.6778824046853, 847.7583888591753, 849.9447535910177, 850.4259624753298, 850.9446885952424, 905.1943770044666, 906.0169715858269, 906.1618003346911, 906.8458362078462, 907.8184363127401, 897.8967418746862, 898.23201163006, 898.27239935652, 898.3442087276293, 898.7932775461647, 650.3561474140566, 654.8035589323232, 655.9278479367266, 656.711047139262, 657.5462930577886, 14367.568972930725, 14652.633684157874, 14728.705425891421, 14795.112293262331, 14842.851571484363, 11398.430078496125, 13699.383527741276, 14485.42058317666, 14681.48614798477, 14703.63240918975, 10782.946085269523, 10876.782464350668, 11030.50362733671, 11388.14588905827, 11449.255798373162, 3764.811759412046, 3781.2800709986946, 3792.7724336539895, 3818.961810381916, 3870.8645197418236, 65067.0, 66618.0, 67624.66187669079, 67707.32292677059, 68324.65837670829, 10733.195010374253, 10782.622608208674, 10924.836127457935, 10980.341179529254, 11092.223544351818, 20704.48238794012, 20727.79272207289, 20750.48123796887, 20780.0, 21036.26373076935, 7600.239976002355, 7632.656530456032, 7657.961710191414, 8056.274935255738, 8119.512829230147, 4453.309736990772, 4530.433695788027, 4557.179707652588, 4610.631149508032, 4769.6661233714, 3430.8627654894026, 3506.24615707619, 3528.9117772055906, 3538.239278555123, 3561.394562924309, 638.5083485716066, 646.1793522226745, 660.6300471735843, 660.725798793505, 673.9224989126313, 666.2637785247329, 668.8963210702349, 677.2482544375739, 677.7255211639294, 691.6368906324119, 8735.301175905912, 9149.359544831797, 9174.357794954289, 9272.30457715674, 9449.622015119456, 691.029104108728, 691.7475121580687, 697.6023666510142, 708.553611224925, 721.9566825990457, 4314.56854314566, 4480.14877173336, 4481.5070342262325, 4483.843065492757, 4534.682572219979, 92689.5365523168, 92879.0, 93139.0, 94309.0, 94461.0, 50938.23592646113, 57917.710411447675, 66295.33704662988, 69851.3014869855, 81111.0, 67918.0, 68911.65544172247, 69416.6529167351, 71042.28957710564, 71112.2888771116, 9448.669296574586, 9741.0, 9788.314817962959, 9878.209743220668, 9935.20518358544, 43909.341359878985, 44963.55036449594, 45040.54959450495, 45182.54817451783, 46160.30759538543, 56659.43340566542, 56804.43195567992, 62896.0, 63463.68268158814, 65764.0, 12274.140810143204, 12578.30819304947, 12628.368581570701, 13156.210627362389, 13419.664508387368, 14414.927925360305, 14431.494897678951, 14733.116013039253, 14768.966172367831, 14825.258737062888, 13402.0618556704, 13724.862751372359, 13808.0, 13903.165810051429, 15191.696166076837, 13562.93218533901, 13816.792748108586, 13954.09298395601, 14421.495247666282, 14486.0, 13298.867011329763, 13756.105853119516, 13765.242911639956, 14044.438222470986, 14500.057496262709, 10573.577056917637, 11352.148588856035, 11663.358515281741, 11791.587294444653, 12144.696382590153, 11722.531098756295, 11797.587084452003, 12420.627381178218, 12537.373131343214, 12623.621291361274], "value": 7295.350579318933, "unit": "score"}], "name": "dromaeo_css", "value": 7368.406207111285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 112.0, 110.0, 110.0, 111.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 123.0, 162.0, 121.0, 122.0, 122.0, 120.0, 149.0, 128.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 161.0, 160.0, 161.0, 162.0, 162.0, 160.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 115.0, 75.0, 76.0, 76.0, 76.0, 98.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 113.0, 83.0, 82.0, 82.0, 99.0, 83.0, 82.0, 114.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 49.0, 51.0, 51.0, 52.0, 50.0, 51.0, 50.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 77.0, 76.0, 91.0, 76.0, 80.0, 80.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 131.0, 128.0, 124.0, 127.0, 126.0, 125.0, 168.0, 125.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 155.0, 154.0, 156.0, 159.0, 158.0, 154.0, 160.0, 155.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 62.0, 62.0, 62.0, 60.0, 61.0, 64.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1461.9, "alertThreshold": 2.0}]} 09:39:38 INFO - Return code: 0 09:39:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:38 INFO - # TBPL SUCCESS # 09:39:38 INFO - Running post-action listener: _resource_record_post_action 09:39:38 INFO - [mozharness: 2016-11-29 17:39:38.392916Z] Finished run-tests step (success) 09:39:38 INFO - Running post-run listener: _resource_record_post_run 09:39:38 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370958336; Read time: 16; Write time: 403500 09:39:38 INFO - TinderboxPrint: CPU usage
13.0% 09:39:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:39:38 INFO - TinderboxPrint: I/O write bytes / time
370,958,336 / 403,500 09:39:38 INFO - TinderboxPrint: CPU idle
8,287.4 (87.0%) 09:39:38 INFO - TinderboxPrint: CPU user
1,193.0 (12.5%) 09:39:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108208128; Read time: 0; Write time: 168320 09:39:38 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 245985280; Read time: 0; Write time: 229728 09:39:39 INFO - Running post-run listener: _upload_blobber_files 09:39:39 INFO - Blob upload gear active. 09:39:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:39 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 09:39:39 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'] 09:39:39 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 09:39:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:42 INFO - (blobuploader) - INFO - Done attempting. 09:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:43 INFO - (blobuploader) - INFO - Done attempting. 09:39:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:44 INFO - (blobuploader) - INFO - Done attempting. 09:39:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:44 INFO - Return code: 0 09:39:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a4b8a7b6d8110a6637fc502896317cab7b4d4b63d7fa2fc93d2ce47f21603ac5bd20ebc2573058387664cd4e8e0cf24ec16d2940af3240ae4b810e36794ca97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe6843ffad1f355056df1467eb615aee8d8c1c33d867ac512ce67bae3a54ac1e15f7edd003f8ff161740aa52ffac284d76e901468ab1ab6665995101880fc2e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9737e6b6ddd1dd35d1c6a48c8dce4b3de2121449cc5043bdbb70e682028280bebc8515f13f50067df73e31ef7ab4923580f86d8b6da1a29178d1c501d3e72868"} 09:39:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:44 INFO - Contents: 09:39:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a4b8a7b6d8110a6637fc502896317cab7b4d4b63d7fa2fc93d2ce47f21603ac5bd20ebc2573058387664cd4e8e0cf24ec16d2940af3240ae4b810e36794ca97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe6843ffad1f355056df1467eb615aee8d8c1c33d867ac512ce67bae3a54ac1e15f7edd003f8ff161740aa52ffac284d76e901468ab1ab6665995101880fc2e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9737e6b6ddd1dd35d1c6a48c8dce4b3de2121449cc5043bdbb70e682028280bebc8515f13f50067df73e31ef7ab4923580f86d8b6da1a29178d1c501d3e72868"} 09:39:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:44 INFO - Copying logs to upload dir... 09:39:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.087083 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-29 09:39:43.799840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:43.802992) ========= 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=745a4373a2a16df560f216e000000264-1480431465.189675-248410963 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/9a4b8a7b6d8110a6637fc502896317cab7b4d4b63d7fa2fc93d2ce47f21603ac5bd20ebc2573058387664cd4e8e0cf24ec16d2940af3240ae4b810e36794ca97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe6843ffad1f355056df1467eb615aee8d8c1c33d867ac512ce67bae3a54ac1e15f7edd003f8ff161740aa52ffac284d76e901468ab1ab6665995101880fc2e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9737e6b6ddd1dd35d1c6a48c8dce4b3de2121449cc5043bdbb70e682028280bebc8515f13f50067df73e31ef7ab4923580f86d8b6da1a29178d1c501d3e72868"} build_url:https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011529 build_url: 'https://queue.taskcluster.net/v1/task/FFODyxuMQ12O2a_TdlJoWA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a4b8a7b6d8110a6637fc502896317cab7b4d4b63d7fa2fc93d2ce47f21603ac5bd20ebc2573058387664cd4e8e0cf24ec16d2940af3240ae4b810e36794ca97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe6843ffad1f355056df1467eb615aee8d8c1c33d867ac512ce67bae3a54ac1e15f7edd003f8ff161740aa52ffac284d76e901468ab1ab6665995101880fc2e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9737e6b6ddd1dd35d1c6a48c8dce4b3de2121449cc5043bdbb70e682028280bebc8515f13f50067df73e31ef7ab4923580f86d8b6da1a29178d1c501d3e72868"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:43.829766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:43.830228) ========= 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=745a4373a2a16df560f216e000000264-1480431465.189675-248410963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:39:43.911508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 09:39:43.911833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 09:39:43.912136) ========= ========= Total master_lag: 0.17 =========