builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1475242688.12 results: success (0) buildid: 20160930033005 builduid: 3c67c05c22b5424992fd993f8c613109 revision: afe79b010d138c608f5490572e3303647b452d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.116756) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.117842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.118551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.135042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.135755) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 06:38:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-09-30 06:38:08 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085360 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.236969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.237337) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015393 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.290719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:08.291533) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev afe79b010d138c608f5490572e3303647b452d74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev afe79b010d138c608f5490572e3303647b452d74 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 06:38:08,348 truncating revision to first 12 chars 2016-09-30 06:38:08,348 Setting DEBUG logging. 2016-09-30 06:38:08,348 attempt 1/10 2016-09-30 06:38:08,348 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/afe79b010d13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 06:38:08,912 unpacking tar archive at: fx-team-afe79b010d13/testing/mozharness/ program finished with exit code 0 elapsedTime=0.871922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:09.179477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:09.179897) ========= script_repo_revision: afe79b010d138c608f5490572e3303647b452d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:09.180352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:09.180687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 06:38:09.190393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 06:38:09.190722) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:38:09 INFO - MultiFileLogger online at 20160930 06:38:09 in /builds/slave/test 06:38:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:38:09 INFO - {'append_to_log': False, 06:38:09 INFO - 'base_work_dir': '/builds/slave/test', 06:38:09 INFO - 'blob_upload_branch': 'Fx-Team', 06:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:38:09 INFO - 'branch': 'Fx-Team', 06:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:09 INFO - 'config_files': ('talos/linux_config.py',), 06:38:09 INFO - 'default_actions': ('clobber', 06:38:09 INFO - 'read-buildbot-config', 06:38:09 INFO - 'download-and-extract', 06:38:09 INFO - 'populate-webroot', 06:38:09 INFO - 'create-virtualenv', 06:38:09 INFO - 'install', 06:38:09 INFO - 'run-tests'), 06:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:09 INFO - 'download_minidump_stackwalk': True, 06:38:09 INFO - 'download_symbols': 'ondemand', 06:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 06:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 06:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:09 INFO - 'installer_path': 'installer.exe', 06:38:09 INFO - 'log_level': 'info', 06:38:09 INFO - 'log_name': 'talos', 06:38:09 INFO - 'log_to_console': True, 06:38:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:38:09 INFO - 'opt_config_files': (), 06:38:09 INFO - 'pip_index': False, 06:38:09 INFO - 'sps_profile': False, 06:38:09 INFO - 'sps_profile_interval': 0, 06:38:09 INFO - 'suite': 'dromaeojs', 06:38:09 INFO - 'system_bits': '32', 06:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:09 INFO - 'title': 'talos-linux64-ix-019', 06:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:38:09 INFO - 'use_talos_json': True, 06:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:09 INFO - 'work_dir': 'build'} 06:38:09 INFO - [mozharness: 2016-09-30 13:38:09.348315Z] Running clobber step. 06:38:09 INFO - Running pre-action listener: _resource_record_pre_action 06:38:09 INFO - Running main action method: clobber 06:38:09 INFO - rmtree: /builds/slave/test/build 06:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:38:09 INFO - Running post-action listener: _resource_record_post_action 06:38:09 INFO - [mozharness: 2016-09-30 13:38:09.807061Z] Finished clobber step (success) 06:38:09 INFO - [mozharness: 2016-09-30 13:38:09.807163Z] Running read-buildbot-config step. 06:38:09 INFO - Running pre-action listener: _resource_record_pre_action 06:38:09 INFO - Running main action method: read_buildbot_config 06:38:09 INFO - Using buildbot properties: 06:38:09 INFO - { 06:38:09 INFO - "project": "", 06:38:09 INFO - "product": "firefox", 06:38:09 INFO - "script_repo_revision": "production", 06:38:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:38:09 INFO - "repository": "", 06:38:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:38:09 INFO - "buildid": "20160930033005", 06:38:09 INFO - "pgo_build": "True", 06:38:09 INFO - "basedir": "/builds/slave/test", 06:38:09 INFO - "buildnumber": 1099, 06:38:09 INFO - "slavename": "talos-linux64-ix-019", 06:38:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:38:09 INFO - "platform": "ubuntu64_hw", 06:38:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:38:09 INFO - "branch": "fx-team", 06:38:09 INFO - "repo_path": "integration/fx-team", 06:38:09 INFO - "revision": "afe79b010d138c608f5490572e3303647b452d74", 06:38:09 INFO - "stage_platform": "linux64-pgo", 06:38:09 INFO - "builduid": "3c67c05c22b5424992fd993f8c613109", 06:38:09 INFO - "slavebuilddir": "test" 06:38:09 INFO - } 06:38:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:38:09 INFO - Running post-action listener: _resource_record_post_action 06:38:09 INFO - [mozharness: 2016-09-30 13:38:09.809619Z] Finished read-buildbot-config step (success) 06:38:09 INFO - [mozharness: 2016-09-30 13:38:09.809708Z] Running download-and-extract step. 06:38:09 INFO - Running pre-action listener: _resource_record_pre_action 06:38:09 INFO - Running main action method: download_and_extract 06:38:09 INFO - mkdir: /builds/slave/test/build/tests 06:38:09 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')]} 06:38:09 INFO - trying https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:38:09 INFO - Downloading https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:38:10 INFO - Downloaded 1361 bytes. 06:38:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:38:10 INFO - Using the following test package requirements: 06:38:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:38:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:38:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'jsshell-linux-x86_64.zip'], 06:38:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:38:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:38:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:38:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:38:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:38:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:38:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:38:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:38:10 INFO - Fetch https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:38:10 INFO - Http code: 200 06:38:10 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 06:38:10 INFO - x-amz-cf-id: Fl37rYSFHelaMsQxnF-Yj97Y-PeQt7EcIEJ6GPbgzF8GPalsF9FMSA== 06:38:10 INFO - x-amz-version-id: G7ZwhoLGiF4TdYKWSkMeNh7MRnjVB7pa 06:38:11 INFO - Expected file size: 21990161 06:38:11 INFO - Obtained file size: 21990161 06:38:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:38:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:38:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:38:15 INFO - Fetch https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:38:15 INFO - Http code: 200 06:38:15 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 06:38:15 INFO - x-amz-cf-id: 45NmCjUNQ8s1hXgOwQUzyc8BOd2UZYkQTemmGr9m_zFL7ZwnPE-0wg== 06:38:15 INFO - x-amz-version-id: G7ZwhoLGiF4TdYKWSkMeNh7MRnjVB7pa 06:38:16 INFO - Expected file size: 21990161 06:38:16 INFO - Obtained file size: 21990161 06:38:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:38:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:38:20 INFO - Fetch https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:38:21 INFO - Http code: 200 06:38:21 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 06:38:21 INFO - x-amz-cf-id: EV6gtmVDrPAhw_rspTS0TLStR7zMstvbkn_RymkNhZ6FEkQY-ZScRQ== 06:38:21 INFO - x-amz-version-id: 3LF5fn_zfols0hnX.UzpIhvERwIR1zE. 06:38:21 INFO - Expected file size: 14408522 06:38:21 INFO - Obtained file size: 14408522 06:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:21 INFO - trying https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:38:21 INFO - Downloading https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:38:22 INFO - Downloaded 59645571 bytes. 06:38:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:38:22 INFO - mkdir: /builds/slave/test/properties 06:38:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:38:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:38:22 INFO - Contents: 06:38:22 INFO - build_url:https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:38:23 INFO - Running post-action listener: _resource_record_post_action 06:38:23 INFO - Running post-action listener: set_extra_try_arguments 06:38:23 INFO - [mozharness: 2016-09-30 13:38:23.690649Z] Finished download-and-extract step (success) 06:38:23 INFO - [mozharness: 2016-09-30 13:38:23.690876Z] Running populate-webroot step. 06:38:23 INFO - Running pre-action listener: _resource_record_pre_action 06:38:23 INFO - Running main action method: populate_webroot 06:38:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:23 INFO - '--tppagecycles', 06:38:23 INFO - '7'], 06:38:23 INFO - 'tests': ['tsvgm']}}, 06:38:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:38:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:38:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:38:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['damp', 'tps']}, 06:38:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'tests': ['damp', 'tps']}, 06:38:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['dromaeo_dom']}, 06:38:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['basic_compositor_video']}, 06:38:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:38:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['a11yr', 06:38:23 INFO - 'ts_paint', 06:38:23 INFO - 'tpaint', 06:38:23 INFO - 'sessionrestore', 06:38:23 INFO - 'sessionrestore_no_auto_restore', 06:38:23 INFO - 'tabpaint']}, 06:38:23 INFO - 'other-e10s': {'tests': ['a11yr', 06:38:23 INFO - 'ts_paint', 06:38:23 INFO - 'tpaint', 06:38:23 INFO - 'sessionrestore', 06:38:23 INFO - 'sessionrestore_no_auto_restore', 06:38:23 INFO - 'tabpaint']}, 06:38:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:38:23 INFO - 'ts_paint', 06:38:23 INFO - 'tpaint', 06:38:23 INFO - 'sessionrestore', 06:38:23 INFO - 'sessionrestore_no_auto_restore', 06:38:23 INFO - 'tabpaint']}, 06:38:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:38:23 INFO - 'ts_paint', 06:38:23 INFO - 'tpaint', 06:38:23 INFO - 'sessionrestore', 06:38:23 INFO - 'sessionrestore_no_auto_restore', 06:38:23 INFO - 'tabpaint']}, 06:38:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['a11yr', 06:38:23 INFO - 'ts_paint', 06:38:23 INFO - 'tpaint', 06:38:23 INFO - 'sessionrestore', 06:38:23 INFO - 'sessionrestore_no_auto_restore', 06:38:23 INFO - 'tabpaint']}, 06:38:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['a11yr', 06:38:23 INFO - 'ts_paint', 06:38:23 INFO - 'tpaint', 06:38:23 INFO - 'sessionrestore', 06:38:23 INFO - 'sessionrestore_no_auto_restore', 06:38:23 INFO - 'tabpaint']}, 06:38:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['tsvgx', 06:38:23 INFO - 'tsvgr_opacity', 06:38:23 INFO - 'tart', 06:38:23 INFO - 'tscrollx', 06:38:23 INFO - 'cart']}, 06:38:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:38:23 INFO - 'tsvgr_opacity', 06:38:23 INFO - 'tart', 06:38:23 INFO - 'tscrollx', 06:38:23 INFO - 'cart']}, 06:38:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'talos_options': ['--disable-e10s'], 06:38:23 INFO - 'tests': ['tp5o']}, 06:38:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'tests': ['tp5o']}, 06:38:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'talos_options': ['--disable-e10s', 06:38:23 INFO - '--xperf_path', 06:38:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:23 INFO - 'tests': ['tp5n']}, 06:38:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:23 INFO - 'talos_options': ['--xperf_path', 06:38:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:23 INFO - 'tests': ['tp5n']}}, 06:38:23 INFO - 'talos.zip': {'path': '', 06:38:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:23 INFO - Running post-action listener: _resource_record_post_action 06:38:23 INFO - [mozharness: 2016-09-30 13:38:23.708056Z] Finished populate-webroot step (success) 06:38:23 INFO - [mozharness: 2016-09-30 13:38:23.708145Z] Running create-virtualenv step. 06:38:23 INFO - Running pre-action listener: _resource_record_pre_action 06:38:23 INFO - Running main action method: create_virtualenv 06:38:23 INFO - Creating virtualenv /builds/slave/test/build/venv 06:38:23 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 06:38:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:38:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:23 INFO - Using real prefix '/usr' 06:38:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:38:24 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:26 INFO - Installing pip.................done. 06:38:26 INFO - Return code: 0 06:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:38:26 INFO - Reading from file tmpfile_stdout 06:38:26 INFO - Output received: 06:38:26 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) 06:38:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38:26 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')]} 06:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:26 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')]} 06:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:26 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:26 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 06:38:26 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 06:38:26 INFO - Using env: {'DISPLAY': ':0', 06:38:26 INFO - 'HOME': '/home/cltbld', 06:38:26 INFO - 'LANG': 'en_US.UTF-8', 06:38:26 INFO - 'LANGUAGE': 'en_US:en', 06:38:26 INFO - 'LOGNAME': 'cltbld', 06:38:26 INFO - 'MAIL': '/var/mail/cltbld', 06:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:26 INFO - 'MOZ_NO_REMOTE': '1', 06:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:26 INFO - 'NO_EM_RESTART': '1', 06:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:26 INFO - 'PWD': '/builds/slave/test', 06:38:26 INFO - 'SHELL': '/bin/bash', 06:38:26 INFO - 'SHLVL': '1', 06:38:26 INFO - 'TERM': 'linux', 06:38:26 INFO - 'TMOUT': '86400', 06:38:26 INFO - 'USER': 'cltbld', 06:38:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:26 INFO - '_': '/tools/buildbot/bin/python'} 06:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:26 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 06:38:26 INFO - Cleaning up... 06:38:26 INFO - Return code: 0 06:38:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:38:26 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')]} 06:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:26 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')]} 06:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:26 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:26 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 06:38:26 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 06:38:26 INFO - Using env: {'DISPLAY': ':0', 06:38:26 INFO - 'HOME': '/home/cltbld', 06:38:26 INFO - 'LANG': 'en_US.UTF-8', 06:38:26 INFO - 'LANGUAGE': 'en_US:en', 06:38:26 INFO - 'LOGNAME': 'cltbld', 06:38:26 INFO - 'MAIL': '/var/mail/cltbld', 06:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:26 INFO - 'MOZ_NO_REMOTE': '1', 06:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:26 INFO - 'NO_EM_RESTART': '1', 06:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:26 INFO - 'PWD': '/builds/slave/test', 06:38:26 INFO - 'SHELL': '/bin/bash', 06:38:26 INFO - 'SHLVL': '1', 06:38:26 INFO - 'TERM': 'linux', 06:38:26 INFO - 'TMOUT': '86400', 06:38:26 INFO - 'USER': 'cltbld', 06:38:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:26 INFO - '_': '/tools/buildbot/bin/python'} 06:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:26 INFO - Downloading/unpacking psutil>=3.1.1 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 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 06:38:26 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 06:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:28 INFO - Installing collected packages: psutil 06:38:28 INFO - Running setup.py install for psutil 06:38:29 INFO - building 'psutil._psutil_linux' extension 06:38:29 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 06:38:29 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 06:38:29 INFO - building 'psutil._psutil_posix' extension 06:38:29 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 06:38:29 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 06:38:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:29 INFO - Successfully installed psutil 06:38:29 INFO - Cleaning up... 06:38:29 INFO - Return code: 0 06:38:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:38: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 mozsystemmonitor==0.3 06:38:29 INFO - Using env: {'DISPLAY': ':0', 06:38:29 INFO - 'HOME': '/home/cltbld', 06:38:29 INFO - 'LANG': 'en_US.UTF-8', 06:38:29 INFO - 'LANGUAGE': 'en_US:en', 06:38:29 INFO - 'LOGNAME': 'cltbld', 06:38:29 INFO - 'MAIL': '/var/mail/cltbld', 06:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:29 INFO - 'MOZ_NO_REMOTE': '1', 06:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:29 INFO - 'NO_EM_RESTART': '1', 06:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:29 INFO - 'PWD': '/builds/slave/test', 06:38:29 INFO - 'SHELL': '/bin/bash', 06:38:29 INFO - 'SHLVL': '1', 06:38:29 INFO - 'TERM': 'linux', 06:38:29 INFO - 'TMOUT': '86400', 06:38:29 INFO - 'USER': 'cltbld', 06:38:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:29 INFO - '_': '/tools/buildbot/bin/python'} 06:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:38:31 INFO - Installing collected packages: mozsystemmonitor 06:38:31 INFO - Running setup.py install for mozsystemmonitor 06:38:31 INFO - Successfully installed mozsystemmonitor 06:38:31 INFO - Cleaning up... 06:38:31 INFO - Return code: 0 06:38:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:31 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:31 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 06:38:31 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 06:38:31 INFO - Using env: {'DISPLAY': ':0', 06:38:31 INFO - 'HOME': '/home/cltbld', 06:38:31 INFO - 'LANG': 'en_US.UTF-8', 06:38:31 INFO - 'LANGUAGE': 'en_US:en', 06:38:31 INFO - 'LOGNAME': 'cltbld', 06:38:31 INFO - 'MAIL': '/var/mail/cltbld', 06:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:31 INFO - 'MOZ_NO_REMOTE': '1', 06:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:31 INFO - 'NO_EM_RESTART': '1', 06:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:31 INFO - 'PWD': '/builds/slave/test', 06:38:31 INFO - 'SHELL': '/bin/bash', 06:38:31 INFO - 'SHLVL': '1', 06:38:31 INFO - 'TERM': 'linux', 06:38:31 INFO - 'TMOUT': '86400', 06:38:31 INFO - 'USER': 'cltbld', 06:38:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:31 INFO - '_': '/tools/buildbot/bin/python'} 06:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:32 INFO - Downloading/unpacking jsonschema==2.5.1 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:34 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:34 INFO - warning: no files found matching '*.txt' 06:38:34 INFO - no previously-included directories found matching 'build' 06:38:34 INFO - no previously-included directories found matching 'dist' 06:38:34 INFO - no previously-included directories found matching '.git*' 06:38:34 INFO - Installing collected packages: jsonschema, functools32 06:38:34 INFO - Running setup.py install for functools32 06:38:34 INFO - warning: no files found matching '*.txt' 06:38:34 INFO - no previously-included directories found matching 'build' 06:38:34 INFO - no previously-included directories found matching 'dist' 06:38:34 INFO - no previously-included directories found matching '.git*' 06:38:34 INFO - Successfully installed jsonschema functools32 06:38:34 INFO - Cleaning up... 06:38:34 INFO - Return code: 0 06:38:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:38:34 INFO - Using env: {'DISPLAY': ':0', 06:38:34 INFO - 'HOME': '/home/cltbld', 06:38:34 INFO - 'LANG': 'en_US.UTF-8', 06:38:34 INFO - 'LANGUAGE': 'en_US:en', 06:38:34 INFO - 'LOGNAME': 'cltbld', 06:38:34 INFO - 'MAIL': '/var/mail/cltbld', 06:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:34 INFO - 'MOZ_NO_REMOTE': '1', 06:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:34 INFO - 'NO_EM_RESTART': '1', 06:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:34 INFO - 'PWD': '/builds/slave/test', 06:38:34 INFO - 'SHELL': '/bin/bash', 06:38:34 INFO - 'SHLVL': '1', 06:38:34 INFO - 'TERM': 'linux', 06:38:34 INFO - 'TMOUT': '86400', 06:38:34 INFO - 'USER': 'cltbld', 06:38:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:34 INFO - '_': '/tools/buildbot/bin/python'} 06:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:38:34 INFO - Cleaning up... 06:38:34 INFO - Return code: 0 06:38:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:38:34 INFO - Using env: {'DISPLAY': ':0', 06:38:34 INFO - 'HOME': '/home/cltbld', 06:38:34 INFO - 'LANG': 'en_US.UTF-8', 06:38:34 INFO - 'LANGUAGE': 'en_US:en', 06:38:34 INFO - 'LOGNAME': 'cltbld', 06:38:34 INFO - 'MAIL': '/var/mail/cltbld', 06:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:34 INFO - 'MOZ_NO_REMOTE': '1', 06:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:34 INFO - 'NO_EM_RESTART': '1', 06:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:34 INFO - 'PWD': '/builds/slave/test', 06:38:34 INFO - 'SHELL': '/bin/bash', 06:38:34 INFO - 'SHLVL': '1', 06:38:34 INFO - 'TERM': 'linux', 06:38:34 INFO - 'TMOUT': '86400', 06:38:34 INFO - 'USER': 'cltbld', 06:38:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:34 INFO - '_': '/tools/buildbot/bin/python'} 06:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38:36 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 06:38:36 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 06:38:36 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 06:38:36 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 06:38:36 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 06:38:36 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 06:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:37 INFO - Downloading docopt-0.6.1.tar.gz 06:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:37 INFO - Running setup.py install for blobuploader 06:38:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:37 INFO - Running setup.py install for requests 06:38:37 INFO - Running setup.py install for docopt 06:38:38 INFO - Successfully installed blobuploader requests docopt 06:38:38 INFO - Cleaning up... 06:38:38 INFO - Return code: 0 06:38:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:38 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:38 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 06:38:38 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 06:38:38 INFO - Using env: {'DISPLAY': ':0', 06:38:38 INFO - 'HOME': '/home/cltbld', 06:38:38 INFO - 'LANG': 'en_US.UTF-8', 06:38:38 INFO - 'LANGUAGE': 'en_US:en', 06:38:38 INFO - 'LOGNAME': 'cltbld', 06:38:38 INFO - 'MAIL': '/var/mail/cltbld', 06:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:38 INFO - 'MOZ_NO_REMOTE': '1', 06:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:38 INFO - 'NO_EM_RESTART': '1', 06:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:38 INFO - 'PWD': '/builds/slave/test', 06:38:38 INFO - 'SHELL': '/bin/bash', 06:38:38 INFO - 'SHLVL': '1', 06:38:38 INFO - 'TERM': 'linux', 06:38:38 INFO - 'TMOUT': '86400', 06:38:38 INFO - 'USER': 'cltbld', 06:38:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:38 INFO - '_': '/tools/buildbot/bin/python'} 06:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:38 INFO - Running setup.py (path:/tmp/pip-Cia6Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:38 INFO - Running setup.py (path:/tmp/pip-lIiOzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:38 INFO - Running setup.py (path:/tmp/pip-CBzwhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:38 INFO - Running setup.py (path:/tmp/pip-fm8XNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:38 INFO - Running setup.py (path:/tmp/pip-wlKsGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:38 INFO - Running setup.py (path:/tmp/pip-Rq8aaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:38 INFO - Running setup.py (path:/tmp/pip-SkRJdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:38 INFO - Running setup.py (path:/tmp/pip-oKQ7Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:38 INFO - Running setup.py (path:/tmp/pip-DQdD8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:39 INFO - Running setup.py (path:/tmp/pip-GlhElg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:39 INFO - Running setup.py (path:/tmp/pip-TyvlFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:39 INFO - Running setup.py (path:/tmp/pip-VROFP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:39 INFO - Running setup.py (path:/tmp/pip-Aph2xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:39 INFO - Running setup.py (path:/tmp/pip-x56FZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:39 INFO - Running setup.py (path:/tmp/pip-3uBHnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:39 INFO - Running setup.py (path:/tmp/pip-lKsyAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:39 INFO - Running setup.py (path:/tmp/pip-WOq1O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:39 INFO - Running setup.py install for manifestparser 06:38:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:39 INFO - Running setup.py install for mozcrash 06:38:39 INFO - Running setup.py install for mozdebug 06:38:39 INFO - Running setup.py install for mozdevice 06:38:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:38:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for mozfile 06:38:40 INFO - Running setup.py install for mozhttpd 06:38:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for mozinfo 06:38:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for mozInstall 06:38:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for mozleak 06:38:40 INFO - Running setup.py install for mozlog 06:38:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for moznetwork 06:38:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for mozprocess 06:38:40 INFO - Running setup.py install for mozprofile 06:38:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:40 INFO - Running setup.py install for mozrunner 06:38:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:41 INFO - Running setup.py install for mozscreenshot 06:38:41 INFO - Running setup.py install for moztest 06:38:41 INFO - Running setup.py install for mozversion 06:38:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:41 INFO - Cleaning up... 06:38:41 INFO - Return code: 0 06:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:41 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:41 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 06:38:41 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 06:38:41 INFO - Using env: {'DISPLAY': ':0', 06:38:41 INFO - 'HOME': '/home/cltbld', 06:38:41 INFO - 'LANG': 'en_US.UTF-8', 06:38:41 INFO - 'LANGUAGE': 'en_US:en', 06:38:41 INFO - 'LOGNAME': 'cltbld', 06:38:41 INFO - 'MAIL': '/var/mail/cltbld', 06:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:41 INFO - 'MOZ_NO_REMOTE': '1', 06:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:41 INFO - 'NO_EM_RESTART': '1', 06:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:41 INFO - 'PWD': '/builds/slave/test', 06:38:41 INFO - 'SHELL': '/bin/bash', 06:38:41 INFO - 'SHLVL': '1', 06:38:41 INFO - 'TERM': 'linux', 06:38:41 INFO - 'TMOUT': '86400', 06:38:41 INFO - 'USER': 'cltbld', 06:38:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:41 INFO - '_': '/tools/buildbot/bin/python'} 06:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:41 INFO - Running setup.py (path:/tmp/pip-EytKdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:41 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)) 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:41 INFO - Running setup.py (path:/tmp/pip-wSBSxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:41 INFO - Running setup.py (path:/tmp/pip-_3tksv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:41 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)) 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:41 INFO - Running setup.py (path:/tmp/pip-WgBqMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:41 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)) 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:41 INFO - Running setup.py (path:/tmp/pip-x_KE3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:41 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)) 06:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:41 INFO - Running setup.py (path:/tmp/pip-BM2Qzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:42 INFO - Running setup.py (path:/tmp/pip-r1bLI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:42 INFO - Running setup.py (path:/tmp/pip-7s5XWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:42 INFO - Running setup.py (path:/tmp/pip-akRprA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:42 INFO - Running setup.py (path:/tmp/pip-0Tnk4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:42 INFO - Running setup.py (path:/tmp/pip-AGqhtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:42 INFO - Running setup.py (path:/tmp/pip-v1h3kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:42 INFO - Running setup.py (path:/tmp/pip-c4mqGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:42 INFO - Running setup.py (path:/tmp/pip-SvaEc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:42 INFO - Running setup.py (path:/tmp/pip-UrBers-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:42 INFO - Running setup.py (path:/tmp/pip-zAM17e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:42 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)) 06:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:42 INFO - Running setup.py (path:/tmp/pip-1cbsIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:42 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)) 06:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:42 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)) 06:38:42 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)) 06:38:42 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)) 06:38:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:44 INFO - Downloading blessings-1.6.tar.gz 06:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:44 INFO - Installing collected packages: blessings 06:38:44 INFO - Running setup.py install for blessings 06:38:44 INFO - Successfully installed blessings 06:38:44 INFO - Cleaning up... 06:38:44 INFO - Return code: 0 06:38:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:45 INFO - Reading from file tmpfile_stdout 06:38:45 INFO - Current package versions: 06:38:45 INFO - argparse == 1.2.1 06:38:45 INFO - blessings == 1.6 06:38:45 INFO - blobuploader == 1.2.4 06:38:45 INFO - docopt == 0.6.1 06:38:45 INFO - functools32 == 3.2.3-2 06:38:45 INFO - jsonschema == 2.5.1 06:38:45 INFO - manifestparser == 1.1 06:38:45 INFO - mozInstall == 1.12 06:38:45 INFO - mozcrash == 0.17 06:38:45 INFO - mozdebug == 0.1 06:38:45 INFO - mozdevice == 0.48 06:38:45 INFO - mozfile == 1.2 06:38:45 INFO - mozhttpd == 0.7 06:38:45 INFO - mozinfo == 0.9 06:38:45 INFO - mozleak == 0.1 06:38:45 INFO - mozlog == 3.4 06:38:45 INFO - moznetwork == 0.27 06:38:45 INFO - mozprocess == 0.23 06:38:45 INFO - mozprofile == 0.28 06:38:45 INFO - mozrunner == 6.12 06:38:45 INFO - mozscreenshot == 0.1 06:38:45 INFO - mozsystemmonitor == 0.3 06:38:45 INFO - moztest == 0.7 06:38:45 INFO - mozversion == 1.4 06:38:45 INFO - psutil == 3.1.1 06:38:45 INFO - requests == 1.2.3 06:38:45 INFO - wsgiref == 0.1.2 06:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:45 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 06:38:45 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 06:38:45 INFO - Using env: {'DISPLAY': ':0', 06:38:45 INFO - 'HOME': '/home/cltbld', 06:38:45 INFO - 'LANG': 'en_US.UTF-8', 06:38:45 INFO - 'LANGUAGE': 'en_US:en', 06:38:45 INFO - 'LOGNAME': 'cltbld', 06:38:45 INFO - 'MAIL': '/var/mail/cltbld', 06:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:45 INFO - 'MOZ_NO_REMOTE': '1', 06:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:45 INFO - 'NO_EM_RESTART': '1', 06:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:45 INFO - 'PWD': '/builds/slave/test', 06:38:45 INFO - 'SHELL': '/bin/bash', 06:38:45 INFO - 'SHLVL': '1', 06:38:45 INFO - 'TERM': 'linux', 06:38:45 INFO - 'TMOUT': '86400', 06:38:45 INFO - 'USER': 'cltbld', 06:38:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:45 INFO - '_': '/tools/buildbot/bin/python'} 06:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 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)) 06:38:45 INFO - Cleaning up... 06:38:45 INFO - Return code: 0 06:38:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 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 0x7f8fedff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', '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 06:38:45 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 06:38:45 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 06:38:45 INFO - Using env: {'DISPLAY': ':0', 06:38:45 INFO - 'HOME': '/home/cltbld', 06:38:45 INFO - 'LANG': 'en_US.UTF-8', 06:38:45 INFO - 'LANGUAGE': 'en_US:en', 06:38:45 INFO - 'LOGNAME': 'cltbld', 06:38:45 INFO - 'MAIL': '/var/mail/cltbld', 06:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:45 INFO - 'MOZ_NO_REMOTE': '1', 06:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:45 INFO - 'NO_EM_RESTART': '1', 06:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:45 INFO - 'PWD': '/builds/slave/test', 06:38:45 INFO - 'SHELL': '/bin/bash', 06:38:45 INFO - 'SHLVL': '1', 06:38:45 INFO - 'TERM': 'linux', 06:38:45 INFO - 'TMOUT': '86400', 06:38:45 INFO - 'USER': 'cltbld', 06:38:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:45 INFO - '_': '/tools/buildbot/bin/python'} 06:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:38:45 INFO - Cleaning up... 06:38:45 INFO - Return code: 0 06:38:45 INFO - Running post-action listener: _resource_record_post_action 06:38:45 INFO - Running post-action listener: _start_resource_monitoring 06:38:45 INFO - Starting resource monitoring. 06:38:45 INFO - [mozharness: 2016-09-30 13:38:45.684448Z] Finished create-virtualenv step (success) 06:38:45 INFO - [mozharness: 2016-09-30 13:38:45.685002Z] Running install step. 06:38:45 INFO - Running pre-action listener: _resource_record_pre_action 06:38:45 INFO - Running main action method: install 06:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:45 INFO - Reading from file tmpfile_stdout 06:38:45 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:45 INFO - Reading from file tmpfile_stdout 06:38:45 INFO - Output received: 06:38:45 INFO - Usage: mozinstall [options] installer 06:38:45 INFO - Options: 06:38:45 INFO - -h, --help show this help message and exit 06:38:45 INFO - -d DEST, --destination=DEST 06:38:45 INFO - Directory to install application into. [default: 06:38:45 INFO - "/builds/slave/test"] 06:38:45 INFO - --app=APP Application being installed. [default: firefox] 06:38:45 INFO - mkdir: /builds/slave/test/build/application 06:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:39:02 INFO - Reading from file tmpfile_stdout 06:39:02 INFO - Output received: 06:39:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:39:02 INFO - Running post-action listener: _resource_record_post_action 06:39:02 INFO - [mozharness: 2016-09-30 13:39:02.992380Z] Finished install step (success) 06:39:02 INFO - [mozharness: 2016-09-30 13:39:02.992625Z] Running run-tests step. 06:39:02 INFO - Running pre-action listener: _resource_record_pre_action 06:39:02 INFO - Running main action method: run_tests 06:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:39:02 INFO - Python 2.7.3 06:39:02 INFO - Return code: 0 06:39:02 INFO - grabbing minidump binary from tooltool 06:39:02 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')]} 06:39:03 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 0x2b29790>, '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 0x2b2a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:39:03 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 06:39:03 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 06:39:03 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 06:39:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:03 INFO - Return code: 0 06:39:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:39:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:39:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:39:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:39:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:39:03 INFO - Using env: {'DISPLAY': ':0', 06:39:03 INFO - 'HOME': '/home/cltbld', 06:39:03 INFO - 'LANG': 'en_US.UTF-8', 06:39:03 INFO - 'LANGUAGE': 'en_US:en', 06:39:03 INFO - 'LOGNAME': 'cltbld', 06:39:03 INFO - 'MAIL': '/var/mail/cltbld', 06:39:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:39:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:03 INFO - 'MOZ_NO_REMOTE': '1', 06:39:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:03 INFO - 'NO_EM_RESTART': '1', 06:39:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:03 INFO - 'PWD': '/builds/slave/test', 06:39:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:39:03 INFO - 'SHELL': '/bin/bash', 06:39:03 INFO - 'SHLVL': '1', 06:39:03 INFO - 'TERM': 'linux', 06:39:03 INFO - 'TMOUT': '86400', 06:39:03 INFO - 'USER': 'cltbld', 06:39:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065', 06:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:03 INFO - '_': '/tools/buildbot/bin/python'} 06:39:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:39:03 INFO - mozversion application_buildid: 20160930033005 06:39:03 INFO - mozversion application_changeset: afe79b010d138c608f5490572e3303647b452d74 06:39:03 INFO - mozversion application_display_name: Nightly 06:39:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:03 INFO - mozversion application_name: Firefox 06:39:03 INFO - mozversion application_remotingname: firefox 06:39:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:39:03 INFO - mozversion application_vendor: Mozilla 06:39:03 INFO - mozversion application_version: 52.0a1 06:39:03 INFO - mozversion platform_buildid: 20160930033005 06:39:03 INFO - mozversion platform_changeset: afe79b010d138c608f5490572e3303647b452d74 06:39:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:39:03 INFO - mozversion platform_version: 52.0a1 06:39:03 INFO - using testdate: 1475242743 06:39:03 INFO - actual date: 1475242743 06:39:03 INFO - starting webserver on 'localhost:47583' 06:39:03 INFO - SUITE-START | Running 2 tests 06:39:03 INFO - TEST-START | dromaeo_css 06:39:03 INFO - operating with platform_type : linux_ 06:39:03 INFO - Initialising browser for dromaeo_css test... 06:39:03 INFO - TEST-INFO | started process 7647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp12_nKV/profile http://localhost:47583/getInfo.html) 06:39:07 INFO - PROCESS | 7647 | __metrics Screen width/height:1600/1200 06:39:07 INFO - PROCESS | 7647 | colorDepth:24 06:39:07 INFO - PROCESS | 7647 | Browser inner width/height: 1024/697 06:39:07 INFO - PROCESS | 7647 | __metrics 06:39:08 INFO - PROCESS | 7647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:39:08 INFO - PROCESS | 7647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:09 INFO - PROCESS | 7647 | console.error: PushService: 06:39:09 INFO - PROCESS | 7647 | stateChangeProcessEnqueue: Error transitioning state 06:39:09 INFO - PROCESS | 7647 | UnknownError 06:39:09 INFO - TEST-INFO | 7647: exit 0 06:39:09 INFO - Browser initialized. 06:39:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:09 INFO - TEST-INFO | started process 7731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp12_nKV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:21 INFO - PROCESS | 7731 | RSS: Main: 176099328 06:39:21 INFO - PROCESS | 7731 | 06:40:13 INFO - PROCESS | 7731 | 1475242813606 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] 06:42:22 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:47583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47583/tests/dromaeo/cssquery-ext.html) 06:42:24 INFO - PROCESS | 7731 | RSS: Main: 371560448 06:42:24 INFO - PROCESS | 7731 | 06:45:26 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:47583/tests/dromaeo/cssquery-ext.html (next: http://localhost:47583/tests/dromaeo/cssquery-jquery.html) 06:45:27 INFO - PROCESS | 7731 | RSS: Main: 276369408 06:45:27 INFO - PROCESS | 7731 | 06:48:29 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:47583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47583/tests/dromaeo/cssquery-mootools.html) 06:48:29 INFO - PROCESS | 7731 | RSS: Main: 259084288 06:48:29 INFO - PROCESS | 7731 | 06:51:31 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:47583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47583/tests/dromaeo/cssquery-prototype.html) 06:51:32 INFO - PROCESS | 7731 | RSS: Main: 254070784 06:51:32 INFO - PROCESS | 7731 | 06:54:35 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:47583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47583/tests/dromaeo/cssquery-yui.html) 06:54:35 INFO - PROCESS | 7731 | RSS: Main: 218411008 06:54:35 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | Cycle 1(1): loaded http://localhost:47583/tests/dromaeo/cssquery-yui.html (next: http://localhost:47583/tests/dromaeo/cssquery-dojo.html) 06:57:38 INFO - PROCESS | 7731 | RSS: Main: 311644160 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | __start_tp_report 06:57:38 INFO - PROCESS | 7731 | _x_x_mozilla_page_load 06:57:38 INFO - PROCESS | 7731 | _x_x_mozilla_page_load_details 06:57:38 INFO - PROCESS | 7731 | |i|pagename|runs| 06:57:38 INFO - PROCESS | 7731 | |0;dojo.html;2960.629921259843;3006.654234763003;3008.4133593949173;3030.3030303030287;3050.1459591314438;5113.565346945505;5188.766505507252;5211.557017653495;5286.497782710641;5350.170723537848;5223.112070947948;5281.498257665526;5334.759935802888;5336.493033161843;5343.492368225022;4549.7701262317905;4757.167495688241;4776.092542416947;4776.928346074812;4814.7351895645725;4883.218685010399;4919.926201106986;4923.82766603169;4937.136001199776;4972.353594032771;4699.553542413465;4753.263244197155;4853.805847766085;4926.679765815228;4978.377702787152;4700.600448961843;4767.737774422405;4802.375691160162;4826.806927722887;4835.395575553056;4650.813967441332;4654.743989080599;4654.976725116353;4708.176069187878;4739.95260047402;5173.689578625294;5176.9741151294;5192.532672059495;5196.506331898464;5252.23842542833;5509.063459211943;5510.91733623996;5568.888622227573;5581.2186293918885;5603.60774745768;5566.276384070085;5615.101583746581;5619.044762390404;5624.775008999676;5636.070048442002;5230.712310822903;5235.240890070919;5238.92141617876;5240.292560504321;5302.1781623848365;5651.576131790132;5655.80204692842;5708.743106560215;5713.942860571341;5714.457126572969;5498.697571633518;5512.118061110203;5575.4424557543925;5577.470140336662;5581.079121944834;5554.222408862763;5568.638038527482;5570.860728481739;5571.13647384656;5580.581456390787;5423.240746295522;5542.889142217133;5556.77772889088;5565.888682226333;5609.046462101453;5501.229827824108;5505.834824955257;5543.113101903757;5546.223528705985;5640.746166422521;4310.504292006397;4314.676399270067;4315.633171180422;4321.69748117635;4367.432233809584;3866.7293289469467;3875.224955008953;3887.78617176058;3889.669378102836;3903.902402439962;5161.483851614808;5206.219067139959;5271.65734227274;5320.52115309624;5331.093714068617;5624.943750562442;5633.8591535211945;5646.4353564644025;5647.265855438849;5703.515201207943;5315.149576067888;5322.893542129135;5323.627346085815;5328.307320048369;5387.542058925035;4677.345171675968;4748.572628463455;4751.572358487683;4833.05755377698;4841.830535931225;5843.503302219359;5955.106733989936;5957.642541447527;5963.373845746221;5964.761409543657;5648;5681.233033540584;5690.687012214368;5692.231548740867;5696.943030569641;5885.323187833283;5891.1457838614015;5894.528437725057;5896.528277737685;5902.2327097477055;5383.138697808332;5499;5501.614886957875;5564.10974244119;5570.136628822377;5675.687837168995;5676.318841738853;5682.0908654616715;5692.402297758841;5737.799177028951;5546.140348246028;5547.944520554743;5550.694711790728;5552.167174923794;5552.333719953632;5217.8173763918085;5322.680639161663;5326.0945639240645;5400.324959380077;5559.082751345983;5306.389765177054;5314.867128321823;5326.547243484347;5330.067238233216;5330.813421530228;5408.513233808976;5434.538064264424;5439.020976224318;5444.945550544602;5446.782128714807;5320.068987927175;5374.516293533601;5423.945760542344;5440.646357986719;5492.47821456961 06:57:38 INFO - PROCESS | 7731 | |1;ext.html;537.8107168623336;586.243745568217;605.2162449627732;605.2646035067394;616.2758758458809;27841.721582784165;28461.430771384585;30086;30474;30488.847555762244;42982.35526467105;44076.77961610196;44202;48500;48537.757311213485;8889.155530224618;9014.233790127848;9036.548172591378;9036.819263614723;9038.276937844958;7966.203379662016;8916.687915922945;8999.235065019448;9006.144416280444;9014.909850901473;8159.714409995651;10664.62673806417;10927.235093543455;10945.45272736364;11376.829347559793;10862.293950893207;10927.344359338385;10930.289531180528;10935.179861510378;10941.726456838564;10654.200934929833;10717.196210284183;10734.141268698486;10737;10742.086922611586;43110;43361.34957975633;43377;43461.56538434607;43497.78251108724;3244;3289.424350738635;3295.4562497187935;3354.1614596350914;3378.527006219131;31926.722931082728;32203.83898080518;33441.33117337664;34013.31973360519;34513.13717157066;4291.120320334324;4297.119090586422;4408.889777755549;4433.7118087324225;4531.796069176895;340820;343418;345484;346117;347682;58139;58526.70736646375;58590.70704646449;58628.70685646545;58633;62013.6281601987;62022;62065.68967155226;62129.37870621326;62150.68924655348;15990.440334588466;16003.679926401406;16149.757753633705;16180.595485112966;16187.109708965885;12492.437840297209;12755.42600582976;12755.553555625509;12765.042621803403;12765.61703148907;15103.39586416553;15463.443408015994;15687.215639217993;16700.248488818033;17416.390426335016;6217.720202590895;6466.1481359369845;6469.450096741735;6511.218653761579;6714.227863795629;877.8200468903987;926.7729406295366;938.8555469724967;1000.3047881722133;1041.5937784264142;31526.857211408893;31937.52093718596;31996.520052199237;32197.195070122965;32522.512162317584;1069.668402795136;1071.3036526257838;1071.4374953149659;1110.5779803674552;1113.9498722557341;16309.266083026292;16772.664546709;16845.915770421314;16951.237194326284;17287.222075006655;501949;503065;503172;503307;503449;50446.74776626093;51729;55934.160987585215;57284.14073788896;58198;1314.6516173214106;1334.4928927007675;1347.932603369808;1349.8582648821928;1362.5163067111032;30628;32830.34339313248;33125.668743313225;33185.66814331922;33204.50193247055;52004.479955201474;52731.73634131805;52754.73622632016;52941;53015;480395;487474;488661;491818;492083;28059.298517537223;28244.576331354634;28416.85791571029;28518.714812852435;28572.714272857836;47194;47576.762116189195;47584.2862357058;47660.285095724284;48143.5185648139;39796.60203397929;39969.40045899255;40211.39682904817;41710.374344384254;42160;40472.79763601163;40683.389749154376;41042.79478602588;42186.57813421949;42538.57461425346;40489.19021619492;41065.58934410618;41139.177216456104;41509.37735934024;41949.580504194564;34340.48489272613;36543.45184822283;36551;36691.63308366989;36959.63040369562;27460.313492162855;27532.17403477899;27633.309167270174;27949;28180.15459536217 06:57:38 INFO - PROCESS | 7731 | |2;jquery.html;357.69953239279016;378.6610983170061;403.4221325728593;407.53337428644204;408.6138599023923;13115.754003369677;14622.48821291255;17325.5668608285;19610.975755881303;20028.399148025546;19080.904595477004;19561.413157605293;19601.705974410394;19800.207991680316;19815.5046123847;5153.6907785532985;5666.801661941833;5882.617629854067;5916.911246331309;5917.408259174092;5244.475552444744;5809.854753631151;5834.56240781941;5838.357780644125;5841.269841269841;5654.406287339832;5657.264555607765;5787.24765780448;5797.449242321994;5803;5754.136879468092;5807.303123625192;5812.767489300423;5820.272465941757;5824.475797178253;4985.426675932278;5169.172932330809;5206.895862082737;5226.085435048889;5229.921551176697;23033.88483057574;23148.18981335662;23175.188868389694;23246.65130023051;23287.883560582257;2254.3462395905167;2270.9772902271097;2286.7827556382117;2330.685357476753;2358.2217868103658;13509.864901350958;14284.57146285613;14315.642108947255;14355.846623006633;14797.926010369987;1898.7404789167012;1902.4768188748205;1930.7779605345283;1944.6305202011713;1969.1138987455702;78149.05929105713;81039.5948020268;82118.58940705318;82181.58909205475;82662.17337826604;10506.317089389318;10689.732756681145;10694.679159625224;10695.358278503314;11893.940530297294;14990.47533336328;15523.689526209413;15544.45594404213;15663.765043524356;15704.136272504893;8120.147384524658;8206.143112737003;8206.179382061746;8309.709160179365;8354.958225208835;7932.444728869039;7940.920590794133;7945.364370850433;8106.148854370324;8120.269175774209;6554.213494380705;6628.933710662928;6718.193816742022;6729.629870357177;6875.449964002868;1927.4506765572025;1941.9417417477216;1976.5157536403385;1986.503374156461;1995.4213278149175;884.3897710579679;969.0745338202;988.6539711101201;1016.8169729448771;1022.7903279827617;19920.203191872162;20267.898660506602;20296.28962986318;20298.89850550738;20318.28885989013;1007.2244371833647;1027.7790275090892;1048.5596049659162;1051.1065594244983;1052.652624633869;10590.682279531626;11029.83455248172;11259.437028148559;11443.14176436754;11493.367864767351;463398;468822;470056;474680;475615;73650.63174684199;76976;77725;78341;78613.60693196497;970.8106919150698;995.576879826071;1012.5797793915442;1015.7155996321042;1021.3361315145066;16797.748033779746;16960.23678934426;17535.82464175393;17867;18135.093245337415;39384.80307598443;39804.80097599609;39901.401478977255;40624.39063413992;40753.38869917013;51984.48015519796;52176.739116304176;52330.21504677357;53140.93718125693;53267.4673253278;7115.466340024415;7985.960070199611;8253.876191857007;8336.041355243982;8771.473711577326;11853;13269.601911942656;13429.66425839362;13458.798118028433;13874.306284685927;11184.328940263611;11670.649880503599;11818.290902545874;11895.048396128463;12207.924652808866;11264.324140551593;11489.82765258505;11600.18798684084;11637.592684256011;11787.882121178678;11487.770244595229;11956.163068585116;11961.401929903644;12066.75866482683;12118.575849845212;8279.62741676614;8435.746927592181;8466.30673865217;8592.097829727789;8759.737207883774;10194.490275486047;11885.405729713653;11929.164958453171;12225.69435764113;12398.504059837865 06:57:38 INFO - PROCESS | 7731 | |3;mootools.html;1348.319098855078;1478.3864696151102;1496.618362317609;1675.388483203631;1834.834864862163;7566.621668916553;8786.121387861218;9163.037881022488;9265.397749146301;9522.95238523808;9305.860412093823;9379.812403751921;9387.671431499899;9394;9396;2296.908123675051;2307.281075598677;2321.9303420897318;2329.790318871301;2333.2533589251448;2259.7062381890332;2265.614845476273;2327.813774898004;2332.9766702333013;2344.3318654183563;2314.2710046335433;2329.1731435340466;2345.3433038749176;2350.882455877208;2354.4349356154485;2251.5046689728233;2279.0541925101065;2281.612125938586;2282.2126366403563;2283.200879692111;2248.5278091600785;2252.4368907773055;2255.605269077921;2258.2547759239574;2259.5029093599383;9211.861822072675;9287.72136835896;9300.39547429415;9309.767255818591;9347.76630584234;5179.430262671103;5362.865928351784;5429.049916264638;5447.700376479292;5482.91775623366;3274.4433446314183;3459.394605943975;3512.4906888501023;3515.771474854126;3518.1556426457464;1043.7338478687961;1090.0571006079763;1092.5902786455079;1105.4362275239605;1110.3227031510771;12945.741085178244;12953.158044727157;13005.544805931842;13051.86948130516;13057.738845223232;4389.758563279051;4418.160549495586;4595.448546174481;4598.379218805485;4690.906181876343;10178.033086856736;10183.083522483012;10183.54174062169;10184.338018028953;10185.541650625739;5311.867203319871;5335.759890804846;5383.67697938125;5387.515123638813;5402.081646120169;4199.874003779892;4459.2865141577195;4590.77046147698;4598.655100867449;5010.774515146827;3652.214773823641;3685.9631403686158;3717.3494638438706;3771.283456143324;3782.2813665403487;1150;1163.4415480569373;1177.8998785103363;1189.8155785853207;1202.2305724336431;818.995905020483;829.9211025666609;900.3742399032609;936.0732874454242;970.8592254123113;5699;5873.618214816023;5959.940400596025;6005.489533389711;6101.389861013863;452.21766344224676;457.77340216593;459.7632219407008;1042.6455005298083;1060.5439660945867;3982.4623675803973;4123.525794533607;4130.215259100762;4240.872773816791;4295.52749197588;11151.330920144817;11519.078473722082;11595.246308989888;11603.535858565732;11613.896679815403;11452.484638191134;11466.713332166595;11475.942620286845;11506.76986460266;11519.942400288113;8292;8525.914740852511;8631.093735157843;8640.351973602004;8645.740627781177;5970.58205925581;6061.848453788691;6090.512758979183;6162.506999440124;6352.968235158794;10445.806380660146;10448.216383771096;10521.631742888962;10572.735681608021;10652.89347106519;8857.867131993155;10560;10570.735731606772;10617.575296988034;10730.463476825971;7065.6113913735235;7991.560464174526;7992.280694737501;8217.58912054383;8224.958875205586;8796.736097917073;8812.823743524965;8869.467831930106;8892.377533572588;8952.552372381486;7830.33442157423;7873.0945941215205;7896.131425543071;7931.841363172589;8076.596170191349;7721.189275126031;7787.338076263581;7791.026121734783;7797.181295964069;7849.843003140019;6890.827729306607;7102.4673149512955;7157.785266442015;7277.890831637424;7303.342699156889;4999.650024498395;5065.7720402581235;5178.663386879841;5212.192110222922;5212.452692467236;4848.903021939471;5134.101532231919;5161.561267292323;5399.163129714901;5552.888942221214 06:57:38 INFO - PROCESS | 7731 | |4;prototype.html;333.7180082830009;334.5466892360851;338.55818157304725;341.8700893660408;348.28080014769483;5105.82566009817;5228.320318358617;5244.816431424901;5282.6830390176565;5327.747979224889;5034.395872495296;5141.22881567765;5166.870828229296;5173.715445650488;5178.171492561191;4147.6474499667565;4154.356074808409;4159.667226621863;4161.126163505667;4179.832806687728;4041.2321658884716;4116.242117781079;4151.3150330195485;4154.605312495308;4193.308104162809;4045.271851066807;4081.2041651877894;4094.549599544048;4105.958940410587;4117.279476091687;4088.632023117919;4091.4272001919753;4101.794910254505;4106.137711080662;4151.8546850860375;3665.120371110941;3667.303212389664;3674.0894734737785;3682.2635472905527;3691.354013047706;4942.479335538901;5045.192769156917;5064.961682855006;5070.264811602334;5070.594352451832;4684.156851766681;4688.953110468886;4695.577398034159;4703.15343238217;4715.481297057321;5385.21914322425;5401.540869026137;5406;5421.918671219895;5437.782488700447;3815.7328986970924;3933.3903244997073;3936.842526298973;3950.960490395088;3960.980195099035;5556.749946252428;5589.441055894418;5608.214849921014;5619.53891988082;5630.887382252373;4151.46031015966;4167.5832416758685;4172.374143878443;4183.728057676241;4187.958120418757;3995.9400608990886;4192.664586833046;4193.685473589493;4212.389203565527;4231.365295205682;4689.882752931204;4691.498720409504;4704.153252414599;4706.458757242893;4716.599089077398;5476.151196564539;5476.890462190734;5479.643823151562;5489;5527.917081243784;1325.6553296143072;1350.6893414514716;1415.8319386506173;1436.7126574685105;1450.8621680940294;915.4187091197005;929.2240978782658;930.5161316115582;933.8645896344992;934.9719508414759;4598.218302888517;4622.745748983771;4630.513796051366;4643;4650.6046986005895;4843.370361852936;4891.5353041461;4897.436794768576;4911.877203069952;4913.65604407688;4573.931391029138;4594.632429405639;4601.217792975202;4624.306354046853;4645.907081858344;2732.9180124595896;2931.6335458067742;2954.49773538499;2957.7225536337332;2958.985205073961;5766.135079737989;5769.701817091121;5784.161296611967;5786.652800831879;5829.766809327664;5538.418466061086;5655.745491452894;5700.629459085146;5705.2012718219485;5742.885142297131;5742.9562331964125;5746.339170995306;5764.308283006066;5769.307683078057;5773.942260577341;5540.889182216414;5555.50000499957;5588.245586845724;5589.301337332833;5645.463680950304;5256.894862102813;5433.266509021231;5511.448855114457;5522.66863988162;5550.38945715979;5767.9134812977;5774.711264436677;5782.971085144547;5787.768489260551;5817.062383496307;3828.751131176576;3961.3067713149508;3972.8609498668566;3978.641922226898;3987.5414327351564;5278.656887302313;5524.779008839601;5530.585206109477;5548.278723765885;5567.192757050286;5288.233206185005;5358.223057656696;5459.945400545944;5486.735392441491;5488.451154884479;5451.536619387396;5464.743109084853;5467.753951072291;5500.697461639488;5502.257195278587;5196.012500494464;5365.463453654604;5405.162199859028;5405.567554595545;5417.268668729671;5432.538234250133;5477.75350109238;5483.862903427446;5495.725213739377;5518.586106041983;5380.43505431924;5399.46115357137;5404.756785944721;5413.648112872808;5418.322709661293 06:57:38 INFO - PROCESS | 7731 | |5;yui.html;766.4402940017067;787.8069872881144;791.3234184772022;818.97133600324;829.8796674482201;11613.419329033535;12110.212836165643;15021.474248401308;16169.676606467863;16312.510624681248;15501.457448989288;16351.918240408811;16379.262933168005;16382.116056653489;16432.507024789247;801.6352559585404;827.5986146718836;828.0973738624898;828.1759649149105;829.9170082991712;821.6590115102225;824.0399934076794;824.5671022713094;824.9340052795762;825.108882406999;703.8838591632375;725.5501589014818;840.5965136734341;868.9261412779921;878.4860856399014;860.1656393298553;860.7288704058233;861.0915484164204;861.6510313323114;861.7845538615346;625.4777260987081;625.583986648878;626.28603392133;626.3141859663662;626.4894111299277;15028.624284392869;15066.171360575165;15066.773998390034;15079.698406031817;15088.321025553876;13990.440382384693;14163.575092747235;14303.642408939755;14308.356123974447;14376.137431754129;12655.367231638382;12767.42546585406;12859.099863009593;13179.670508237275;13269.86730132696;4193.622573968358;4275.273203555403;4295.978520107411;4324.848630297956;4481.7983190756495;77320;78240.21759782443;78503.6074819628;78577.60711196465;78890.21109788887;11110.388928608843;11122.277051991594;11135.721606959729;11222.871866019323;11285.541334316404;21359.893200533897;21468;21544.89227553852;21616.35150945474;22347.217847375265;8119.553424561587;8236.588170591447;8277.54473503951;8286.4199506034;8359.498430094214;4526.569975852289;4727.95272047282;4749.501302363271;4766.213574760126;4792.400949881265;3497.842597083137;3639.3994990826745;3641.5812181598926;3649.306631740014;3655.1958569114754;532.653775046223;678.803147087349;686.4954258619911;686.9690863911136;698.7205117952758;647.1457675867904;693.7086423702058;700.8598280343952;704.4188544450849;722.9566226026456;9059.411138276122;9397.295202859812;9519.286053545873;9877.209823214125;9930.900690992998;581.3575998521658;584.9996505974746;653.0139489371084;672.7880717573948;686.8111269400955;4340.587644173798;4508.143452743968;4539.409876716006;4562.201614717411;4627.9074418511445;79066.6046669763;108219.45890270498;110299.44850275698;110523.44738276258;110716;63530.87049341778;76269;86405.56797215974;96778;99884;74675.25324746792;83922.58038709767;85136;85177;88140;9180.586873590571;9243.21432678203;9256.768580785534;9551.952240238754;9887.110160085627;50165.74917125391;50628.49371506385;51836.70408239673;52079;53485.19772203498;64458;72674;72953.27046729677;75547;78957.21042789498;12508;12754.170978886343;12977.156484828456;12981.221126732426;13143.21140731521;13597.388117534536;13700.93149534246;13969.371378288204;14153.43386264579;14168.574942751733;13050.54323098687;13560.186388816703;14006.43974241019;14502.1298722077;14859.85140148628;13957;14076.436942522185;14078.296085195903;14089.788653170006;14231.715365692835;13084.542041028519;13418.798718019432;13873.930630346784;13981.370838312097;14006.649833754238;11326.603568875049;11601.651950441501;11652.825207621723;11730.296182229093;11865.5847045353;9779.773039032298;10413.062824345845;10478.318909270873;11380.374079425712;11479.311241325548 06:57:38 INFO - PROCESS | 7731 | __end_tp_report 06:57:38 INFO - PROCESS | 7731 | __start_cc_report 06:57:38 INFO - PROCESS | 7731 | _x_x_mozilla_cycle_collect,1658 06:57:38 INFO - PROCESS | 7731 | __end_cc_report 06:57:38 INFO - PROCESS | 7731 | __startTimestamp1475243858798__endTimestamp 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | ------- Summary: start ------- 06:57:38 INFO - PROCESS | 7731 | Number of tests: 6 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | [#0] dojo.html Cycles:165 Average:5213.45 Median:5350.17 stddev:592.78 (11.1%) stddev-sans-first:567.64 06:57:38 INFO - PROCESS | 7731 | Values: 2960.6 3006.7 3008.4 3030.3 3050.1 5113.6 5188.8 5211.6 5286.5 5350.2 5223.1 5281.5 5334.8 5336.5 5343.5 4549.8 4757.2 4776.1 4776.9 4814.7 4883.2 4919.9 4923.8 4937.1 4972.4 4699.6 4753.3 4853.8 4926.7 4978.4 4700.6 4767.7 4802.4 4826.8 4835.4 4650.8 4654.7 4655.0 4708.2 4740.0 5173.7 5177.0 5192.5 5196.5 5252.2 5509.1 5510.9 5568.9 5581.2 5603.6 5566.3 5615.1 5619.0 5624.8 5636.1 5230.7 5235.2 5238.9 5240.3 5302.2 5651.6 5655.8 5708.7 5713.9 5714.5 5498.7 5512.1 5575.4 5577.5 5581.1 5554.2 5568.6 5570.9 5571.1 5580.6 5423.2 5542.9 5556.8 5565.9 5609.0 5501.2 5505.8 5543.1 5546.2 5640.7 4310.5 4314.7 4315.6 4321.7 4367.4 3866.7 3875.2 3887.8 3889.7 3903.9 5161.5 5206.2 5271.7 5320.5 5331.1 5624.9 5633.9 5646.4 5647.3 5703.5 5315.1 5322.9 5323.6 5328.3 5387.5 4677.3 4748.6 4751.6 4833.1 4841.8 5843.5 5955.1 5957.6 5963.4 5964.8 5648.0 5681.2 5690.7 5692.2 5696.9 5885.3 5891.1 5894.5 5896.5 5902.2 5383.1 5499.0 5501.6 5564.1 5570.1 5675.7 5676.3 5682.1 5692.4 5737.8 5546.1 5547.9 5550.7 5552.2 5552.3 5217.8 5322.7 5326.1 5400.3 5559.1 5306.4 5314.9 5326.5 5330.1 5330.8 5408.5 5434.5 5439.0 5444.9 5446.8 5320.1 5374.5 5423.9 5440.6 5492.5 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | [#1] ext.html Cycles:180 Average:60365.68 Median:38378.12 stddev:119560.58 (311.5%) stddev-sans-first:119811.60 06:57:38 INFO - PROCESS | 7731 | Values: 537.8 586.2 605.2 605.3 616.3 27841.7 28461.4 30086.0 30474.0 30488.8 42982.4 44076.8 44202.0 48500.0 48537.8 8889.2 9014.2 9036.5 9036.8 9038.3 7966.2 8916.7 8999.2 9006.1 9014.9 8159.7 10664.6 10927.2 10945.5 11376.8 10862.3 10927.3 10930.3 10935.2 10941.7 10654.2 10717.2 10734.1 10737.0 10742.1 43110.0 43361.3 43377.0 43461.6 43497.8 3244.0 3289.4 3295.5 3354.2 3378.5 31926.7 32203.8 33441.3 34013.3 34513.1 4291.1 4297.1 4408.9 4433.7 4531.8 340820.0 343418.0 345484.0 346117.0 347682.0 58139.0 58526.7 58590.7 58628.7 58633.0 62013.6 62022.0 62065.7 62129.4 62150.7 15990.4 16003.7 16149.8 16180.6 16187.1 12492.4 12755.4 12755.6 12765.0 12765.6 15103.4 15463.4 15687.2 16700.2 17416.4 6217.7 6466.1 6469.5 6511.2 6714.2 877.8 926.8 938.9 1000.3 1041.6 31526.9 31937.5 31996.5 32197.2 32522.5 1069.7 1071.3 1071.4 1110.6 1113.9 16309.3 16772.7 16845.9 16951.2 17287.2 501949.0 503065.0 503172.0 503307.0 503449.0 50446.7 51729.0 55934.2 57284.1 58198.0 1314.7 1334.5 1347.9 1349.9 1362.5 30628.0 32830.3 33125.7 33185.7 33204.5 52004.5 52731.7 52754.7 52941.0 53015.0 480395.0 487474.0 488661.0 491818.0 492083.0 28059.3 28244.6 28416.9 28518.7 28572.7 47194.0 47576.8 47584.3 47660.3 48143.5 39796.6 39969.4 40211.4 41710.4 42160.0 40472.8 40683.4 41042.8 42186.6 42538.6 40489.2 41065.6 41139.2 41509.4 41949.6 34340.5 36543.5 36551.0 36691.6 36959.6 27460.3 27532.2 27633.3 27949.0 28180.2 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | [#2] jquery.html Cycles:180 Average:28001.69 Median:23210.92 stddev:77301.32 (333.0%) stddev-sans-first:77490.30 06:57:38 INFO - PROCESS | 7731 | Values: 357.7 378.7 403.4 407.5 408.6 13115.8 14622.5 17325.6 19611.0 20028.4 19080.9 19561.4 19601.7 19800.2 19815.5 5153.7 5666.8 5882.6 5916.9 5917.4 5244.5 5809.9 5834.6 5838.4 5841.3 5654.4 5657.3 5787.2 5797.4 5803.0 5754.1 5807.3 5812.8 5820.3 5824.5 4985.4 5169.2 5206.9 5226.1 5229.9 23033.9 23148.2 23175.2 23246.7 23287.9 2254.3 2271.0 2286.8 2330.7 2358.2 13509.9 14284.6 14315.6 14355.8 14797.9 1898.7 1902.5 1930.8 1944.6 1969.1 78149.1 81039.6 82118.6 82181.6 82662.2 10506.3 10689.7 10694.7 10695.4 11893.9 14990.5 15523.7 15544.5 15663.8 15704.1 8120.1 8206.1 8206.2 8309.7 8355.0 7932.4 7940.9 7945.4 8106.1 8120.3 6554.2 6628.9 6718.2 6729.6 6875.4 1927.5 1941.9 1976.5 1986.5 1995.4 884.4 969.1 988.7 1016.8 1022.8 19920.2 20267.9 20296.3 20298.9 20318.3 1007.2 1027.8 1048.6 1051.1 1052.7 10590.7 11029.8 11259.4 11443.1 11493.4 463398.0 468822.0 470056.0 474680.0 475615.0 73650.6 76976.0 77725.0 78341.0 78613.6 970.8 995.6 1012.6 1015.7 1021.3 16797.7 16960.2 17535.8 17867.0 18135.1 39384.8 39804.8 39901.4 40624.4 40753.4 51984.5 52176.7 52330.2 53140.9 53267.5 7115.5 7986.0 8253.9 8336.0 8771.5 11853.0 13269.6 13429.7 13458.8 13874.3 11184.3 11670.6 11818.3 11895.0 12207.9 11264.3 11489.8 11600.2 11637.6 11787.9 11487.8 11956.2 11961.4 12066.8 12118.6 8279.6 8435.7 8466.3 8592.1 8759.7 10194.5 11885.4 11929.2 12225.7 12398.5 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | [#3] mootools.html Cycles:180 Average:5921.16 Median:455.00 stddev:3485.88 (766.1%) stddev-sans-first:3478.72 06:57:38 INFO - PROCESS | 7731 | Values: 1348.3 1478.4 1496.6 1675.4 1834.8 7566.6 8786.1 9163.0 9265.4 9523.0 9305.9 9379.8 9387.7 9394.0 9396.0 2296.9 2307.3 2321.9 2329.8 2333.3 2259.7 2265.6 2327.8 2333.0 2344.3 2314.3 2329.2 2345.3 2350.9 2354.4 2251.5 2279.1 2281.6 2282.2 2283.2 2248.5 2252.4 2255.6 2258.3 2259.5 9211.9 9287.7 9300.4 9309.8 9347.8 5179.4 5362.9 5429.0 5447.7 5482.9 3274.4 3459.4 3512.5 3515.8 3518.2 1043.7 1090.1 1092.6 1105.4 1110.3 12945.7 12953.2 13005.5 13051.9 13057.7 4389.8 4418.2 4595.4 4598.4 4690.9 10178.0 10183.1 10183.5 10184.3 10185.5 5311.9 5335.8 5383.7 5387.5 5402.1 4199.9 4459.3 4590.8 4598.7 5010.8 3652.2 3686.0 3717.3 3771.3 3782.3 1150.0 1163.4 1177.9 1189.8 1202.2 819.0 829.9 900.4 936.1 970.9 5699.0 5873.6 5959.9 6005.5 6101.4 452.2 457.8 459.8 1042.6 1060.5 3982.5 4123.5 4130.2 4240.9 4295.5 11151.3 11519.1 11595.2 11603.5 11613.9 11452.5 11466.7 11475.9 11506.8 11519.9 8292.0 8525.9 8631.1 8640.4 8645.7 5970.6 6061.8 6090.5 6162.5 6353.0 10445.8 10448.2 10521.6 10572.7 10652.9 8857.9 10560.0 10570.7 10617.6 10730.5 7065.6 7991.6 7992.3 8217.6 8225.0 8796.7 8812.8 8869.5 8892.4 8952.6 7830.3 7873.1 7896.1 7931.8 8076.6 7721.2 7787.3 7791.0 7797.2 7849.8 6890.8 7102.5 7157.8 7277.9 7303.3 4999.7 5065.8 5178.7 5212.2 5212.5 4848.9 5134.1 5161.6 5399.2 5552.9 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | [#4] prototype.html Cycles:180 Average:4556.96 Median:5088.21 stddev:1321.16 (26.0%) stddev-sans-first:1286.28 06:57:38 INFO - PROCESS | 7731 | Values: 333.7 334.5 338.6 341.9 348.3 5105.8 5228.3 5244.8 5282.7 5327.7 5034.4 5141.2 5166.9 5173.7 5178.2 4147.6 4154.4 4159.7 4161.1 4179.8 4041.2 4116.2 4151.3 4154.6 4193.3 4045.3 4081.2 4094.5 4106.0 4117.3 4088.6 4091.4 4101.8 4106.1 4151.9 3665.1 3667.3 3674.1 3682.3 3691.4 4942.5 5045.2 5065.0 5070.3 5070.6 4684.2 4689.0 4695.6 4703.2 4715.5 5385.2 5401.5 5406.0 5421.9 5437.8 3815.7 3933.4 3936.8 3951.0 3961.0 5556.7 5589.4 5608.2 5619.5 5630.9 4151.5 4167.6 4172.4 4183.7 4188.0 3995.9 4192.7 4193.7 4212.4 4231.4 4689.9 4691.5 4704.2 4706.5 4716.6 5476.2 5476.9 5479.6 5489.0 5527.9 1325.7 1350.7 1415.8 1436.7 1450.9 915.4 929.2 930.5 933.9 935.0 4598.2 4622.7 4630.5 4643.0 4650.6 4843.4 4891.5 4897.4 4911.9 4913.7 4573.9 4594.6 4601.2 4624.3 4645.9 2732.9 2931.6 2954.5 2957.7 2959.0 5766.1 5769.7 5784.2 5786.7 5829.8 5538.4 5655.7 5700.6 5705.2 5742.9 5743.0 5746.3 5764.3 5769.3 5773.9 5540.9 5555.5 5588.2 5589.3 5645.5 5256.9 5433.3 5511.4 5522.7 5550.4 5767.9 5774.7 5783.0 5787.8 5817.1 3828.8 3961.3 3972.9 3978.6 3987.5 5278.7 5524.8 5530.6 5548.3 5567.2 5288.2 5358.2 5459.9 5486.7 5488.5 5451.5 5464.7 5467.8 5500.7 5502.3 5196.0 5365.5 5405.2 5405.6 5417.3 5432.5 5477.8 5483.9 5495.7 5518.6 5380.4 5399.5 5404.8 5413.6 5418.3 06:57:38 INFO - PROCESS | 7731 | 06:57:38 INFO - PROCESS | 7731 | [#5] yui.html Cycles:180 Average:20059.91 Median:4757.86 stddev:27999.39 (588.5%) stddev-sans-first:28040.46 06:57:38 INFO - PROCESS | 7731 | Values: 766.4 787.8 791.3 819.0 829.9 11613.4 12110.2 15021.5 16169.7 16312.5 15501.5 16351.9 16379.3 16382.1 16432.5 801.6 827.6 828.1 828.2 829.9 821.7 824.0 824.6 824.9 825.1 703.9 725.6 840.6 868.9 878.5 860.2 860.7 861.1 861.7 861.8 625.5 625.6 626.3 626.3 626.5 15028.6 15066.2 15066.8 15079.7 15088.3 13990.4 14163.6 14303.6 14308.4 14376.1 12655.4 12767.4 12859.1 13179.7 13269.9 4193.6 4275.3 4296.0 4324.8 4481.8 77320.0 78240.2 78503.6 78577.6 78890.2 11110.4 11122.3 11135.7 11222.9 11285.5 21359.9 21468.0 21544.9 21616.4 22347.2 8119.6 8236.6 8277.5 8286.4 8359.5 4526.6 4728.0 4749.5 4766.2 4792.4 3497.8 3639.4 3641.6 3649.3 3655.2 532.7 678.8 686.5 687.0 698.7 647.1 693.7 700.9 704.4 723.0 9059.4 9397.3 9519.3 9877.2 9930.9 581.4 585.0 653.0 672.8 686.8 4340.6 4508.1 4539.4 4562.2 4627.9 79066.6 108219.5 110299.4 110523.4 110716.0 63530.9 76269.0 86405.6 96778.0 99884.0 74675.3 83922.6 85136.0 85177.0 88140.0 9180.6 9243.2 9256.8 9552.0 9887.1 50165.7 50628.5 51836.7 52079.0 53485.2 64458.0 72674.0 72953.3 75547.0 78957.2 12508.0 12754.2 12977.2 12981.2 13143.2 13597.4 13700.9 13969.4 14153.4 14168.6 13050.5 13560.2 14006.4 14502.1 14859.9 13957.0 14076.4 14078.3 14089.8 14231.7 13084.5 13418.8 13873.9 13981.4 14006.6 11326.6 11601.7 11652.8 11730.3 11865.6 9779.8 10413.1 10478.3 11380.4 11479.3 06:57:38 INFO - PROCESS | 7731 | -------- Summary: end -------- 06:57:38 INFO - PROCESS | 7731 | 06:57:39 INFO - TEST-INFO | 7731: exit 0 06:57:39 INFO - TEST-OK | dromaeo_css | took 1116447ms 06:57:39 INFO - TEST-START | kraken 06:57:39 INFO - operating with platform_type : linux_ 06:57:39 INFO - Initialising browser for kraken test... 06:57:39 INFO - TEST-INFO | started process 8039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpausci9/profile http://localhost:47583/getInfo.html) 06:57:44 INFO - PROCESS | 8039 | __metrics Screen width/height:1600/1200 06:57:44 INFO - PROCESS | 8039 | colorDepth:24 06:57:44 INFO - PROCESS | 8039 | Browser inner width/height: 1024/697 06:57:44 INFO - PROCESS | 8039 | __metrics 06:57:44 INFO - PROCESS | 8039 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:57:44 INFO - PROCESS | 8039 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:45 INFO - PROCESS | 8039 | console.error: PushService: 06:57:45 INFO - PROCESS | 8039 | stateChangeProcessEnqueue: Error transitioning state 06:57:45 INFO - PROCESS | 8039 | UnknownError 06:57:46 INFO - TEST-INFO | 8039: exit 0 06:57:46 INFO - Browser initialized. 06:57:46 INFO - Running cycle 1/1 for kraken test... 06:57:46 INFO - TEST-INFO | started process 8121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpausci9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:58 INFO - PROCESS | 8121 | RSS: Main: 173510656 06:57:58 INFO - PROCESS | 8121 | 06:58:00 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47583/tests/kraken/driver.html?testName=audio-beat-detection) 06:58:01 INFO - PROCESS | 8121 | RSS: Main: 232194048 06:58:01 INFO - PROCESS | 8121 | 06:58:04 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47583/tests/kraken/driver.html?testName=audio-dft) 06:58:04 INFO - PROCESS | 8121 | RSS: Main: 217288704 06:58:04 INFO - PROCESS | 8121 | 06:58:08 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47583/tests/kraken/driver.html?testName=audio-fft) 06:58:08 INFO - PROCESS | 8121 | RSS: Main: 298500096 06:58:08 INFO - PROCESS | 8121 | 06:58:10 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47583/tests/kraken/driver.html?testName=audio-oscillator) 06:58:11 INFO - PROCESS | 8121 | RSS: Main: 207990784 06:58:11 INFO - PROCESS | 8121 | 06:58:13 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:14 INFO - PROCESS | 8121 | RSS: Main: 212508672 06:58:14 INFO - PROCESS | 8121 | 06:58:17 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47583/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:17 INFO - PROCESS | 8121 | RSS: Main: 248483840 06:58:17 INFO - PROCESS | 8121 | 06:58:21 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47583/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:21 INFO - PROCESS | 8121 | RSS: Main: 247980032 06:58:21 INFO - PROCESS | 8121 | 06:58:24 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47583/tests/kraken/driver.html?testName=json-parse-financial) 06:58:25 INFO - PROCESS | 8121 | RSS: Main: 248049664 06:58:25 INFO - PROCESS | 8121 | 06:58:26 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:27 INFO - PROCESS | 8121 | RSS: Main: 210300928 06:58:27 INFO - PROCESS | 8121 | 06:58:29 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:29 INFO - PROCESS | 8121 | RSS: Main: 217448448 06:58:29 INFO - PROCESS | 8121 | 06:58:31 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:32 INFO - PROCESS | 8121 | RSS: Main: 223096832 06:58:32 INFO - PROCESS | 8121 | 06:58:35 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:35 INFO - PROCESS | 8121 | RSS: Main: 223670272 06:58:35 INFO - PROCESS | 8121 | 06:58:38 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:39 INFO - PROCESS | 8121 | RSS: Main: 221999104 06:58:39 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | Cycle 1(1): loaded http://localhost:47583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47583/tests/kraken/driver.html?testName=ai-astar) 06:58:40 INFO - PROCESS | 8121 | RSS: Main: 272904192 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | __start_tp_report 06:58:40 INFO - PROCESS | 8121 | _x_x_mozilla_page_load 06:58:40 INFO - PROCESS | 8121 | _x_x_mozilla_page_load_details 06:58:40 INFO - PROCESS | 8121 | |i|pagename|runs| 06:58:40 INFO - PROCESS | 8121 | |0;ai-astar;110;114;111;111;112;112;112;112;112;112 06:58:40 INFO - PROCESS | 8121 | |1;audio-beat-detection;154;125;128;174;132;123;126;127;172;128 06:58:40 INFO - PROCESS | 8121 | |2;audio-dft;161;160;159;160;161;161;160;161;162;160 06:58:40 INFO - PROCESS | 8121 | |3;audio-fft;75;76;75;110;79;75;76;77;97;74 06:58:40 INFO - PROCESS | 8121 | |4;audio-oscillator;83;83;112;82;82;83;100;83;81;111 06:58:40 INFO - PROCESS | 8121 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 06:58:40 INFO - PROCESS | 8121 | |6;imaging-darkroom;147;147;147;148;148;153;145;146;146;148 06:58:40 INFO - PROCESS | 8121 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 06:58:40 INFO - PROCESS | 8121 | |8;json-parse-financial;53;51;51;52;51;52;53;53;53;52 06:58:40 INFO - PROCESS | 8121 | |9;json-stringify-tinderbox;61;61;60;59;60;61;60;59;60;60 06:58:40 INFO - PROCESS | 8121 | |10;stanford-crypto-aes;89;80;80;80;81;80;80;84;80;81 06:58:40 INFO - PROCESS | 8121 | |11;stanford-crypto-ccm;140;129;128;147;134;127;129;127;166;132 06:58:40 INFO - PROCESS | 8121 | |12;stanford-crypto-pbkdf2;166;167;167;165;166;168;168;166;165;169 06:58:40 INFO - PROCESS | 8121 | |13;stanford-crypto-sha256-iterative;67;68;67;65;65;65;64;64;66;64 06:58:40 INFO - PROCESS | 8121 | __end_tp_report 06:58:40 INFO - PROCESS | 8121 | __start_cc_report 06:58:40 INFO - PROCESS | 8121 | _x_x_mozilla_cycle_collect,1672 06:58:40 INFO - PROCESS | 8121 | __end_cc_report 06:58:40 INFO - PROCESS | 8121 | __startTimestamp1475243920957__endTimestamp 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | ------- Summary: start ------- 06:58:40 INFO - PROCESS | 8121 | Number of tests: 14 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 06:58:40 INFO - PROCESS | 8121 | Values: 110.0 114.0 111.0 111.0 112.0 112.0 112.0 112.0 112.0 112.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:130.00 stddev:19.99 (15.4%) stddev-sans-first:20.44 06:58:40 INFO - PROCESS | 8121 | Values: 154.0 125.0 128.0 174.0 132.0 123.0 126.0 127.0 172.0 128.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 06:58:40 INFO - PROCESS | 8121 | Values: 161.0 160.0 159.0 160.0 161.0 161.0 160.0 161.0 162.0 160.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:12.12 (15.9%) stddev-sans-first:12.63 06:58:40 INFO - PROCESS | 8121 | Values: 75.0 76.0 75.0 110.0 79.0 75.0 76.0 77.0 97.0 74.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.50 stddev:12.61 (15.3%) stddev-sans-first:13.11 06:58:40 INFO - PROCESS | 8121 | Values: 83.0 83.0 112.0 82.0 82.0 83.0 100.0 83.0 81.0 111.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:58:40 INFO - PROCESS | 8121 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:2.17 (1.5%) stddev-sans-first:2.30 06:58:40 INFO - PROCESS | 8121 | Values: 147.0 147.0 147.0 148.0 148.0 153.0 145.0 146.0 146.0 148.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 06:58:40 INFO - PROCESS | 8121 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.87 06:58:40 INFO - PROCESS | 8121 | Values: 53.0 51.0 51.0 52.0 51.0 52.0 53.0 53.0 53.0 52.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 06:58:40 INFO - PROCESS | 8121 | Values: 61.0 61.0 60.0 59.0 60.0 61.0 60.0 59.0 60.0 60.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.50 stddev:2.92 (3.6%) stddev-sans-first:1.32 06:58:40 INFO - PROCESS | 8121 | Values: 89.0 80.0 80.0 80.0 81.0 80.0 80.0 84.0 80.0 81.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:133.00 stddev:12.39 (9.3%) stddev-sans-first:13.05 06:58:40 INFO - PROCESS | 8121 | Values: 140.0 129.0 128.0 147.0 134.0 127.0 129.0 127.0 166.0 132.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 06:58:40 INFO - PROCESS | 8121 | Values: 166.0 167.0 167.0 165.0 166.0 168.0 168.0 166.0 165.0 169.0 06:58:40 INFO - PROCESS | 8121 | 06:58:40 INFO - PROCESS | 8121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.43 (2.2%) stddev-sans-first:1.41 06:58:40 INFO - PROCESS | 8121 | Values: 67.0 68.0 67.0 65.0 65.0 65.0 64.0 64.0 66.0 64.0 06:58:40 INFO - PROCESS | 8121 | -------- Summary: end -------- 06:58:40 INFO - PROCESS | 8121 | 06:58:42 INFO - TEST-INFO | 8121: exit 0 06:58:42 INFO - TEST-OK | kraken | took 62458ms 06:58:42 INFO - SUITE-END | took 1178s 06:58:42 INFO - Completed test suite (00:19:39) 06:58:42 INFO - javascript benchmark 06:58:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2960.629921259843, 3006.654234763003, 3008.4133593949173, 3030.3030303030287, 3050.1459591314438, 5113.565346945505, 5188.766505507252, 5211.557017653495, 5286.497782710641, 5350.170723537848, 5223.112070947948, 5281.498257665526, 5334.759935802888, 5336.493033161843, 5343.492368225022, 4549.7701262317905, 4757.167495688241, 4776.092542416947, 4776.928346074812, 4814.7351895645725, 4883.218685010399, 4919.926201106986, 4923.82766603169, 4937.136001199776, 4972.353594032771, 4699.553542413465, 4753.263244197155, 4853.805847766085, 4926.679765815228, 4978.377702787152, 4700.600448961843, 4767.737774422405, 4802.375691160162, 4826.806927722887, 4835.395575553056, 4650.813967441332, 4654.743989080599, 4654.976725116353, 4708.176069187878, 4739.95260047402, 5173.689578625294, 5176.9741151294, 5192.532672059495, 5196.506331898464, 5252.23842542833, 5509.063459211943, 5510.91733623996, 5568.888622227573, 5581.2186293918885, 5603.60774745768, 5566.276384070085, 5615.101583746581, 5619.044762390404, 5624.775008999676, 5636.070048442002, 5230.712310822903, 5235.240890070919, 5238.92141617876, 5240.292560504321, 5302.1781623848365, 5651.576131790132, 5655.80204692842, 5708.743106560215, 5713.942860571341, 5714.457126572969, 5498.697571633518, 5512.118061110203, 5575.4424557543925, 5577.470140336662, 5581.079121944834, 5554.222408862763, 5568.638038527482, 5570.860728481739, 5571.13647384656, 5580.581456390787, 5423.240746295522, 5542.889142217133, 5556.77772889088, 5565.888682226333, 5609.046462101453, 5501.229827824108, 5505.834824955257, 5543.113101903757, 5546.223528705985, 5640.746166422521, 4310.504292006397, 4314.676399270067, 4315.633171180422, 4321.69748117635, 4367.432233809584, 3866.7293289469467, 3875.224955008953, 3887.78617176058, 3889.669378102836, 3903.902402439962, 5161.483851614808, 5206.219067139959, 5271.65734227274, 5320.52115309624, 5331.093714068617, 5624.943750562442, 5633.8591535211945, 5646.4353564644025, 5647.265855438849, 5703.515201207943, 5315.149576067888, 5322.893542129135, 5323.627346085815, 5328.307320048369, 5387.542058925035, 4677.345171675968, 4748.572628463455, 4751.572358487683, 4833.05755377698, 4841.830535931225, 5843.503302219359, 5955.106733989936, 5957.642541447527, 5963.373845746221, 5964.761409543657, 5648.0, 5681.233033540584, 5690.687012214368, 5692.231548740867, 5696.943030569641, 5885.323187833283, 5891.1457838614015, 5894.528437725057, 5896.528277737685, 5902.2327097477055, 5383.138697808332, 5499.0, 5501.614886957875, 5564.10974244119, 5570.136628822377, 5675.687837168995, 5676.318841738853, 5682.0908654616715, 5692.402297758841, 5737.799177028951, 5546.140348246028, 5547.944520554743, 5550.694711790728, 5552.167174923794, 5552.333719953632, 5217.8173763918085, 5322.680639161663, 5326.0945639240645, 5400.324959380077, 5559.082751345983, 5306.389765177054, 5314.867128321823, 5326.547243484347, 5330.067238233216, 5330.813421530228, 5408.513233808976, 5434.538064264424, 5439.020976224318, 5444.945550544602, 5446.782128714807, 5320.068987927175, 5374.516293533601, 5423.945760542344, 5440.646357986719, 5492.47821456961], "value": 5173.385383581746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.8107168623336, 586.243745568217, 605.2162449627732, 605.2646035067394, 616.2758758458809, 27841.721582784165, 28461.430771384585, 30086.0, 30474.0, 30488.847555762244, 42982.35526467105, 44076.77961610196, 44202.0, 48500.0, 48537.757311213485, 8889.155530224618, 9014.233790127848, 9036.548172591378, 9036.819263614723, 9038.276937844958, 7966.203379662016, 8916.687915922945, 8999.235065019448, 9006.144416280444, 9014.909850901473, 8159.714409995651, 10664.62673806417, 10927.235093543455, 10945.45272736364, 11376.829347559793, 10862.293950893207, 10927.344359338385, 10930.289531180528, 10935.179861510378, 10941.726456838564, 10654.200934929833, 10717.196210284183, 10734.141268698486, 10737.0, 10742.086922611586, 43110.0, 43361.34957975633, 43377.0, 43461.56538434607, 43497.78251108724, 3244.0, 3289.424350738635, 3295.4562497187935, 3354.1614596350914, 3378.527006219131, 31926.722931082728, 32203.83898080518, 33441.33117337664, 34013.31973360519, 34513.13717157066, 4291.120320334324, 4297.119090586422, 4408.889777755549, 4433.7118087324225, 4531.796069176895, 340820.0, 343418.0, 345484.0, 346117.0, 347682.0, 58139.0, 58526.70736646375, 58590.70704646449, 58628.70685646545, 58633.0, 62013.6281601987, 62022.0, 62065.68967155226, 62129.37870621326, 62150.68924655348, 15990.440334588466, 16003.679926401406, 16149.757753633705, 16180.595485112966, 16187.109708965885, 12492.437840297209, 12755.42600582976, 12755.553555625509, 12765.042621803403, 12765.61703148907, 15103.39586416553, 15463.443408015994, 15687.215639217993, 16700.248488818033, 17416.390426335016, 6217.720202590895, 6466.1481359369845, 6469.450096741735, 6511.218653761579, 6714.227863795629, 877.8200468903987, 926.7729406295366, 938.8555469724967, 1000.3047881722133, 1041.5937784264142, 31526.857211408893, 31937.52093718596, 31996.520052199237, 32197.195070122965, 32522.512162317584, 1069.668402795136, 1071.3036526257838, 1071.4374953149659, 1110.5779803674552, 1113.9498722557341, 16309.266083026292, 16772.664546709, 16845.915770421314, 16951.237194326284, 17287.222075006655, 501949.0, 503065.0, 503172.0, 503307.0, 503449.0, 50446.74776626093, 51729.0, 55934.160987585215, 57284.14073788896, 58198.0, 1314.6516173214106, 1334.4928927007675, 1347.932603369808, 1349.8582648821928, 1362.5163067111032, 30628.0, 32830.34339313248, 33125.668743313225, 33185.66814331922, 33204.50193247055, 52004.479955201474, 52731.73634131805, 52754.73622632016, 52941.0, 53015.0, 480395.0, 487474.0, 488661.0, 491818.0, 492083.0, 28059.298517537223, 28244.576331354634, 28416.85791571029, 28518.714812852435, 28572.714272857836, 47194.0, 47576.762116189195, 47584.2862357058, 47660.285095724284, 48143.5185648139, 39796.60203397929, 39969.40045899255, 40211.39682904817, 41710.374344384254, 42160.0, 40472.79763601163, 40683.389749154376, 41042.79478602588, 42186.57813421949, 42538.57461425346, 40489.19021619492, 41065.58934410618, 41139.177216456104, 41509.37735934024, 41949.580504194564, 34340.48489272613, 36543.45184822283, 36551.0, 36691.63308366989, 36959.63040369562, 27460.313492162855, 27532.17403477899, 27633.309167270174, 27949.0, 28180.15459536217], "value": 20014.053996137944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.69953239279016, 378.6610983170061, 403.4221325728593, 407.53337428644204, 408.6138599023923, 13115.754003369677, 14622.48821291255, 17325.5668608285, 19610.975755881303, 20028.399148025546, 19080.904595477004, 19561.413157605293, 19601.705974410394, 19800.207991680316, 19815.5046123847, 5153.6907785532985, 5666.801661941833, 5882.617629854067, 5916.911246331309, 5917.408259174092, 5244.475552444744, 5809.854753631151, 5834.56240781941, 5838.357780644125, 5841.269841269841, 5654.406287339832, 5657.264555607765, 5787.24765780448, 5797.449242321994, 5803.0, 5754.136879468092, 5807.303123625192, 5812.767489300423, 5820.272465941757, 5824.475797178253, 4985.426675932278, 5169.172932330809, 5206.895862082737, 5226.085435048889, 5229.921551176697, 23033.88483057574, 23148.18981335662, 23175.188868389694, 23246.65130023051, 23287.883560582257, 2254.3462395905167, 2270.9772902271097, 2286.7827556382117, 2330.685357476753, 2358.2217868103658, 13509.864901350958, 14284.57146285613, 14315.642108947255, 14355.846623006633, 14797.926010369987, 1898.7404789167012, 1902.4768188748205, 1930.7779605345283, 1944.6305202011713, 1969.1138987455702, 78149.05929105713, 81039.5948020268, 82118.58940705318, 82181.58909205475, 82662.17337826604, 10506.317089389318, 10689.732756681145, 10694.679159625224, 10695.358278503314, 11893.940530297294, 14990.47533336328, 15523.689526209413, 15544.45594404213, 15663.765043524356, 15704.136272504893, 8120.147384524658, 8206.143112737003, 8206.179382061746, 8309.709160179365, 8354.958225208835, 7932.444728869039, 7940.920590794133, 7945.364370850433, 8106.148854370324, 8120.269175774209, 6554.213494380705, 6628.933710662928, 6718.193816742022, 6729.629870357177, 6875.449964002868, 1927.4506765572025, 1941.9417417477216, 1976.5157536403385, 1986.503374156461, 1995.4213278149175, 884.3897710579679, 969.0745338202, 988.6539711101201, 1016.8169729448771, 1022.7903279827617, 19920.203191872162, 20267.898660506602, 20296.28962986318, 20298.89850550738, 20318.28885989013, 1007.2244371833647, 1027.7790275090892, 1048.5596049659162, 1051.1065594244983, 1052.652624633869, 10590.682279531626, 11029.83455248172, 11259.437028148559, 11443.14176436754, 11493.367864767351, 463398.0, 468822.0, 470056.0, 474680.0, 475615.0, 73650.63174684199, 76976.0, 77725.0, 78341.0, 78613.60693196497, 970.8106919150698, 995.576879826071, 1012.5797793915442, 1015.7155996321042, 1021.3361315145066, 16797.748033779746, 16960.23678934426, 17535.82464175393, 17867.0, 18135.093245337415, 39384.80307598443, 39804.80097599609, 39901.401478977255, 40624.39063413992, 40753.38869917013, 51984.48015519796, 52176.739116304176, 52330.21504677357, 53140.93718125693, 53267.4673253278, 7115.466340024415, 7985.960070199611, 8253.876191857007, 8336.041355243982, 8771.473711577326, 11853.0, 13269.601911942656, 13429.66425839362, 13458.798118028433, 13874.306284685927, 11184.328940263611, 11670.649880503599, 11818.290902545874, 11895.048396128463, 12207.924652808866, 11264.324140551593, 11489.82765258505, 11600.18798684084, 11637.592684256011, 11787.882121178678, 11487.770244595229, 11956.163068585116, 11961.401929903644, 12066.75866482683, 12118.575849845212, 8279.62741676614, 8435.746927592181, 8466.30673865217, 8592.097829727789, 8759.737207883774, 10194.490275486047, 11885.405729713653, 11929.164958453171, 12225.69435764113, 12398.504059837865], "value": 9278.05544131823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.319098855078, 1478.3864696151102, 1496.618362317609, 1675.388483203631, 1834.834864862163, 7566.621668916553, 8786.121387861218, 9163.037881022488, 9265.397749146301, 9522.95238523808, 9305.860412093823, 9379.812403751921, 9387.671431499899, 9394.0, 9396.0, 2296.908123675051, 2307.281075598677, 2321.9303420897318, 2329.790318871301, 2333.2533589251448, 2259.7062381890332, 2265.614845476273, 2327.813774898004, 2332.9766702333013, 2344.3318654183563, 2314.2710046335433, 2329.1731435340466, 2345.3433038749176, 2350.882455877208, 2354.4349356154485, 2251.5046689728233, 2279.0541925101065, 2281.612125938586, 2282.2126366403563, 2283.200879692111, 2248.5278091600785, 2252.4368907773055, 2255.605269077921, 2258.2547759239574, 2259.5029093599383, 9211.861822072675, 9287.72136835896, 9300.39547429415, 9309.767255818591, 9347.76630584234, 5179.430262671103, 5362.865928351784, 5429.049916264638, 5447.700376479292, 5482.91775623366, 3274.4433446314183, 3459.394605943975, 3512.4906888501023, 3515.771474854126, 3518.1556426457464, 1043.7338478687961, 1090.0571006079763, 1092.5902786455079, 1105.4362275239605, 1110.3227031510771, 12945.741085178244, 12953.158044727157, 13005.544805931842, 13051.86948130516, 13057.738845223232, 4389.758563279051, 4418.160549495586, 4595.448546174481, 4598.379218805485, 4690.906181876343, 10178.033086856736, 10183.083522483012, 10183.54174062169, 10184.338018028953, 10185.541650625739, 5311.867203319871, 5335.759890804846, 5383.67697938125, 5387.515123638813, 5402.081646120169, 4199.874003779892, 4459.2865141577195, 4590.77046147698, 4598.655100867449, 5010.774515146827, 3652.214773823641, 3685.9631403686158, 3717.3494638438706, 3771.283456143324, 3782.2813665403487, 1150.0, 1163.4415480569373, 1177.8998785103363, 1189.8155785853207, 1202.2305724336431, 818.995905020483, 829.9211025666609, 900.3742399032609, 936.0732874454242, 970.8592254123113, 5699.0, 5873.618214816023, 5959.940400596025, 6005.489533389711, 6101.389861013863, 452.21766344224676, 457.77340216593, 459.7632219407008, 1042.6455005298083, 1060.5439660945867, 3982.4623675803973, 4123.525794533607, 4130.215259100762, 4240.872773816791, 4295.52749197588, 11151.330920144817, 11519.078473722082, 11595.246308989888, 11603.535858565732, 11613.896679815403, 11452.484638191134, 11466.713332166595, 11475.942620286845, 11506.76986460266, 11519.942400288113, 8292.0, 8525.914740852511, 8631.093735157843, 8640.351973602004, 8645.740627781177, 5970.58205925581, 6061.848453788691, 6090.512758979183, 6162.506999440124, 6352.968235158794, 10445.806380660146, 10448.216383771096, 10521.631742888962, 10572.735681608021, 10652.89347106519, 8857.867131993155, 10560.0, 10570.735731606772, 10617.575296988034, 10730.463476825971, 7065.6113913735235, 7991.560464174526, 7992.280694737501, 8217.58912054383, 8224.958875205586, 8796.736097917073, 8812.823743524965, 8869.467831930106, 8892.377533572588, 8952.552372381486, 7830.33442157423, 7873.0945941215205, 7896.131425543071, 7931.841363172589, 8076.596170191349, 7721.189275126031, 7787.338076263581, 7791.026121734783, 7797.181295964069, 7849.843003140019, 6890.827729306607, 7102.4673149512955, 7157.785266442015, 7277.890831637424, 7303.342699156889, 4999.650024498395, 5065.7720402581235, 5178.663386879841, 5212.192110222922, 5212.452692467236, 4848.903021939471, 5134.101532231919, 5161.561267292323, 5399.163129714901, 5552.888942221214], "value": 4636.084149881465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.7180082830009, 334.5466892360851, 338.55818157304725, 341.8700893660408, 348.28080014769483, 5105.82566009817, 5228.320318358617, 5244.816431424901, 5282.6830390176565, 5327.747979224889, 5034.395872495296, 5141.22881567765, 5166.870828229296, 5173.715445650488, 5178.171492561191, 4147.6474499667565, 4154.356074808409, 4159.667226621863, 4161.126163505667, 4179.832806687728, 4041.2321658884716, 4116.242117781079, 4151.3150330195485, 4154.605312495308, 4193.308104162809, 4045.271851066807, 4081.2041651877894, 4094.549599544048, 4105.958940410587, 4117.279476091687, 4088.632023117919, 4091.4272001919753, 4101.794910254505, 4106.137711080662, 4151.8546850860375, 3665.120371110941, 3667.303212389664, 3674.0894734737785, 3682.2635472905527, 3691.354013047706, 4942.479335538901, 5045.192769156917, 5064.961682855006, 5070.264811602334, 5070.594352451832, 4684.156851766681, 4688.953110468886, 4695.577398034159, 4703.15343238217, 4715.481297057321, 5385.21914322425, 5401.540869026137, 5406.0, 5421.918671219895, 5437.782488700447, 3815.7328986970924, 3933.3903244997073, 3936.842526298973, 3950.960490395088, 3960.980195099035, 5556.749946252428, 5589.441055894418, 5608.214849921014, 5619.53891988082, 5630.887382252373, 4151.46031015966, 4167.5832416758685, 4172.374143878443, 4183.728057676241, 4187.958120418757, 3995.9400608990886, 4192.664586833046, 4193.685473589493, 4212.389203565527, 4231.365295205682, 4689.882752931204, 4691.498720409504, 4704.153252414599, 4706.458757242893, 4716.599089077398, 5476.151196564539, 5476.890462190734, 5479.643823151562, 5489.0, 5527.917081243784, 1325.6553296143072, 1350.6893414514716, 1415.8319386506173, 1436.7126574685105, 1450.8621680940294, 915.4187091197005, 929.2240978782658, 930.5161316115582, 933.8645896344992, 934.9719508414759, 4598.218302888517, 4622.745748983771, 4630.513796051366, 4643.0, 4650.6046986005895, 4843.370361852936, 4891.5353041461, 4897.436794768576, 4911.877203069952, 4913.65604407688, 4573.931391029138, 4594.632429405639, 4601.217792975202, 4624.306354046853, 4645.907081858344, 2732.9180124595896, 2931.6335458067742, 2954.49773538499, 2957.7225536337332, 2958.985205073961, 5766.135079737989, 5769.701817091121, 5784.161296611967, 5786.652800831879, 5829.766809327664, 5538.418466061086, 5655.745491452894, 5700.629459085146, 5705.2012718219485, 5742.885142297131, 5742.9562331964125, 5746.339170995306, 5764.308283006066, 5769.307683078057, 5773.942260577341, 5540.889182216414, 5555.50000499957, 5588.245586845724, 5589.301337332833, 5645.463680950304, 5256.894862102813, 5433.266509021231, 5511.448855114457, 5522.66863988162, 5550.38945715979, 5767.9134812977, 5774.711264436677, 5782.971085144547, 5787.768489260551, 5817.062383496307, 3828.751131176576, 3961.3067713149508, 3972.8609498668566, 3978.641922226898, 3987.5414327351564, 5278.656887302313, 5524.779008839601, 5530.585206109477, 5548.278723765885, 5567.192757050286, 5288.233206185005, 5358.223057656696, 5459.945400545944, 5486.735392441491, 5488.451154884479, 5451.536619387396, 5464.743109084853, 5467.753951072291, 5500.697461639488, 5502.257195278587, 5196.012500494464, 5365.463453654604, 5405.162199859028, 5405.567554595545, 5417.268668729671, 5432.538234250133, 5477.75350109238, 5483.862903427446, 5495.725213739377, 5518.586106041983, 5380.43505431924, 5399.46115357137, 5404.756785944721, 5413.648112872808, 5418.322709661293], "value": 4140.618469575548, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.4402940017067, 787.8069872881144, 791.3234184772022, 818.97133600324, 829.8796674482201, 11613.419329033535, 12110.212836165643, 15021.474248401308, 16169.676606467863, 16312.510624681248, 15501.457448989288, 16351.918240408811, 16379.262933168005, 16382.116056653489, 16432.507024789247, 801.6352559585404, 827.5986146718836, 828.0973738624898, 828.1759649149105, 829.9170082991712, 821.6590115102225, 824.0399934076794, 824.5671022713094, 824.9340052795762, 825.108882406999, 703.8838591632375, 725.5501589014818, 840.5965136734341, 868.9261412779921, 878.4860856399014, 860.1656393298553, 860.7288704058233, 861.0915484164204, 861.6510313323114, 861.7845538615346, 625.4777260987081, 625.583986648878, 626.28603392133, 626.3141859663662, 626.4894111299277, 15028.624284392869, 15066.171360575165, 15066.773998390034, 15079.698406031817, 15088.321025553876, 13990.440382384693, 14163.575092747235, 14303.642408939755, 14308.356123974447, 14376.137431754129, 12655.367231638382, 12767.42546585406, 12859.099863009593, 13179.670508237275, 13269.86730132696, 4193.622573968358, 4275.273203555403, 4295.978520107411, 4324.848630297956, 4481.7983190756495, 77320.0, 78240.21759782443, 78503.6074819628, 78577.60711196465, 78890.21109788887, 11110.388928608843, 11122.277051991594, 11135.721606959729, 11222.871866019323, 11285.541334316404, 21359.893200533897, 21468.0, 21544.89227553852, 21616.35150945474, 22347.217847375265, 8119.553424561587, 8236.588170591447, 8277.54473503951, 8286.4199506034, 8359.498430094214, 4526.569975852289, 4727.95272047282, 4749.501302363271, 4766.213574760126, 4792.400949881265, 3497.842597083137, 3639.3994990826745, 3641.5812181598926, 3649.306631740014, 3655.1958569114754, 532.653775046223, 678.803147087349, 686.4954258619911, 686.9690863911136, 698.7205117952758, 647.1457675867904, 693.7086423702058, 700.8598280343952, 704.4188544450849, 722.9566226026456, 9059.411138276122, 9397.295202859812, 9519.286053545873, 9877.209823214125, 9930.900690992998, 581.3575998521658, 584.9996505974746, 653.0139489371084, 672.7880717573948, 686.8111269400955, 4340.587644173798, 4508.143452743968, 4539.409876716006, 4562.201614717411, 4627.9074418511445, 79066.6046669763, 108219.45890270498, 110299.44850275698, 110523.44738276258, 110716.0, 63530.87049341778, 76269.0, 86405.56797215974, 96778.0, 99884.0, 74675.25324746792, 83922.58038709767, 85136.0, 85177.0, 88140.0, 9180.586873590571, 9243.21432678203, 9256.768580785534, 9551.952240238754, 9887.110160085627, 50165.74917125391, 50628.49371506385, 51836.70408239673, 52079.0, 53485.19772203498, 64458.0, 72674.0, 72953.27046729677, 75547.0, 78957.21042789498, 12508.0, 12754.170978886343, 12977.156484828456, 12981.221126732426, 13143.21140731521, 13597.388117534536, 13700.93149534246, 13969.371378288204, 14153.43386264579, 14168.574942751733, 13050.54323098687, 13560.186388816703, 14006.43974241019, 14502.1298722077, 14859.85140148628, 13957.0, 14076.436942522185, 14078.296085195903, 14089.788653170006, 14231.715365692835, 13084.542041028519, 13418.798718019432, 13873.930630346784, 13981.370838312097, 14006.649833754238, 11326.603568875049, 11601.651950441501, 11652.825207621723, 11730.296182229093, 11865.5847045353, 9779.773039032298, 10413.062824345845, 10478.318909270873, 11380.374079425712, 11479.311241325548], "value": 7515.01378647717, "unit": "score"}], "name": "dromaeo_css", "value": 7193.826465635769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 128.0, 174.0, 132.0, 123.0, 126.0, 127.0, 172.0, 128.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 110.0, 79.0, 75.0, 76.0, 77.0, 97.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 82.0, 82.0, 83.0, 100.0, 83.0, 81.0, 111.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 153.0, 145.0, 146.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 52.0, 51.0, 52.0, 53.0, 53.0, 53.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 59.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 80.0, 80.0, 81.0, 80.0, 80.0, 84.0, 80.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 129.0, 128.0, 147.0, 134.0, 127.0, 129.0, 127.0, 166.0, 132.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 167.0, 165.0, 166.0, 168.0, 168.0, 166.0, 165.0, 169.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1504.6000000000001, "alertThreshold": 2.0}]} 06:58:42 INFO - Return code: 0 06:58:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:58:42 INFO - # TBPL SUCCESS # 06:58:42 INFO - Running post-action listener: _resource_record_post_action 06:58:42 INFO - [mozharness: 2016-09-30 13:58:42.792416Z] Finished run-tests step (success) 06:58:42 INFO - Running post-run listener: _resource_record_post_run 06:58:42 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403861504; Read time: 12; Write time: 346976 06:58:42 INFO - TinderboxPrint: CPU usage
13.1% 06:58:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:58:42 INFO - TinderboxPrint: I/O write bytes / time
403,861,504 / 346,976 06:58:42 INFO - TinderboxPrint: CPU idle
8,300.8 (86.9%) 06:58:42 INFO - TinderboxPrint: CPU user
1,198.4 (12.5%) 06:58:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:58:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114167808; Read time: 0; Write time: 83132 06:58:42 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288796672; Read time: 0; Write time: 263820 06:58:43 INFO - Running post-run listener: _upload_blobber_files 06:58:43 INFO - Blob upload gear active. 06:58:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:43 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 06:58:43 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:58:43 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:58:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:44 INFO - (blobuploader) - INFO - Done attempting. 06:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:45 INFO - (blobuploader) - INFO - Done attempting. 06:58:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:58:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:50 INFO - (blobuploader) - INFO - Done attempting. 06:58:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:50 INFO - Return code: 0 06:58:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df062b2f975ac8048ea2ec4b8f26f37faab4d784727a7da91438256ec7e1f531cf3bc1d42f1c6997ffc26f4e8736f50ab5a05c269329bca233339aae84867d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4245f9a327fa971daee2745bb8cdb63dbcf8958fd10212dd0caca9513f0992b8d560bec77f9e84f26b9fbdcbd70e058317192733725dd9b12529de098b173ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe22633f4140596308e30156667e860c9b525847d3affb2437de6fdde5e37cdc018f22bd984e192b354ee2a12b6aa701f3dd242390f38ca1d1e7a5db5735304"} 06:58:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:50 INFO - Contents: 06:58:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df062b2f975ac8048ea2ec4b8f26f37faab4d784727a7da91438256ec7e1f531cf3bc1d42f1c6997ffc26f4e8736f50ab5a05c269329bca233339aae84867d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4245f9a327fa971daee2745bb8cdb63dbcf8958fd10212dd0caca9513f0992b8d560bec77f9e84f26b9fbdcbd70e058317192733725dd9b12529de098b173ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe22633f4140596308e30156667e860c9b525847d3affb2437de6fdde5e37cdc018f22bd984e192b354ee2a12b6aa701f3dd242390f38ca1d1e7a5db5735304"} 06:58:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:50 INFO - Copying logs to upload dir... 06:58:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.001404 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 06:58:50.210490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 06:58:50.214176) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df062b2f975ac8048ea2ec4b8f26f37faab4d784727a7da91438256ec7e1f531cf3bc1d42f1c6997ffc26f4e8736f50ab5a05c269329bca233339aae84867d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4245f9a327fa971daee2745bb8cdb63dbcf8958fd10212dd0caca9513f0992b8d560bec77f9e84f26b9fbdcbd70e058317192733725dd9b12529de098b173ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe22633f4140596308e30156667e860c9b525847d3affb2437de6fdde5e37cdc018f22bd984e192b354ee2a12b6aa701f3dd242390f38ca1d1e7a5db5735304"} build_url:https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/JbFErR1_QZqAm4xXVrgcZQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1df062b2f975ac8048ea2ec4b8f26f37faab4d784727a7da91438256ec7e1f531cf3bc1d42f1c6997ffc26f4e8736f50ab5a05c269329bca233339aae84867d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4245f9a327fa971daee2745bb8cdb63dbcf8958fd10212dd0caca9513f0992b8d560bec77f9e84f26b9fbdcbd70e058317192733725dd9b12529de098b173ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe22633f4140596308e30156667e860c9b525847d3affb2437de6fdde5e37cdc018f22bd984e192b354ee2a12b6aa701f3dd242390f38ca1d1e7a5db5735304"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 06:58:50.240390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:58:50.240782) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1475242687.411916-993999065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:58:50.324127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 06:58:50.324533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 06:58:50.324912) ========= ========= Total master_lag: 0.18 =========