builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1471964724.94 results: success (0) buildid: 20160823053002 builduid: 970d4e80ad184b738290bbe9033a4bc9 revision: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:24.943207) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:24.943585) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:24.943863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:24.972559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:24.972827) ========= 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=0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 08:05:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-08-23 08:05:25 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095649 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.082819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.083125) ========= 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=0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022345 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.133980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.134310) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cc027a0b80d20bfb271e906638e0cf140f3ba01 --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 8cc027a0b80d20bfb271e906638e0cf140f3ba01 --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=0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 08:05:25,667 truncating revision to first 12 chars 2016-08-23 08:05:25,667 Setting DEBUG logging. 2016-08-23 08:05:25,667 attempt 1/10 2016-08-23 08:05:25,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cc027a0b80d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 08:05:25,928 unpacking tar archive at: fx-team-8cc027a0b80d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.678849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.679180) ========= script_repo_revision: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.679589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.679866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:05:25.689224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-23 08:05:25.689512) ========= /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=0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:26 INFO - MultiFileLogger online at 20160823 08:05:26 in /builds/slave/test 08:05:26 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 08:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:26 INFO - {'append_to_log': False, 08:05:26 INFO - 'base_work_dir': '/builds/slave/test', 08:05:26 INFO - 'blob_upload_branch': 'Fx-Team', 08:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:26 INFO - 'branch': 'Fx-Team', 08:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:26 INFO - 'config_files': ('talos/linux_config.py',), 08:05:26 INFO - 'default_actions': ('clobber', 08:05:26 INFO - 'read-buildbot-config', 08:05:26 INFO - 'download-and-extract', 08:05:26 INFO - 'populate-webroot', 08:05:26 INFO - 'create-virtualenv', 08:05:26 INFO - 'install', 08:05:26 INFO - 'run-tests'), 08:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:26 INFO - 'download_minidump_stackwalk': True, 08:05:26 INFO - 'download_symbols': 'ondemand', 08:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:26 INFO - 'installer_path': 'installer.exe', 08:05:26 INFO - 'log_level': 'info', 08:05:26 INFO - 'log_name': 'talos', 08:05:26 INFO - 'log_to_console': True, 08:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:26 INFO - 'opt_config_files': (), 08:05:26 INFO - 'pip_index': False, 08:05:26 INFO - 'sps_profile': False, 08:05:26 INFO - 'sps_profile_interval': 0, 08:05:26 INFO - 'suite': 'dromaeojs', 08:05:26 INFO - 'system_bits': '32', 08:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:26 INFO - 'title': 'talos-linux64-ix-058', 08:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:26 INFO - 'use_talos_json': True, 08:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:26 INFO - 'work_dir': 'build'} 08:05:26 INFO - [mozharness: 2016-08-23 15:05:26.323321Z] Running clobber step. 08:05:26 INFO - Running pre-action listener: _resource_record_pre_action 08:05:26 INFO - Running main action method: clobber 08:05:26 INFO - rmtree: /builds/slave/test/build 08:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:26 INFO - Running post-action listener: _resource_record_post_action 08:05:26 INFO - [mozharness: 2016-08-23 15:05:26.794872Z] Finished clobber step (success) 08:05:26 INFO - [mozharness: 2016-08-23 15:05:26.794974Z] Running read-buildbot-config step. 08:05:26 INFO - Running pre-action listener: _resource_record_pre_action 08:05:26 INFO - Running main action method: read_buildbot_config 08:05:26 INFO - Using buildbot properties: 08:05:26 INFO - { 08:05:26 INFO - "project": "", 08:05:26 INFO - "product": "firefox", 08:05:26 INFO - "script_repo_revision": "production", 08:05:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:05:26 INFO - "repository": "", 08:05:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:05:26 INFO - "buildid": "20160823053002", 08:05:26 INFO - "pgo_build": "True", 08:05:26 INFO - "basedir": "/builds/slave/test", 08:05:26 INFO - "buildnumber": 385, 08:05:26 INFO - "slavename": "talos-linux64-ix-058", 08:05:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:05:26 INFO - "platform": "ubuntu64_hw", 08:05:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:05:26 INFO - "branch": "fx-team", 08:05:26 INFO - "repo_path": "integration/fx-team", 08:05:26 INFO - "revision": "8cc027a0b80d20bfb271e906638e0cf140f3ba01", 08:05:26 INFO - "stage_platform": "linux64-pgo", 08:05:26 INFO - "builduid": "970d4e80ad184b738290bbe9033a4bc9", 08:05:26 INFO - "slavebuilddir": "test" 08:05:26 INFO - } 08:05:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:05:26 INFO - Running post-action listener: _resource_record_post_action 08:05:26 INFO - [mozharness: 2016-08-23 15:05:26.797546Z] Finished read-buildbot-config step (success) 08:05:26 INFO - [mozharness: 2016-08-23 15:05:26.797633Z] Running download-and-extract step. 08:05:26 INFO - Running pre-action listener: _resource_record_pre_action 08:05:26 INFO - Running main action method: download_and_extract 08:05:26 INFO - mkdir: /builds/slave/test/build/tests 08:05: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')]} 08:05:26 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:05:27 INFO - Downloaded 1361 bytes. 08:05:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:05:27 INFO - Using the following test package requirements: 08:05:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'jsshell-linux-x86_64.zip'], 08:05:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:27 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:28 INFO - Downloaded 21919722 bytes. 08:05:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:05:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:32 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:33 INFO - Downloaded 21919722 bytes. 08:05:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:37 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:05:38 INFO - Downloaded 14413981 bytes. 08:05:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:05: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')]} 08:05:38 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:05:40 INFO - Downloaded 59785248 bytes. 08:05:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:40 INFO - mkdir: /builds/slave/test/properties 08:05:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:40 INFO - Contents: 08:05:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:40 INFO - Running post-action listener: _resource_record_post_action 08:05:40 INFO - Running post-action listener: set_extra_try_arguments 08:05:40 INFO - [mozharness: 2016-08-23 15:05:40.887454Z] Finished download-and-extract step (success) 08:05:40 INFO - [mozharness: 2016-08-23 15:05:40.887751Z] Running populate-webroot step. 08:05:40 INFO - Running pre-action listener: _resource_record_pre_action 08:05:40 INFO - Running main action method: populate_webroot 08:05:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:40 INFO - '--tppagecycles', 08:05:40 INFO - '7'], 08:05:40 INFO - 'tests': ['tsvgm']}}, 08:05:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['damp', 'tps']}, 08:05:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'tests': ['damp', 'tps']}, 08:05:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['dromaeo_dom']}, 08:05:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['basic_compositor_video']}, 08:05:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['a11yr', 08:05:40 INFO - 'ts_paint', 08:05:40 INFO - 'tpaint', 08:05:40 INFO - 'sessionrestore', 08:05:40 INFO - 'sessionrestore_no_auto_restore', 08:05:40 INFO - 'tabpaint']}, 08:05:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:40 INFO - 'ts_paint', 08:05:40 INFO - 'tpaint', 08:05:40 INFO - 'sessionrestore', 08:05:40 INFO - 'sessionrestore_no_auto_restore', 08:05:40 INFO - 'tabpaint']}, 08:05:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:40 INFO - 'ts_paint', 08:05:40 INFO - 'tpaint', 08:05:40 INFO - 'sessionrestore', 08:05:40 INFO - 'sessionrestore_no_auto_restore', 08:05:40 INFO - 'tabpaint']}, 08:05:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:40 INFO - 'ts_paint', 08:05:40 INFO - 'tpaint', 08:05:40 INFO - 'sessionrestore', 08:05:40 INFO - 'sessionrestore_no_auto_restore', 08:05:40 INFO - 'tabpaint']}, 08:05:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['a11yr', 08:05:40 INFO - 'ts_paint', 08:05:40 INFO - 'tpaint', 08:05:40 INFO - 'sessionrestore', 08:05:40 INFO - 'sessionrestore_no_auto_restore', 08:05:40 INFO - 'tabpaint']}, 08:05:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['a11yr', 08:05:40 INFO - 'ts_paint', 08:05:40 INFO - 'tpaint', 08:05:40 INFO - 'sessionrestore', 08:05:40 INFO - 'sessionrestore_no_auto_restore', 08:05:40 INFO - 'tabpaint']}, 08:05:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['tsvgx', 08:05:40 INFO - 'tsvgr_opacity', 08:05:40 INFO - 'tart', 08:05:40 INFO - 'tscrollx', 08:05:40 INFO - 'cart']}, 08:05:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:40 INFO - 'tsvgr_opacity', 08:05:40 INFO - 'tart', 08:05:40 INFO - 'tscrollx', 08:05:40 INFO - 'cart']}, 08:05:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'talos_options': ['--disable-e10s'], 08:05:40 INFO - 'tests': ['tp5o']}, 08:05:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'tests': ['tp5o']}, 08:05:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'talos_options': ['--disable-e10s', 08:05:40 INFO - '--xperf_path', 08:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:40 INFO - 'tests': ['tp5n']}, 08:05:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:40 INFO - 'talos_options': ['--xperf_path', 08:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:40 INFO - 'tests': ['tp5n']}}, 08:05:40 INFO - 'talos.zip': {'path': '', 08:05:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:40 INFO - Running post-action listener: _resource_record_post_action 08:05:40 INFO - [mozharness: 2016-08-23 15:05:40.911006Z] Finished populate-webroot step (success) 08:05:40 INFO - [mozharness: 2016-08-23 15:05:40.911099Z] Running create-virtualenv step. 08:05:40 INFO - Running pre-action listener: _resource_record_pre_action 08:05:40 INFO - Running main action method: create_virtualenv 08:05:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:05:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:41 INFO - Using real prefix '/usr' 08:05:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:43 INFO - Installing pip.................done. 08:05:43 INFO - Return code: 0 08:05:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:43 INFO - Using env: {'DISPLAY': ':0', 08:05:43 INFO - 'HOME': '/home/cltbld', 08:05:43 INFO - 'LANG': 'en_US.UTF-8', 08:05:43 INFO - 'LANGUAGE': 'en_US:en', 08:05:43 INFO - 'LOGNAME': 'cltbld', 08:05:43 INFO - 'MAIL': '/var/mail/cltbld', 08:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:43 INFO - 'MOZ_NO_REMOTE': '1', 08:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:43 INFO - 'NO_EM_RESTART': '1', 08:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:43 INFO - 'PWD': '/builds/slave/test', 08:05:43 INFO - 'SHELL': '/bin/bash', 08:05:43 INFO - 'SHLVL': '1', 08:05:43 INFO - 'TERM': 'linux', 08:05:43 INFO - 'TMOUT': '86400', 08:05:43 INFO - 'USER': 'cltbld', 08:05:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:43 INFO - '_': '/tools/buildbot/bin/python'} 08:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:05:43 INFO - Cleaning up... 08:05:43 INFO - Return code: 0 08:05:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:43 INFO - Using env: {'DISPLAY': ':0', 08:05:43 INFO - 'HOME': '/home/cltbld', 08:05:43 INFO - 'LANG': 'en_US.UTF-8', 08:05:43 INFO - 'LANGUAGE': 'en_US:en', 08:05:43 INFO - 'LOGNAME': 'cltbld', 08:05:43 INFO - 'MAIL': '/var/mail/cltbld', 08:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:43 INFO - 'MOZ_NO_REMOTE': '1', 08:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:43 INFO - 'NO_EM_RESTART': '1', 08:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:43 INFO - 'PWD': '/builds/slave/test', 08:05:43 INFO - 'SHELL': '/bin/bash', 08:05:43 INFO - 'SHLVL': '1', 08:05:43 INFO - 'TERM': 'linux', 08:05:43 INFO - 'TMOUT': '86400', 08:05:43 INFO - 'USER': 'cltbld', 08:05:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:43 INFO - '_': '/tools/buildbot/bin/python'} 08:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:43 INFO - Downloading/unpacking psutil>=3.1.1 08:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:45 INFO - Installing collected packages: psutil 08:05:45 INFO - Running setup.py install for psutil 08:05:45 INFO - building 'psutil._psutil_linux' extension 08:05:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:05:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:05:46 INFO - building 'psutil._psutil_posix' extension 08:05:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:05:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:46 INFO - Successfully installed psutil 08:05:46 INFO - Cleaning up... 08:05:46 INFO - Return code: 0 08:05:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:46 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:05:46 INFO - Using env: {'DISPLAY': ':0', 08:05:46 INFO - 'HOME': '/home/cltbld', 08:05:46 INFO - 'LANG': 'en_US.UTF-8', 08:05:46 INFO - 'LANGUAGE': 'en_US:en', 08:05:46 INFO - 'LOGNAME': 'cltbld', 08:05:46 INFO - 'MAIL': '/var/mail/cltbld', 08:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:46 INFO - 'MOZ_NO_REMOTE': '1', 08:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:46 INFO - 'NO_EM_RESTART': '1', 08:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:46 INFO - 'PWD': '/builds/slave/test', 08:05:46 INFO - 'SHELL': '/bin/bash', 08:05:46 INFO - 'SHLVL': '1', 08:05:46 INFO - 'TERM': 'linux', 08:05:46 INFO - 'TMOUT': '86400', 08:05:46 INFO - 'USER': 'cltbld', 08:05:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:46 INFO - '_': '/tools/buildbot/bin/python'} 08:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:48 INFO - Installing collected packages: mozsystemmonitor 08:05:48 INFO - Running setup.py install for mozsystemmonitor 08:05:48 INFO - Successfully installed mozsystemmonitor 08:05:48 INFO - Cleaning up... 08:05:48 INFO - Return code: 0 08:05:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:48 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:05:48 INFO - Using env: {'DISPLAY': ':0', 08:05:48 INFO - 'HOME': '/home/cltbld', 08:05:48 INFO - 'LANG': 'en_US.UTF-8', 08:05:48 INFO - 'LANGUAGE': 'en_US:en', 08:05:48 INFO - 'LOGNAME': 'cltbld', 08:05:48 INFO - 'MAIL': '/var/mail/cltbld', 08:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:48 INFO - 'MOZ_NO_REMOTE': '1', 08:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:48 INFO - 'NO_EM_RESTART': '1', 08:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:48 INFO - 'PWD': '/builds/slave/test', 08:05:48 INFO - 'SHELL': '/bin/bash', 08:05:48 INFO - 'SHLVL': '1', 08:05:48 INFO - 'TERM': 'linux', 08:05:48 INFO - 'TMOUT': '86400', 08:05:48 INFO - 'USER': 'cltbld', 08:05:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:48 INFO - '_': '/tools/buildbot/bin/python'} 08:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:51 INFO - warning: no files found matching '*.txt' 08:05:51 INFO - no previously-included directories found matching 'build' 08:05:51 INFO - no previously-included directories found matching 'dist' 08:05:51 INFO - no previously-included directories found matching '.git*' 08:05:51 INFO - Installing collected packages: jsonschema, functools32 08:05:51 INFO - Running setup.py install for functools32 08:05:51 INFO - warning: no files found matching '*.txt' 08:05:51 INFO - no previously-included directories found matching 'build' 08:05:51 INFO - no previously-included directories found matching 'dist' 08:05:51 INFO - no previously-included directories found matching '.git*' 08:05:51 INFO - Successfully installed jsonschema functools32 08:05:51 INFO - Cleaning up... 08:05:51 INFO - Return code: 0 08:05:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:05:51 INFO - Using env: {'DISPLAY': ':0', 08:05:51 INFO - 'HOME': '/home/cltbld', 08:05:51 INFO - 'LANG': 'en_US.UTF-8', 08:05:51 INFO - 'LANGUAGE': 'en_US:en', 08:05:51 INFO - 'LOGNAME': 'cltbld', 08:05:51 INFO - 'MAIL': '/var/mail/cltbld', 08:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:51 INFO - 'MOZ_NO_REMOTE': '1', 08:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:51 INFO - 'NO_EM_RESTART': '1', 08:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:51 INFO - 'PWD': '/builds/slave/test', 08:05:51 INFO - 'SHELL': '/bin/bash', 08:05:51 INFO - 'SHLVL': '1', 08:05:51 INFO - 'TERM': 'linux', 08:05:51 INFO - 'TMOUT': '86400', 08:05:51 INFO - 'USER': 'cltbld', 08:05:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:51 INFO - '_': '/tools/buildbot/bin/python'} 08:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:05:51 INFO - Cleaning up... 08:05:51 INFO - Return code: 0 08:05:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:51 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:51 INFO - Using env: {'DISPLAY': ':0', 08:05:51 INFO - 'HOME': '/home/cltbld', 08:05:51 INFO - 'LANG': 'en_US.UTF-8', 08:05:51 INFO - 'LANGUAGE': 'en_US:en', 08:05:51 INFO - 'LOGNAME': 'cltbld', 08:05:51 INFO - 'MAIL': '/var/mail/cltbld', 08:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:51 INFO - 'MOZ_NO_REMOTE': '1', 08:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:51 INFO - 'NO_EM_RESTART': '1', 08:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:51 INFO - 'PWD': '/builds/slave/test', 08:05:51 INFO - 'SHELL': '/bin/bash', 08:05:51 INFO - 'SHLVL': '1', 08:05:51 INFO - 'TERM': 'linux', 08:05:51 INFO - 'TMOUT': '86400', 08:05:51 INFO - 'USER': 'cltbld', 08:05:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:51 INFO - '_': '/tools/buildbot/bin/python'} 08:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:54 INFO - Downloading docopt-0.6.1.tar.gz 08:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:54 INFO - Running setup.py install for blobuploader 08:05:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:54 INFO - Running setup.py install for requests 08:05:54 INFO - Running setup.py install for docopt 08:05:54 INFO - Successfully installed blobuploader requests docopt 08:05:54 INFO - Cleaning up... 08:05:55 INFO - Return code: 0 08:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:55 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:55 INFO - Using env: {'DISPLAY': ':0', 08:05:55 INFO - 'HOME': '/home/cltbld', 08:05:55 INFO - 'LANG': 'en_US.UTF-8', 08:05:55 INFO - 'LANGUAGE': 'en_US:en', 08:05:55 INFO - 'LOGNAME': 'cltbld', 08:05:55 INFO - 'MAIL': '/var/mail/cltbld', 08:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:55 INFO - 'MOZ_NO_REMOTE': '1', 08:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:55 INFO - 'NO_EM_RESTART': '1', 08:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:55 INFO - 'PWD': '/builds/slave/test', 08:05:55 INFO - 'SHELL': '/bin/bash', 08:05:55 INFO - 'SHLVL': '1', 08:05:55 INFO - 'TERM': 'linux', 08:05:55 INFO - 'TMOUT': '86400', 08:05:55 INFO - 'USER': 'cltbld', 08:05:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:55 INFO - '_': '/tools/buildbot/bin/python'} 08:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:55 INFO - Running setup.py (path:/tmp/pip-ks7FBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:55 INFO - Running setup.py (path:/tmp/pip-Grq3Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:55 INFO - Running setup.py (path:/tmp/pip-eA0k9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:55 INFO - Running setup.py (path:/tmp/pip-_hht7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:55 INFO - Running setup.py (path:/tmp/pip-V0vFsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:55 INFO - Running setup.py (path:/tmp/pip-IiSmww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:55 INFO - Running setup.py (path:/tmp/pip-lUoS6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:55 INFO - Running setup.py (path:/tmp/pip-Ekupcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:55 INFO - Running setup.py (path:/tmp/pip-SGvTrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:55 INFO - Running setup.py (path:/tmp/pip-szQ75r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:55 INFO - Running setup.py (path:/tmp/pip-oMtt8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:56 INFO - Running setup.py (path:/tmp/pip-8mk57L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:56 INFO - Running setup.py (path:/tmp/pip-TC7q9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:56 INFO - Running setup.py (path:/tmp/pip-zUYUOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:56 INFO - Running setup.py (path:/tmp/pip-udo_X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:56 INFO - Running setup.py (path:/tmp/pip-vfGaa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:56 INFO - Running setup.py (path:/tmp/pip-6qGNUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:56 INFO - Running setup.py install for manifestparser 08:05:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:56 INFO - Running setup.py install for mozcrash 08:05:56 INFO - Running setup.py install for mozdebug 08:05:56 INFO - Running setup.py install for mozdevice 08:05:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:56 INFO - Running setup.py install for mozfile 08:05:57 INFO - Running setup.py install for mozhttpd 08:05:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for mozinfo 08:05:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for mozInstall 08:05:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for mozleak 08:05:57 INFO - Running setup.py install for mozlog 08:05:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for moznetwork 08:05:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for mozprocess 08:05:57 INFO - Running setup.py install for mozprofile 08:05:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for mozrunner 08:05:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:57 INFO - Running setup.py install for mozscreenshot 08:05:58 INFO - Running setup.py install for moztest 08:05:58 INFO - Running setup.py install for mozversion 08:05:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:58 INFO - Cleaning up... 08:05:58 INFO - Return code: 0 08:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:58 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:58 INFO - Using env: {'DISPLAY': ':0', 08:05:58 INFO - 'HOME': '/home/cltbld', 08:05:58 INFO - 'LANG': 'en_US.UTF-8', 08:05:58 INFO - 'LANGUAGE': 'en_US:en', 08:05:58 INFO - 'LOGNAME': 'cltbld', 08:05:58 INFO - 'MAIL': '/var/mail/cltbld', 08:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:58 INFO - 'MOZ_NO_REMOTE': '1', 08:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:58 INFO - 'NO_EM_RESTART': '1', 08:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:58 INFO - 'PWD': '/builds/slave/test', 08:05:58 INFO - 'SHELL': '/bin/bash', 08:05:58 INFO - 'SHLVL': '1', 08:05:58 INFO - 'TERM': 'linux', 08:05:58 INFO - 'TMOUT': '86400', 08:05:58 INFO - 'USER': 'cltbld', 08:05:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:58 INFO - '_': '/tools/buildbot/bin/python'} 08:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:58 INFO - Running setup.py (path:/tmp/pip-U_gd5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:58 INFO - Running setup.py (path:/tmp/pip-BldsXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:58 INFO - Running setup.py (path:/tmp/pip-1d0ITk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:58 INFO - Running setup.py (path:/tmp/pip-y0xk7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:58 INFO - Running setup.py (path:/tmp/pip-Ddpd3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:58 INFO - Running setup.py (path:/tmp/pip-w_j2T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:58 INFO - Running setup.py (path:/tmp/pip-B4_LuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:59 INFO - Running setup.py (path:/tmp/pip-tZD27I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:59 INFO - Running setup.py (path:/tmp/pip-x3tVPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:59 INFO - Running setup.py (path:/tmp/pip-zarR1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:59 INFO - Running setup.py (path:/tmp/pip-FarV68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:59 INFO - Running setup.py (path:/tmp/pip-jDz1vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:59 INFO - Running setup.py (path:/tmp/pip-caHAPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:59 INFO - Running setup.py (path:/tmp/pip-KfsGUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:59 INFO - Running setup.py (path:/tmp/pip-PFfmQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:59 INFO - Running setup.py (path:/tmp/pip-2SzJyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:59 INFO - Running setup.py (path:/tmp/pip-bYQxDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:01 INFO - Downloading blessings-1.6.tar.gz 08:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:01 INFO - Installing collected packages: blessings 08:06:01 INFO - Running setup.py install for blessings 08:06:01 INFO - Successfully installed blessings 08:06:01 INFO - Cleaning up... 08:06:01 INFO - Return code: 0 08:06:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:02 INFO - Reading from file tmpfile_stdout 08:06:02 INFO - Current package versions: 08:06:02 INFO - argparse == 1.2.1 08:06:02 INFO - blessings == 1.6 08:06:02 INFO - blobuploader == 1.2.4 08:06:02 INFO - docopt == 0.6.1 08:06:02 INFO - functools32 == 3.2.3-2 08:06:02 INFO - jsonschema == 2.5.1 08:06:02 INFO - manifestparser == 1.1 08:06:02 INFO - mozInstall == 1.12 08:06:02 INFO - mozcrash == 0.17 08:06:02 INFO - mozdebug == 0.1 08:06:02 INFO - mozdevice == 0.48 08:06:02 INFO - mozfile == 1.2 08:06:02 INFO - mozhttpd == 0.7 08:06:02 INFO - mozinfo == 0.9 08:06:02 INFO - mozleak == 0.1 08:06:02 INFO - mozlog == 3.3 08:06:02 INFO - moznetwork == 0.27 08:06:02 INFO - mozprocess == 0.23 08:06:02 INFO - mozprofile == 0.28 08:06:02 INFO - mozrunner == 6.12 08:06:02 INFO - mozscreenshot == 0.1 08:06:02 INFO - mozsystemmonitor == 0.3 08:06:02 INFO - moztest == 0.7 08:06:02 INFO - mozversion == 1.4 08:06:02 INFO - psutil == 3.1.1 08:06:02 INFO - requests == 1.2.3 08:06:02 INFO - wsgiref == 0.1.2 08:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:06:02 INFO - Using env: {'DISPLAY': ':0', 08:06:02 INFO - 'HOME': '/home/cltbld', 08:06:02 INFO - 'LANG': 'en_US.UTF-8', 08:06:02 INFO - 'LANGUAGE': 'en_US:en', 08:06:02 INFO - 'LOGNAME': 'cltbld', 08:06:02 INFO - 'MAIL': '/var/mail/cltbld', 08:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:02 INFO - 'MOZ_NO_REMOTE': '1', 08:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:02 INFO - 'NO_EM_RESTART': '1', 08:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:02 INFO - 'PWD': '/builds/slave/test', 08:06:02 INFO - 'SHELL': '/bin/bash', 08:06:02 INFO - 'SHLVL': '1', 08:06:02 INFO - 'TERM': 'linux', 08:06:02 INFO - 'TMOUT': '86400', 08:06:02 INFO - 'USER': 'cltbld', 08:06:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:02 INFO - '_': '/tools/buildbot/bin/python'} 08:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:06:02 INFO - Cleaning up... 08:06:02 INFO - Return code: 0 08:06:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:02 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 0x7f2031e41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, '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': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:06:02 INFO - Using env: {'DISPLAY': ':0', 08:06:02 INFO - 'HOME': '/home/cltbld', 08:06:02 INFO - 'LANG': 'en_US.UTF-8', 08:06:02 INFO - 'LANGUAGE': 'en_US:en', 08:06:02 INFO - 'LOGNAME': 'cltbld', 08:06:02 INFO - 'MAIL': '/var/mail/cltbld', 08:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:02 INFO - 'MOZ_NO_REMOTE': '1', 08:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:02 INFO - 'NO_EM_RESTART': '1', 08:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:02 INFO - 'PWD': '/builds/slave/test', 08:06:02 INFO - 'SHELL': '/bin/bash', 08:06:02 INFO - 'SHLVL': '1', 08:06:02 INFO - 'TERM': 'linux', 08:06:02 INFO - 'TMOUT': '86400', 08:06:02 INFO - 'USER': 'cltbld', 08:06:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:02 INFO - '_': '/tools/buildbot/bin/python'} 08:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:06:02 INFO - Cleaning up... 08:06:02 INFO - Return code: 0 08:06:02 INFO - Running post-action listener: _resource_record_post_action 08:06:02 INFO - Running post-action listener: _start_resource_monitoring 08:06:02 INFO - Starting resource monitoring. 08:06:02 INFO - [mozharness: 2016-08-23 15:06:02.610377Z] Finished create-virtualenv step (success) 08:06:02 INFO - [mozharness: 2016-08-23 15:06:02.610835Z] Running install step. 08:06:02 INFO - Running pre-action listener: _resource_record_pre_action 08:06:02 INFO - Running main action method: install 08:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:02 INFO - Reading from file tmpfile_stdout 08:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:02 INFO - Reading from file tmpfile_stdout 08:06:02 INFO - Output received: 08:06:02 INFO - Usage: mozinstall [options] installer 08:06:02 INFO - Options: 08:06:02 INFO - -h, --help show this help message and exit 08:06:02 INFO - -d DEST, --destination=DEST 08:06:02 INFO - Directory to install application into. [default: 08:06:02 INFO - "/builds/slave/test"] 08:06:02 INFO - --app=APP Application being installed. [default: firefox] 08:06:02 INFO - mkdir: /builds/slave/test/build/application 08:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:06:20 INFO - Reading from file tmpfile_stdout 08:06:20 INFO - Output received: 08:06:20 INFO - /builds/slave/test/build/application/firefox/firefox 08:06:20 INFO - Running post-action listener: _resource_record_post_action 08:06:20 INFO - [mozharness: 2016-08-23 15:06:20.105090Z] Finished install step (success) 08:06:20 INFO - [mozharness: 2016-08-23 15:06:20.105341Z] Running run-tests step. 08:06:20 INFO - Running pre-action listener: _resource_record_pre_action 08:06:20 INFO - Running main action method: run_tests 08:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:06:20 INFO - Python 2.7.3 08:06:20 INFO - Return code: 0 08:06:20 INFO - grabbing minidump binary from tooltool 08:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:20 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 0x2326370>, '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 0x23298f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:06:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:06:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:06:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:06:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:06:20 INFO - Return code: 0 08:06:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:06:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:06:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:06:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:06:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:06:20 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/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:06:20 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/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:06:20 INFO - Using env: {'DISPLAY': ':0', 08:06:20 INFO - 'HOME': '/home/cltbld', 08:06:20 INFO - 'LANG': 'en_US.UTF-8', 08:06:20 INFO - 'LANGUAGE': 'en_US:en', 08:06:20 INFO - 'LOGNAME': 'cltbld', 08:06:20 INFO - 'MAIL': '/var/mail/cltbld', 08:06:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:20 INFO - 'MOZ_NO_REMOTE': '1', 08:06:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:20 INFO - 'NO_EM_RESTART': '1', 08:06:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:20 INFO - 'PWD': '/builds/slave/test', 08:06:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:20 INFO - 'SHELL': '/bin/bash', 08:06:20 INFO - 'SHLVL': '1', 08:06:20 INFO - 'TERM': 'linux', 08:06:20 INFO - 'TMOUT': '86400', 08:06:20 INFO - 'USER': 'cltbld', 08:06:20 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989', 08:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:20 INFO - '_': '/tools/buildbot/bin/python'} 08:06:20 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/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:06:20 INFO - mozversion application_buildid: 20160823053002 08:06:20 INFO - mozversion application_changeset: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 08:06:20 INFO - mozversion application_display_name: Nightly 08:06:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:20 INFO - mozversion application_name: Firefox 08:06:20 INFO - mozversion application_remotingname: firefox 08:06:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:06:20 INFO - mozversion application_vendor: Mozilla 08:06:20 INFO - mozversion application_version: 51.0a1 08:06:20 INFO - mozversion platform_buildid: 20160823053002 08:06:20 INFO - mozversion platform_changeset: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 08:06:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:06:20 INFO - mozversion platform_version: 51.0a1 08:06:20 INFO - using testdate: 1471964780 08:06:20 INFO - actual date: 1471964780 08:06:20 INFO - starting webserver on 'localhost:36441' 08:06:20 INFO - SUITE-START | Running 2 tests 08:06:20 INFO - TEST-START | dromaeo_css 08:06:20 INFO - operating with platform_type : linux_ 08:06:20 INFO - Initialising browser for dromaeo_css test... 08:06:20 INFO - TEST-INFO | started process 11784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnZBZEq/profile http://localhost:36441/getInfo.html) 08:06:24 INFO - PROCESS | 11784 | __metrics Screen width/height:1600/1200 08:06:24 INFO - PROCESS | 11784 | colorDepth:24 08:06:24 INFO - PROCESS | 11784 | Browser inner width/height: 1024/697 08:06:24 INFO - PROCESS | 11784 | __metrics 08:06:25 INFO - PROCESS | 11784 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:25 INFO - PROCESS | 11784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:25 INFO - PROCESS | 11784 | console.error: PushService: 08:06:25 INFO - PROCESS | 11784 | stateChangeProcessEnqueue: Error transitioning state 08:06:25 INFO - PROCESS | 11784 | UnknownError 08:06:26 INFO - TEST-INFO | 11784: exit 0 08:06:26 INFO - Browser initialized. 08:06:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:26 INFO - TEST-INFO | started process 11867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnZBZEq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:38 INFO - PROCESS | 11867 | RSS: Main: 174612480 08:06:38 INFO - PROCESS | 11867 | 08:07:29 INFO - PROCESS | 11867 | 1471964849903 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:09:39 INFO - PROCESS | 11867 | Cycle 1(1): loaded http://localhost:36441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36441/tests/dromaeo/cssquery-ext.html) 08:09:40 INFO - PROCESS | 11867 | RSS: Main: 275136512 08:09:40 INFO - PROCESS | 11867 | 08:12:42 INFO - PROCESS | 11867 | Cycle 1(1): loaded http://localhost:36441/tests/dromaeo/cssquery-ext.html (next: http://localhost:36441/tests/dromaeo/cssquery-jquery.html) 08:12:43 INFO - PROCESS | 11867 | RSS: Main: 273092608 08:12:43 INFO - PROCESS | 11867 | 08:15:45 INFO - PROCESS | 11867 | Cycle 1(1): loaded http://localhost:36441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36441/tests/dromaeo/cssquery-mootools.html) 08:15:46 INFO - PROCESS | 11867 | RSS: Main: 272846848 08:15:46 INFO - PROCESS | 11867 | 08:18:48 INFO - PROCESS | 11867 | Cycle 1(1): loaded http://localhost:36441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36441/tests/dromaeo/cssquery-prototype.html) 08:18:48 INFO - PROCESS | 11867 | RSS: Main: 263684096 08:18:48 INFO - PROCESS | 11867 | 08:21:51 INFO - PROCESS | 11867 | Cycle 1(1): loaded http://localhost:36441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36441/tests/dromaeo/cssquery-yui.html) 08:21:52 INFO - PROCESS | 11867 | RSS: Main: 219369472 08:21:52 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | Cycle 1(1): loaded http://localhost:36441/tests/dromaeo/cssquery-yui.html (next: http://localhost:36441/tests/dromaeo/cssquery-dojo.html) 08:24:55 INFO - PROCESS | 11867 | RSS: Main: 300986368 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | __start_tp_report 08:24:55 INFO - PROCESS | 11867 | _x_x_mozilla_page_load 08:24:55 INFO - PROCESS | 11867 | _x_x_mozilla_page_load_details 08:24:55 INFO - PROCESS | 11867 | |i|pagename|runs| 08:24:55 INFO - PROCESS | 11867 | |0;dojo.html;3000.0249918776394;3014.3971205758853;3023.894163704271;3045.2843581758284;3046.817190968542;5154.201098829678;5206.401263854658;5206.479352064792;5235.214717792328;5300.6819590824525;5243.632945693803;5290.947090529094;5306.257124002643;5373.623846330758;5384.703841288728;4833.299171620113;4893.363862697862;4953.306537084811;4994.300797888299;5007.824726134586;4922.901541969159;4957.752112394384;4976.626752993522;4982.053409852135;5019;4751.976240118812;4808.278758186265;4922.680025798311;4935.210366341404;4975.378077740283;4765.11845308619;4797.160496913027;4826.517348265181;4836.733979631119;4930.383702037246;4837.250226214942;4850.490698476679;4869.245266983623;4871.658983871131;4884.365032545782;5360.892782144374;5375.381831089397;5377.838664840061;5385.757640906129;5387.164989426645;5474;5566.025945459528;5612.887742245173;5622.156676498517;5709.8287051388525;5739.454751798572;5743.425657434265;5747.712614369307;5753.194552762617;5755.366909639936;5348.304720386363;5353.544948679367;5355.732213389393;5362.329708786402;5362.892742145214;5663.405342438985;5720.342160651495;5746.88506229873;5754.88490230193;5872.911906321408;5558.249636299129;5649.491545760901;5652.63257888236;5656.066748986371;5661.631993920464;5726.541876649858;5728.05487094633;5738.483536481736;5740.167675687086;5744.023516002289;5487.945120548823;5514.531264842533;5563.693996830132;5571.220029195916;5647.858803529944;5640.85897852557;5643.322801263875;5645.68948707825;5649.576281778883;5652.406497317805;4397.296432570837;4397.802098905557;4401.207782599163;4410.757408342508;4417.712848664826;3864.7101467390057;3907.9218415631526;3925.725199236026;3963.8810835674976;4055.4727885374714;5366.973165134227;5442.2380866678695;5442.945570544323;5444.618876678674;5455.318085239345;5827.446392592697;5841.88316233673;5844.035734103911;5846.269216347957;5848.64908105515;5259.76331065103;5299.178627312773;5300.681959082467;5353.86615334612;5362.061639213122;4979.402471703419;4982.476839931827;4983.451820299764;4985.501449854985;4986.376702912136;5913.674747888907;5924.7926322578505;5927.822165334961;5928;5929.9110513341475;5530.170474428868;5640.746166422603;5745.770169193185;5751.396103409082;5829.76680932758;5923.703814809156;5945.078512830518;5978.073398623221;5982.611130276692;5983.970080149571;5609.074502707008;5632.690202038763;5634.154876768517;5634.352049514195;5635.605507614428;5558.749856256559;5599.132134519156;5600.159976003632;5624.550035997192;5734.455226753452;5554.389017208023;5585.972070139624;5588.832335029955;5589.469000444951;5605.1872478491205;5554.250176226158;5556.72216389187;5564.304461942257;5579.302587176603;5598.216249725123;5303.9204411934625;5514.283143191359;5555.805546805843;5582.469665381782;5675.489205971482;5691.800786972436;5700.800471983461;5710.514606258348;5745.827625171251;5753.079507278815;5584.274044374205;5603.719814009201;5607.271054762855;5611.214429979887;5616.550675945996 08:24:55 INFO - PROCESS | 11867 | |1;ext.html;561.9044762390394;577.4398833131863;578.2280655325142;581.102197105472;585.5462016936873;43059.78470107649;44302.556974430285;44519.554804451946;48350.75824620872;48625.270620940624;46032.309515357294;46480.53519464813;46557.7672111639;46576;46718.75859241823;7885.211478852098;8977.775555611113;9127.132922372397;9138;10482.685519434392;10743.40911249881;10882.510287037063;10900.1279897608;10902.345859248431;10914.072303854142;10967.341959482417;11016.669499915015;11025.669229923074;11035.172362072877;11042.950919662619;10912.072473839693;10927.289726167774;10939.234253602252;10952.014318711314;10966.616168434146;10696.411697356642;10727.892721072767;10729.785404291948;10770.78458430827;10771.138308935266;43143.56856431427;43562.56437435617;43572;43574.34638480425;43598.56401435977;3586.0317714217276;3749.046282120973;3840.2127563849344;3858.8070596470066;4278.935815962763;32227.710891564308;33297.833510832534;33381.83309083439;33774.1556461088;34214.82892585546;4304.160688665712;4461.353103799964;4488.84289049885;4608.493065762764;4608.746518941457;345550;349124;350011;350299.2485037584;350675;60283.397166028655;60504.39495605075;60684.393156068756;60687.69656151691;60709;63670.1760700682;63905;63923.68038159779;64102.35897640964;64145;15778.605534861721;16026.839731602768;16054.518364449084;16056;16158.27287772053;11038.613648522423;11729.35488548138;12037.217580857216;12110;12121.878781212075;18680.34618788336;18780.624387512173;18799.15403806832;18800.905995469937;19078.713819292723;5985.22192115031;6048.939510604926;6102.115193297036;6224.595401298901;6261.279952805395;943.4150826487621;946.6781294359813;1043;1099.2140619457127;1112.0880877680224;32225.194370140463;32406.18984525406;32716.672833271838;32859.3428131436;33329.50005749916;1077.8113830079863;1120.456578559398;1124.083871644607;1132.3941691195337;1192.1595275330872;16915.746263806053;17302.567435814206;17345.826541734674;17443.651126977642;17491.30034798619;145150.2742486281;145295;145841;147203;148244.2587787054;59112;59707.40292597105;59852.70073649604;59933.40066599278;59975.70012149911;1196.485511230162;1312.8424589049184;1348.615644541301;1365.0956915103375;1373.1006190944747;31466.213344666565;33504.16239594029;33756;33992.320153596294;34424.31151377009;50348.74825625995;55925;57442.42557574538;57489.71255143865;63008.68495657492;462788;463145;465671;465676;466094;26044.869775651;26314.21057368282;26507;28980;29533.409331813673;46268.537314626425;46427.303590445496;46720.29919551277;47040.29439558478;47876;39510;39735.80132099321;41123.7943810291;41486.377704335064;42262.788686056374;39422.408663870636;39674.206515868944;40276.39585406163;40756.38865416962;41179.7941010293;39571;39847.60152398439;40617.390739139526;40823.79588102041;41072.79463602663;33387.499187512694;36201.637983619825;36474.45288320624;37164.44253336148;37424.43863341997;27197.32006699769;27329.453410931274;27408.58887116655;27586.448271034868;27616.723832762218 08:24:55 INFO - PROCESS | 11867 | |2;jquery.html;355.8114199474276;384.86144987804386;391.58687584598255;399.6862462966571;419.12403077567876;14520.05943536404;16938.66122677547;19121.71317430236;19888.303909363174;19892.303769368056;18837.340693075745;18875.716864247046;18888.905555472204;19186.520336991583;19210;4093.283675356801;5629.8592535186535;5780.104083866986;5802.12968054791;5814.4766970972605;6157.6305421674615;6629.105070815426;6635.037919501669;6654.70053847578;6702.530822842403;5484.890302193974;5736.770529178849;5768.336641286242;6599.406053455188;6612.338766123373;5802.100674395476;5810.680412577307;5813.360530341659;5828.388019257981;5870.73581688825;5428.565714742811;5623.746931388097;5673.546116310686;5675.886482270332;5694.487496125327;14035.403450361613;14313;16550.66898662032;22973;23013.194538191085;2247.3370355745096;2278.1001504405667;2422.854628722282;2446.5963116085823;3003.0840593618937;10053.396796192252;10159.847602285972;10163.339382940085;10558.736031599195;10638.521266543024;1934.7678278606516;1945.3963732747773;1983.4545499987476;2006.367994081874;2007.4479518132484;80246;80864.19135808684;80977.59511202465;81276;82414.17585824124;10901.672949811518;11071.944640276746;11157.995780379642;11160.497777600027;11427;15691.372345106069;15692;15716.921415393079;15723.685526289639;15740.763888541682;8173.223543763333;8373.41386102979;8475.237228649452;8561.357898157663;8570.100139485265;7990.880136797953;8012.198780121941;8045.396595255379;8214.507129572245;8228.094909559944;4735.881602959954;4840.419149702058;4868.488808675038;4951.851444456672;4953.43035550909;1953.082051435823;1974.7136665183755;1976.555275063128;1998.4504261328252;2014.0634604908787;916.9449833010041;973.9659111931048;982.886967998675;997.4663554998041;1076.8330908709163;18723.625527489374;19216.231350745813;19224.231030758612;19236.519087022938;19774.209031638573;930.1907340613574;944.4380593546829;991.9900800991898;1024.9743756406;1025.4308858583408;10253.282270241161;10572.577096916037;10779.299345542671;10847.837282440769;10912.23614347004;333001;483514;486399;491118;491385.15953869384;84302.57848710717;84910.57544712236;86822.13177868267;88124;89859;1013.1438934100673;1052.1530168214508;1054.225144518778;1067.7971185474735;1075.9246852720235;17517.21172547264;17652.558686032953;18277.451676449728;18344.816551834843;18582.256709732;41415.7929210352;41778.37332439955;43366.34950475682;43486.56513434825;44754;58340.708296458244;58364.4163558359;59547.40452595419;59749.70125149346;60255.39744602498;8269.255766981001;8461.32309415233;8532.70135545253;8718.782030449289;8731.170538798804;9291.256699464162;12024.458899349374;13461.259630720013;13683.931580342034;13839.861601383856;11673.066154707432;11764.529418823151;11799;11887.28676279426;12307.323097229739;11456.599019034295;11573.594924177612;11712.414379281172;11843.348615826213;11950.402479876146;11679.474423651127;11771.882281177079;11974.700632484257;12493.43779529905;12566.371681416076;7258.963705181441;7593.1647518774;7624.580648064188;8506.234438900528;8645.654173832976;8853.15894989975;10652.147828173573;11604.941975290407;11790.115741319263;11791.29252244868 08:24:55 INFO - PROCESS | 11867 | |3;mootools.html;1345.3004437692407;1477.5130691567897;1482.5774654223549;1602.5192442267323;1756.6662334156501;8645.783855403619;9012.819743605132;9124.81750364993;9323.487208203545;9339.766505837357;9020.72937811865;9216.308776841746;9220.953895230532;9227.169554740072;9235.39969901956;2286.416963674265;2316.698829152208;2319.199876042771;2321.58211521926;2323.570139524185;2312.19073324336;2335.3344296875393;2369.869657168855;2370.7984821290124;2373.6083546214854;2341.1454818991033;2365.077619728307;2366.0299277296313;2369.230000249917;2370.300761275419;2287.0623044551653;2302.5510025545027;2307.7230732312146;2311.9075236990584;2333.1134169015663;2304.896279667419;2305.91929282476;2310.5609934112463;2311.653252012195;2311.6763653088583;8854.29165666745;9063.954680226556;9148.313876459226;9177.862332065024;9201.677941272023;5188.143956247215;5346.91979620306;5405.621606487547;5416.350037995427;5420.24116623673;3440.088376580208;3464.2725027744204;3529.770564913298;3544.167120726627;3559.323728491604;1123.8089524780808;1135.7444574970648;1160.0893298760516;1160.9435413773426;1167.4629670351649;12707.555235566711;12884.162529435556;12973.41619627119;13006.479740810357;13028.934855325757;4687.648426368036;4723.82703956184;4763.3807605011125;4823.2282834746275;4943.876403089879;10865;10888.074513666268;10892.237543372046;10901.34591924487;10913.072388846878;5447.700376479253;5478.972605137029;5481.369642491085;5487.945120548823;5489.698066606375;4392.165488557228;4710.222813235778;4828.034393121319;4848.587870031087;5038.622103342264;3926.096997690547;4048.109415928491;4100.138970816102;4158.91682166355;4225.661947044229;1253.8119282107757;1308.8298521192185;1309.502389092158;1309.5154792726753;1318.2683610596212;890.4879694175875;937.9718608441758;1014.5028935821542;1017.1100287248657;1034.5086084109987;6066.120412540157;6080.665563393967;6202.658853762996;6232.3144454110015;6296.5592408531875;448.61867412698945;459.993100103492;466.8809453589313;468.3747197491319;468.5735980258017;4312.525622181557;4363.650907927358;4368.388425620352;4393.538678438782;4403.3174857897075;11269.323840569592;11765.941170294094;11767.411629418495;11777.116716246315;11844.348560829065;11636.12729045325;11637.301761894314;11647.068234541217;11650.475728592233;11661.125415593695;7952.522848629101;8213.876791848126;8250.422470427133;8471.110533394152;8471.49171049739;6273.435390814849;6329.683515824098;6525;6603.504737144637;6650.600963942179;10265.435401053013;10511.26421150512;10676.199285053497;10723;10846.566137354734;10388.948055259676;10961.232713709964;10962.123030157727;10962.835557466486;10972.396518191576;7040.401565866754;7664.80837979055;7669.348105411103;7810.297073263434;7873.645685944261;8848.690295839871;8867.157620026088;8874.911250887408;8960.417572857743;8962;7764.495307804975;7968.561729104955;8085;8115.4724942880885;8272.296854767412;7659.195784442776;7799.103103143211;7853.293203611703;7874.448788584744;7925.207479252259;7017.789466316019;7153.463490238149;7153.570785752871;7158.534695244793;7164.104486939133;5210.817621383233;5237.502437268454;5320.973395133;5323.653962492425;5422.77023921342;5339.519443250126;5375.758090885842;5457.154141108134;5489.313835770528;5529.529989950738 08:24:55 INFO - PROCESS | 11867 | |4;prototype.html;287.5456778290301;293.1703279718397;301.4664044640986;305.80122920101945;306.5845778969498;5052.797888084481;5133;5155.3040339554145;5198.168293073114;5211.713355765436;5179.4561571035065;5211.921821172676;5218.921716174251;5220.190870415092;5222.738863056851;4042.6361627453525;4049.9190016199805;4064.695147863915;4067.5525692173987;4070.104576993057;3884.3008258513455;4000.9799951000205;4070.8778736637946;4071.5521292657786;4072.7759973201464;3977.781222032787;3981.86063487778;3984.681225501967;3987.8006099695044;3989.8603548875794;3956.3867600521967;3962.1877515109477;3967.4643923070303;3968.3253846846105;3980.0248939009984;3342.548755917944;3453.395655760257;3457.94813077804;3474.4788281757687;3482.7736197147105;5039.874003149951;5044.949550504484;5049.621278404097;5066.822661206877;5082.932584157332;4525.389072475206;4528.230200865861;4528.569785870337;4531.660125490602;4535.977320113411;5115.544538621482;5342.679439233659;5402.37872644647;5407.459254074561;5408.432114627986;3797.240551889633;3797.4303854421782;3799.3920972644246;3802.4676545283683;3812.989557767194;5621.522170615462;5634.1829085457275;5653.9151912721345;5656.066748986413;5657.32112146545;3777.490038844776;3835.6547910688173;3878.9139041068547;3882.5729169791302;3888.416737489399;3873.573906870242;3894.6300101490315;3898.1618951924906;3899.454076429302;3902.824372903169;4475.552444755564;4506.81972721094;4513.842015529441;4545.204589196877;4546.295139322754;5225.242339860775;5347.679139251657;5413.2150838128255;5454.618136755237;5469.1249400096585;1320.683036071336;1347.2590075458459;1353.8307711536058;1358.4973559782745;1360.5306169371552;835.8996920369473;848.9448185867899;857.9918595650087;863.404251066762;865.191046371632;4605.585497305192;4637.721736695809;4649.907271791127;4662.114198302312;4707.270373092176;4861.225652636762;4891.290762839369;4902.632302577321;4912.189488734319;4918.163912134945;4407.471103467605;4563.8134085137435;4631;4654.394928659321;4658.254679251304;2569.982563687496;2595.4419799743146;2609.069288726329;2621.5843444540114;2622.973770262311;4956.628252880976;5018.924716129261;5026.084870774942;5034.345535080416;5054.332070416754;4948.935978764583;4972.204447288416;4977.427595826454;4986.326845875833;5284.841454756363;5734.913976290359;5767.538596912237;5773.430823283682;5781.277340332458;5801.970990145022;5548.55611551083;5561.4716601922755;5581.944180558143;5582.49757521825;5597.020521408818;5372.489613486712;5465.180222966586;5486.780528778804;5534.086875665631;5535.903431460771;5725.16985037159;5725.627834190931;5732.398098199796;5746.856328591819;5749.453801888814;3596.568411790497;3785.4511095891494;3835.271298453285;3874.53505579321;3880.922381552297;5541.861453463695;5544.112941929272;5547.334319881478;5549.916751248654;5569.805056822992;5396.865078373072;5421.484958928895;5441.455854414527;5451.727413629382;5457.481539253765;5237.319148510669;5390.164524498709;5413.621046526705;5418.485243901823;5420.864478388072;5350.411454739898;5353.143497040455;5363.302770639792;5366.490183432567;5373.408925018167;5168.715720635401;5431.375391829832;5435.456454354691;5436.640839790052;5439.782408703608;5292.179712144623;5353.384360798403;5373.629724420248;5382.407935127211;5389.83830485086 08:24:55 INFO - PROCESS | 11867 | |5;yui.html;731.4660297982473;742.2651574940807;803.3934379543443;855.9572021398936;865.8181781825818;16054.59863503413;17139.057351845644;17178.05520696363;17187.914060429695;17193.828061719378;15582.065076095414;15726.84273157268;15728.449504267353;15754;15763.84236157638;640.2317219336803;783.8589053970283;810.4853418079502;814.027237451246;814.3770015937812;811.5333683132193;812.6708682983401;812.6830536090929;813.9430239883211;814.0963530481162;852.4842470305468;854.1287886355914;854.2141230068352;855.7133360324299;856.019857263433;686.6669665212393;702.6381413572014;703.5673061067458;839.836231934773;849.4563479373206;610.3652201710216;615.1019511513196;615.6860001399274;616.214326733414;616.22355831652;16271.430499932563;16484.175791210393;16486.505404837873;16517.83482165175;16531.91734041322;15470.303836327392;15592;15646.295916683663;15830.970986885815;15859.841401585953;12678;12864.09951303409;13299.401526931311;13308.80036799439;13432.32838358088;3896.980515097435;3993.6805055595482;4018.136100738326;4089.2434899543678;4091.8747344480207;81667.9999999994;83362;86516.56741716314;86746.56626716827;87374;11832.155880804004;11837.822432663517;12040.21738586989;12117.212381195193;12390.5663301784;23889;23919.52160956771;23941.7605823943;23960.760392395852;23979.52040959171;9048.909510904938;9437.292203084797;9594.280428967855;9776.217902567778;9776.41341519497;5154.252633368215;5173.508516690908;5207.140821764442;5208.765605547759;5398.514133727984;3649.39784935488;3747.9250414991548;3760.9435858462143;3760.9623903761158;3761.6990640748672;626.2797782550012;635.8791829552371;637.2225884420999;643.996780016097;650.8665723526666;678.3453966921944;722.7253643615497;737.7049180327912;761.4200533892196;778.0468925566137;10250.487475626189;10592.099671528007;10609.021735895532;10922.672319830259;10950;673.5554534007531;702.6416527570975;713.0552018575409;715.4169351978121;716.2050124361954;5005.273946703274;5013.222950442687;5106.719130447861;5124.615653825978;5208.270842082112;69863.65068174627;92791;121375;126519;130049.34975325063;107996.46001769941;109997;111253;111801.44099279614;111971;58142.70928645414;80309.59845200737;80605;85436.57281713551;88393.55803221071;9713.660021899199;10307.535489645406;10729.248952573245;10974.341539507335;11024.448777560929;47964.5203547974;52163.47836521586;53086.2037069452;53463;54288.72855635697;45257.77371113255;45722.31416528688;45771.56713246586;50905.236421452966;71921.6403917977;14671.193084380462;14808;14831.33259003369;14871.330790114254;14950.925245373703;15920.442784502487;16239.675206495567;16313.429029983894;16486.34054637801;16580.088095154882;14954.90631311639;15061.849381506483;15307.846921531087;15794;16036.599085022968;14563.635909102357;14917.47788827386;15182.696346073237;15223.467178649138;15579;14291.285435727965;14558.199299038655;14672.3717597893;14886.627834304229;14940.626484337978;11232.719182020188;11252.099086835293;11857.34784586856;11941.16411851162;12287.754244914873;11622.302661840316;11734.354610496504;12061.457234424297;12072.698182545506;12134.150609457252 08:24:55 INFO - PROCESS | 11867 | __end_tp_report 08:24:55 INFO - PROCESS | 11867 | __start_cc_report 08:24:55 INFO - PROCESS | 11867 | _x_x_mozilla_cycle_collect,941 08:24:55 INFO - PROCESS | 11867 | __end_cc_report 08:24:55 INFO - PROCESS | 11867 | __startTimestamp1471965895553__endTimestamp 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | ------- Summary: start ------- 08:24:55 INFO - PROCESS | 11867 | Number of tests: 6 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | [#0] dojo.html Cycles:165 Average:5309.62 Median:5554.39 stddev:599.72 (10.8%) stddev-sans-first:573.54 08:24:55 INFO - PROCESS | 11867 | Values: 3000.0 3014.4 3023.9 3045.3 3046.8 5154.2 5206.4 5206.5 5235.2 5300.7 5243.6 5290.9 5306.3 5373.6 5384.7 4833.3 4893.4 4953.3 4994.3 5007.8 4922.9 4957.8 4976.6 4982.1 5019.0 4752.0 4808.3 4922.7 4935.2 4975.4 4765.1 4797.2 4826.5 4836.7 4930.4 4837.3 4850.5 4869.2 4871.7 4884.4 5360.9 5375.4 5377.8 5385.8 5387.2 5474.0 5566.0 5612.9 5622.2 5709.8 5739.5 5743.4 5747.7 5753.2 5755.4 5348.3 5353.5 5355.7 5362.3 5362.9 5663.4 5720.3 5746.9 5754.9 5872.9 5558.2 5649.5 5652.6 5656.1 5661.6 5726.5 5728.1 5738.5 5740.2 5744.0 5487.9 5514.5 5563.7 5571.2 5647.9 5640.9 5643.3 5645.7 5649.6 5652.4 4397.3 4397.8 4401.2 4410.8 4417.7 3864.7 3907.9 3925.7 3963.9 4055.5 5367.0 5442.2 5442.9 5444.6 5455.3 5827.4 5841.9 5844.0 5846.3 5848.6 5259.8 5299.2 5300.7 5353.9 5362.1 4979.4 4982.5 4983.5 4985.5 4986.4 5913.7 5924.8 5927.8 5928.0 5929.9 5530.2 5640.7 5745.8 5751.4 5829.8 5923.7 5945.1 5978.1 5982.6 5984.0 5609.1 5632.7 5634.2 5634.4 5635.6 5558.7 5599.1 5600.2 5624.6 5734.5 5554.4 5586.0 5588.8 5589.5 5605.2 5554.3 5556.7 5564.3 5579.3 5598.2 5303.9 5514.3 5555.8 5582.5 5675.5 5691.8 5700.8 5710.5 5745.8 5753.1 5584.3 5603.7 5607.3 5611.2 5616.6 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | [#1] ext.html Cycles:180 Average:50861.97 Median:19893.83 stddev:91809.34 (461.5%) stddev-sans-first:91989.22 08:24:55 INFO - PROCESS | 11867 | Values: 561.9 577.4 578.2 581.1 585.5 43059.8 44302.6 44519.6 48350.8 48625.3 46032.3 46480.5 46557.8 46576.0 46718.8 7885.2 8977.8 9127.1 9138.0 10482.7 10743.4 10882.5 10900.1 10902.3 10914.1 10967.3 11016.7 11025.7 11035.2 11043.0 10912.1 10927.3 10939.2 10952.0 10966.6 10696.4 10727.9 10729.8 10770.8 10771.1 43143.6 43562.6 43572.0 43574.3 43598.6 3586.0 3749.0 3840.2 3858.8 4278.9 32227.7 33297.8 33381.8 33774.2 34214.8 4304.2 4461.4 4488.8 4608.5 4608.7 345550.0 349124.0 350011.0 350299.2 350675.0 60283.4 60504.4 60684.4 60687.7 60709.0 63670.2 63905.0 63923.7 64102.4 64145.0 15778.6 16026.8 16054.5 16056.0 16158.3 11038.6 11729.4 12037.2 12110.0 12121.9 18680.3 18780.6 18799.2 18800.9 19078.7 5985.2 6048.9 6102.1 6224.6 6261.3 943.4 946.7 1043.0 1099.2 1112.1 32225.2 32406.2 32716.7 32859.3 33329.5 1077.8 1120.5 1124.1 1132.4 1192.2 16915.7 17302.6 17345.8 17443.7 17491.3 145150.3 145295.0 145841.0 147203.0 148244.3 59112.0 59707.4 59852.7 59933.4 59975.7 1196.5 1312.8 1348.6 1365.1 1373.1 31466.2 33504.2 33756.0 33992.3 34424.3 50348.7 55925.0 57442.4 57489.7 63008.7 462788.0 463145.0 465671.0 465676.0 466094.0 26044.9 26314.2 26507.0 28980.0 29533.4 46268.5 46427.3 46720.3 47040.3 47876.0 39510.0 39735.8 41123.8 41486.4 42262.8 39422.4 39674.2 40276.4 40756.4 41179.8 39571.0 39847.6 40617.4 40823.8 41072.8 33387.5 36201.6 36474.5 37164.4 37424.4 27197.3 27329.5 27408.6 27586.4 27616.7 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | [#2] jquery.html Cycles:180 Average:27887.03 Median:168002.04 stddev:76185.35 (45.3%) stddev-sans-first:76371.02 08:24:55 INFO - PROCESS | 11867 | Values: 355.8 384.9 391.6 399.7 419.1 14520.1 16938.7 19121.7 19888.3 19892.3 18837.3 18875.7 18888.9 19186.5 19210.0 4093.3 5629.9 5780.1 5802.1 5814.5 6157.6 6629.1 6635.0 6654.7 6702.5 5484.9 5736.8 5768.3 6599.4 6612.3 5802.1 5810.7 5813.4 5828.4 5870.7 5428.6 5623.7 5673.5 5675.9 5694.5 14035.4 14313.0 16550.7 22973.0 23013.2 2247.3 2278.1 2422.9 2446.6 3003.1 10053.4 10159.8 10163.3 10558.7 10638.5 1934.8 1945.4 1983.5 2006.4 2007.4 80246.0 80864.2 80977.6 81276.0 82414.2 10901.7 11071.9 11158.0 11160.5 11427.0 15691.4 15692.0 15716.9 15723.7 15740.8 8173.2 8373.4 8475.2 8561.4 8570.1 7990.9 8012.2 8045.4 8214.5 8228.1 4735.9 4840.4 4868.5 4951.9 4953.4 1953.1 1974.7 1976.6 1998.5 2014.1 916.9 974.0 982.9 997.5 1076.8 18723.6 19216.2 19224.2 19236.5 19774.2 930.2 944.4 992.0 1025.0 1025.4 10253.3 10572.6 10779.3 10847.8 10912.2 333001.0 483514.0 486399.0 491118.0 491385.2 84302.6 84910.6 86822.1 88124.0 89859.0 1013.1 1052.2 1054.2 1067.8 1075.9 17517.2 17652.6 18277.5 18344.8 18582.3 41415.8 41778.4 43366.3 43486.6 44754.0 58340.7 58364.4 59547.4 59749.7 60255.4 8269.3 8461.3 8532.7 8718.8 8731.2 9291.3 12024.5 13461.3 13683.9 13839.9 11673.1 11764.5 11799.0 11887.3 12307.3 11456.6 11573.6 11712.4 11843.3 11950.4 11679.5 11771.9 11974.7 12493.4 12566.4 7259.0 7593.2 7624.6 8506.2 8645.7 8853.2 10652.1 11604.9 11790.1 11791.3 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | [#3] mootools.html Cycles:180 Average:6015.40 Median:463.44 stddev:3511.89 (757.8%) stddev-sans-first:3504.20 08:24:55 INFO - PROCESS | 11867 | Values: 1345.3 1477.5 1482.6 1602.5 1756.7 8645.8 9012.8 9124.8 9323.5 9339.8 9020.7 9216.3 9221.0 9227.2 9235.4 2286.4 2316.7 2319.2 2321.6 2323.6 2312.2 2335.3 2369.9 2370.8 2373.6 2341.1 2365.1 2366.0 2369.2 2370.3 2287.1 2302.6 2307.7 2311.9 2333.1 2304.9 2305.9 2310.6 2311.7 2311.7 8854.3 9064.0 9148.3 9177.9 9201.7 5188.1 5346.9 5405.6 5416.4 5420.2 3440.1 3464.3 3529.8 3544.2 3559.3 1123.8 1135.7 1160.1 1160.9 1167.5 12707.6 12884.2 12973.4 13006.5 13028.9 4687.6 4723.8 4763.4 4823.2 4943.9 10865.0 10888.1 10892.2 10901.3 10913.1 5447.7 5479.0 5481.4 5487.9 5489.7 4392.2 4710.2 4828.0 4848.6 5038.6 3926.1 4048.1 4100.1 4158.9 4225.7 1253.8 1308.8 1309.5 1309.5 1318.3 890.5 938.0 1014.5 1017.1 1034.5 6066.1 6080.7 6202.7 6232.3 6296.6 448.6 460.0 466.9 468.4 468.6 4312.5 4363.7 4368.4 4393.5 4403.3 11269.3 11765.9 11767.4 11777.1 11844.3 11636.1 11637.3 11647.1 11650.5 11661.1 7952.5 8213.9 8250.4 8471.1 8471.5 6273.4 6329.7 6525.0 6603.5 6650.6 10265.4 10511.3 10676.2 10723.0 10846.6 10388.9 10961.2 10962.1 10962.8 10972.4 7040.4 7664.8 7669.3 7810.3 7873.6 8848.7 8867.2 8874.9 8960.4 8962.0 7764.5 7968.6 8085.0 8115.5 8272.3 7659.2 7799.1 7853.3 7874.4 7925.2 7017.8 7153.5 7153.6 7158.5 7164.1 5210.8 5237.5 5321.0 5323.7 5422.8 5339.5 5375.8 5457.2 5489.3 5529.5 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | [#4] prototype.html Cycles:180 Average:4443.21 Median:5022.50 stddev:1330.14 (26.5%) stddev-sans-first:1296.79 08:24:55 INFO - PROCESS | 11867 | Values: 287.5 293.2 301.5 305.8 306.6 5052.8 5133.0 5155.3 5198.2 5211.7 5179.5 5211.9 5218.9 5220.2 5222.7 4042.6 4049.9 4064.7 4067.6 4070.1 3884.3 4001.0 4070.9 4071.6 4072.8 3977.8 3981.9 3984.7 3987.8 3989.9 3956.4 3962.2 3967.5 3968.3 3980.0 3342.5 3453.4 3457.9 3474.5 3482.8 5039.9 5044.9 5049.6 5066.8 5082.9 4525.4 4528.2 4528.6 4531.7 4536.0 5115.5 5342.7 5402.4 5407.5 5408.4 3797.2 3797.4 3799.4 3802.5 3813.0 5621.5 5634.2 5653.9 5656.1 5657.3 3777.5 3835.7 3878.9 3882.6 3888.4 3873.6 3894.6 3898.2 3899.5 3902.8 4475.6 4506.8 4513.8 4545.2 4546.3 5225.2 5347.7 5413.2 5454.6 5469.1 1320.7 1347.3 1353.8 1358.5 1360.5 835.9 848.9 858.0 863.4 865.2 4605.6 4637.7 4649.9 4662.1 4707.3 4861.2 4891.3 4902.6 4912.2 4918.2 4407.5 4563.8 4631.0 4654.4 4658.3 2570.0 2595.4 2609.1 2621.6 2623.0 4956.6 5018.9 5026.1 5034.3 5054.3 4948.9 4972.2 4977.4 4986.3 5284.8 5734.9 5767.5 5773.4 5781.3 5802.0 5548.6 5561.5 5581.9 5582.5 5597.0 5372.5 5465.2 5486.8 5534.1 5535.9 5725.2 5725.6 5732.4 5746.9 5749.5 3596.6 3785.5 3835.3 3874.5 3880.9 5541.9 5544.1 5547.3 5549.9 5569.8 5396.9 5421.5 5441.5 5451.7 5457.5 5237.3 5390.2 5413.6 5418.5 5420.9 5350.4 5353.1 5363.3 5366.5 5373.4 5168.7 5431.4 5435.5 5436.6 5439.8 5292.2 5353.4 5373.6 5382.4 5389.8 08:24:55 INFO - PROCESS | 11867 | 08:24:55 INFO - PROCESS | 11867 | [#5] yui.html Cycles:180 Average:20997.63 Median:3761.33 stddev:29641.15 (788.0%) stddev-sans-first:29685.24 08:24:55 INFO - PROCESS | 11867 | Values: 731.5 742.3 803.4 856.0 865.8 16054.6 17139.1 17178.1 17187.9 17193.8 15582.1 15726.8 15728.4 15754.0 15763.8 640.2 783.9 810.5 814.0 814.4 811.5 812.7 812.7 813.9 814.1 852.5 854.1 854.2 855.7 856.0 686.7 702.6 703.6 839.8 849.5 610.4 615.1 615.7 616.2 616.2 16271.4 16484.2 16486.5 16517.8 16531.9 15470.3 15592.0 15646.3 15831.0 15859.8 12678.0 12864.1 13299.4 13308.8 13432.3 3897.0 3993.7 4018.1 4089.2 4091.9 81668.0 83362.0 86516.6 86746.6 87374.0 11832.2 11837.8 12040.2 12117.2 12390.6 23889.0 23919.5 23941.8 23960.8 23979.5 9048.9 9437.3 9594.3 9776.2 9776.4 5154.3 5173.5 5207.1 5208.8 5398.5 3649.4 3747.9 3760.9 3761.0 3761.7 626.3 635.9 637.2 644.0 650.9 678.3 722.7 737.7 761.4 778.0 10250.5 10592.1 10609.0 10922.7 10950.0 673.6 702.6 713.1 715.4 716.2 5005.3 5013.2 5106.7 5124.6 5208.3 69863.7 92791.0 121375.0 126519.0 130049.3 107996.5 109997.0 111253.0 111801.4 111971.0 58142.7 80309.6 80605.0 85436.6 88393.6 9713.7 10307.5 10729.2 10974.3 11024.4 47964.5 52163.5 53086.2 53463.0 54288.7 45257.8 45722.3 45771.6 50905.2 71921.6 14671.2 14808.0 14831.3 14871.3 14950.9 15920.4 16239.7 16313.4 16486.3 16580.1 14954.9 15061.8 15307.8 15794.0 16036.6 14563.6 14917.5 15182.7 15223.5 15579.0 14291.3 14558.2 14672.4 14886.6 14940.6 11232.7 11252.1 11857.3 11941.2 12287.8 11622.3 11734.4 12061.5 12072.7 12134.2 08:24:55 INFO - PROCESS | 11867 | -------- Summary: end -------- 08:24:55 INFO - PROCESS | 11867 | 08:24:56 INFO - TEST-INFO | 11867: exit 0 08:24:56 INFO - TEST-OK | dromaeo_css | took 1116128ms 08:24:56 INFO - TEST-START | kraken 08:24:56 INFO - operating with platform_type : linux_ 08:24:56 INFO - Initialising browser for kraken test... 08:24:56 INFO - TEST-INFO | started process 12176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpneuAqd/profile http://localhost:36441/getInfo.html) 08:25:00 INFO - PROCESS | 12176 | __metrics Screen width/height:1600/1200 08:25:00 INFO - PROCESS | 12176 | colorDepth:24 08:25:00 INFO - PROCESS | 12176 | Browser inner width/height: 1024/697 08:25:00 INFO - PROCESS | 12176 | __metrics 08:25:01 INFO - PROCESS | 12176 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:25:01 INFO - PROCESS | 12176 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:01 INFO - PROCESS | 12176 | console.error: PushService: 08:25:01 INFO - PROCESS | 12176 | stateChangeProcessEnqueue: Error transitioning state 08:25:01 INFO - PROCESS | 12176 | UnknownError 08:25:02 INFO - TEST-INFO | 12176: exit 0 08:25:02 INFO - Browser initialized. 08:25:02 INFO - Running cycle 1/1 for kraken test... 08:25:02 INFO - TEST-INFO | started process 12261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpneuAqd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:14 INFO - PROCESS | 12261 | RSS: Main: 176664576 08:25:14 INFO - PROCESS | 12261 | 08:25:17 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36441/tests/kraken/driver.html?testName=audio-beat-detection) 08:25:18 INFO - PROCESS | 12261 | RSS: Main: 234508288 08:25:18 INFO - PROCESS | 12261 | 08:25:20 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36441/tests/kraken/driver.html?testName=audio-dft) 08:25:21 INFO - PROCESS | 12261 | RSS: Main: 225390592 08:25:21 INFO - PROCESS | 12261 | 08:25:24 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36441/tests/kraken/driver.html?testName=audio-fft) 08:25:25 INFO - PROCESS | 12261 | RSS: Main: 301371392 08:25:25 INFO - PROCESS | 12261 | 08:25:27 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36441/tests/kraken/driver.html?testName=audio-oscillator) 08:25:27 INFO - PROCESS | 12261 | RSS: Main: 209219584 08:25:27 INFO - PROCESS | 12261 | 08:25:30 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:30 INFO - PROCESS | 12261 | RSS: Main: 212807680 08:25:30 INFO - PROCESS | 12261 | 08:25:33 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36441/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:34 INFO - PROCESS | 12261 | RSS: Main: 249548800 08:25:34 INFO - PROCESS | 12261 | 08:25:37 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36441/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:38 INFO - PROCESS | 12261 | RSS: Main: 248483840 08:25:38 INFO - PROCESS | 12261 | 08:25:41 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36441/tests/kraken/driver.html?testName=json-parse-financial) 08:25:41 INFO - PROCESS | 12261 | RSS: Main: 248684544 08:25:41 INFO - PROCESS | 12261 | 08:25:43 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:44 INFO - PROCESS | 12261 | RSS: Main: 211558400 08:25:44 INFO - PROCESS | 12261 | 08:25:45 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:46 INFO - PROCESS | 12261 | RSS: Main: 218927104 08:25:46 INFO - PROCESS | 12261 | 08:25:48 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:49 INFO - PROCESS | 12261 | RSS: Main: 223068160 08:25:49 INFO - PROCESS | 12261 | 08:25:51 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:52 INFO - PROCESS | 12261 | RSS: Main: 217956352 08:25:52 INFO - PROCESS | 12261 | 08:25:55 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:56 INFO - PROCESS | 12261 | RSS: Main: 221835264 08:25:56 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | Cycle 1(1): loaded http://localhost:36441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36441/tests/kraken/driver.html?testName=ai-astar) 08:25:57 INFO - PROCESS | 12261 | RSS: Main: 272596992 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | __start_tp_report 08:25:57 INFO - PROCESS | 12261 | _x_x_mozilla_page_load 08:25:57 INFO - PROCESS | 12261 | _x_x_mozilla_page_load_details 08:25:57 INFO - PROCESS | 12261 | |i|pagename|runs| 08:25:57 INFO - PROCESS | 12261 | |0;ai-astar;99;114;110;112;111;113;119;114;113;113 08:25:57 INFO - PROCESS | 12261 | |1;audio-beat-detection;159;119;146;184;118;149;143;121;171;117 08:25:57 INFO - PROCESS | 12261 | |2;audio-dft;161;162;162;161;162;162;162;161;163;162 08:25:57 INFO - PROCESS | 12261 | |3;audio-fft;75;78;75;171;76;75;74;73;170;75 08:25:57 INFO - PROCESS | 12261 | |4;audio-oscillator;86;86;152;85;85;84;136;85;86;156 08:25:57 INFO - PROCESS | 12261 | |5;imaging-gaussian-blur;116;117;117;117;118;117;118;118;118;118 08:25:57 INFO - PROCESS | 12261 | |6;imaging-darkroom;146;146;145;146;145;145;145;146;146;146 08:25:57 INFO - PROCESS | 12261 | |7;imaging-desaturate;94;96;95;95;94;94;96;95;95;94 08:25:57 INFO - PROCESS | 12261 | |8;json-parse-financial;51;54;52;52;51;51;51;52;52;51 08:25:57 INFO - PROCESS | 12261 | |9;json-stringify-tinderbox;62;64;63;65;65;63;63;63;65;64 08:25:57 INFO - PROCESS | 12261 | |10;stanford-crypto-aes;79;78;80;91;82;78;78;77;78;78 08:25:57 INFO - PROCESS | 12261 | |11;stanford-crypto-ccm;123;128;124;130;126;124;132;131;158;131 08:25:57 INFO - PROCESS | 12261 | |12;stanford-crypto-pbkdf2;165;163;166;163;161;162;164;169;160;167 08:25:57 INFO - PROCESS | 12261 | |13;stanford-crypto-sha256-iterative;67;64;68;66;63;68;64;64;66;69 08:25:57 INFO - PROCESS | 12261 | __end_tp_report 08:25:57 INFO - PROCESS | 12261 | __start_cc_report 08:25:57 INFO - PROCESS | 12261 | _x_x_mozilla_cycle_collect,1712 08:25:57 INFO - PROCESS | 12261 | __end_cc_report 08:25:57 INFO - PROCESS | 12261 | __startTimestamp1471965957963__endTimestamp 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | ------- Summary: start ------- 08:25:57 INFO - PROCESS | 12261 | Number of tests: 14 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:5.09 (4.5%) stddev-sans-first:2.54 08:25:57 INFO - PROCESS | 12261 | Values: 99.0 114.0 110.0 112.0 111.0 113.0 119.0 114.0 113.0 113.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:147.50 stddev:23.87 (16.2%) stddev-sans-first:24.57 08:25:57 INFO - PROCESS | 12261 | Values: 159.0 119.0 146.0 184.0 118.0 149.0 143.0 121.0 171.0 117.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:25:57 INFO - PROCESS | 12261 | Values: 161.0 162.0 162.0 161.0 162.0 162.0 162.0 161.0 163.0 162.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:40.23 (53.6%) stddev-sans-first:42.07 08:25:57 INFO - PROCESS | 12261 | Values: 75.0 78.0 75.0 171.0 76.0 75.0 74.0 73.0 170.0 75.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:85.00 stddev:30.71 (36.1%) stddev-sans-first:31.86 08:25:57 INFO - PROCESS | 12261 | Values: 86.0 86.0 152.0 85.0 85.0 84.0 136.0 85.0 86.0 156.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 08:25:57 INFO - PROCESS | 12261 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:25:57 INFO - PROCESS | 12261 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 08:25:57 INFO - PROCESS | 12261 | Values: 94.0 96.0 95.0 95.0 94.0 94.0 96.0 95.0 95.0 94.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.95 (1.8%) stddev-sans-first:0.97 08:25:57 INFO - PROCESS | 12261 | Values: 51.0 54.0 52.0 52.0 51.0 51.0 51.0 52.0 52.0 51.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 08:25:57 INFO - PROCESS | 12261 | Values: 62.0 64.0 63.0 65.0 65.0 63.0 63.0 63.0 65.0 64.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:78.50 stddev:4.15 (5.3%) stddev-sans-first:4.39 08:25:57 INFO - PROCESS | 12261 | Values: 79.0 78.0 80.0 91.0 82.0 78.0 78.0 77.0 78.0 78.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:130.50 stddev:10.14 (7.8%) stddev-sans-first:10.37 08:25:57 INFO - PROCESS | 12261 | Values: 123.0 128.0 124.0 130.0 126.0 124.0 132.0 131.0 158.0 131.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:2.79 (1.7%) stddev-sans-first:2.93 08:25:57 INFO - PROCESS | 12261 | Values: 165.0 163.0 166.0 163.0 161.0 162.0 164.0 169.0 160.0 167.0 08:25:57 INFO - PROCESS | 12261 | 08:25:57 INFO - PROCESS | 12261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:2.08 (3.1%) stddev-sans-first:2.17 08:25:57 INFO - PROCESS | 12261 | Values: 67.0 64.0 68.0 66.0 63.0 68.0 64.0 64.0 66.0 69.0 08:25:57 INFO - PROCESS | 12261 | -------- Summary: end -------- 08:25:57 INFO - PROCESS | 12261 | 08:25:59 INFO - TEST-INFO | 12261: exit 0 08:25:59 INFO - TEST-OK | kraken | took 62660ms 08:25:59 INFO - SUITE-END | took 1178s 08:25:59 INFO - Completed test suite (00:19:39) 08:25:59 INFO - javascript benchmark 08:25:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.0249918776394, 3014.3971205758853, 3023.894163704271, 3045.2843581758284, 3046.817190968542, 5154.201098829678, 5206.401263854658, 5206.479352064792, 5235.214717792328, 5300.6819590824525, 5243.632945693803, 5290.947090529094, 5306.257124002643, 5373.623846330758, 5384.703841288728, 4833.299171620113, 4893.363862697862, 4953.306537084811, 4994.300797888299, 5007.824726134586, 4922.901541969159, 4957.752112394384, 4976.626752993522, 4982.053409852135, 5019.0, 4751.976240118812, 4808.278758186265, 4922.680025798311, 4935.210366341404, 4975.378077740283, 4765.11845308619, 4797.160496913027, 4826.517348265181, 4836.733979631119, 4930.383702037246, 4837.250226214942, 4850.490698476679, 4869.245266983623, 4871.658983871131, 4884.365032545782, 5360.892782144374, 5375.381831089397, 5377.838664840061, 5385.757640906129, 5387.164989426645, 5474.0, 5566.025945459528, 5612.887742245173, 5622.156676498517, 5709.8287051388525, 5739.454751798572, 5743.425657434265, 5747.712614369307, 5753.194552762617, 5755.366909639936, 5348.304720386363, 5353.544948679367, 5355.732213389393, 5362.329708786402, 5362.892742145214, 5663.405342438985, 5720.342160651495, 5746.88506229873, 5754.88490230193, 5872.911906321408, 5558.249636299129, 5649.491545760901, 5652.63257888236, 5656.066748986371, 5661.631993920464, 5726.541876649858, 5728.05487094633, 5738.483536481736, 5740.167675687086, 5744.023516002289, 5487.945120548823, 5514.531264842533, 5563.693996830132, 5571.220029195916, 5647.858803529944, 5640.85897852557, 5643.322801263875, 5645.68948707825, 5649.576281778883, 5652.406497317805, 4397.296432570837, 4397.802098905557, 4401.207782599163, 4410.757408342508, 4417.712848664826, 3864.7101467390057, 3907.9218415631526, 3925.725199236026, 3963.8810835674976, 4055.4727885374714, 5366.973165134227, 5442.2380866678695, 5442.945570544323, 5444.618876678674, 5455.318085239345, 5827.446392592697, 5841.88316233673, 5844.035734103911, 5846.269216347957, 5848.64908105515, 5259.76331065103, 5299.178627312773, 5300.681959082467, 5353.86615334612, 5362.061639213122, 4979.402471703419, 4982.476839931827, 4983.451820299764, 4985.501449854985, 4986.376702912136, 5913.674747888907, 5924.7926322578505, 5927.822165334961, 5928.0, 5929.9110513341475, 5530.170474428868, 5640.746166422603, 5745.770169193185, 5751.396103409082, 5829.76680932758, 5923.703814809156, 5945.078512830518, 5978.073398623221, 5982.611130276692, 5983.970080149571, 5609.074502707008, 5632.690202038763, 5634.154876768517, 5634.352049514195, 5635.605507614428, 5558.749856256559, 5599.132134519156, 5600.159976003632, 5624.550035997192, 5734.455226753452, 5554.389017208023, 5585.972070139624, 5588.832335029955, 5589.469000444951, 5605.1872478491205, 5554.250176226158, 5556.72216389187, 5564.304461942257, 5579.302587176603, 5598.216249725123, 5303.9204411934625, 5514.283143191359, 5555.805546805843, 5582.469665381782, 5675.489205971482, 5691.800786972436, 5700.800471983461, 5710.514606258348, 5745.827625171251, 5753.079507278815, 5584.274044374205, 5603.719814009201, 5607.271054762855, 5611.214429979887, 5616.550675945996], "value": 5268.7912848878195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9044762390394, 577.4398833131863, 578.2280655325142, 581.102197105472, 585.5462016936873, 43059.78470107649, 44302.556974430285, 44519.554804451946, 48350.75824620872, 48625.270620940624, 46032.309515357294, 46480.53519464813, 46557.7672111639, 46576.0, 46718.75859241823, 7885.211478852098, 8977.775555611113, 9127.132922372397, 9138.0, 10482.685519434392, 10743.40911249881, 10882.510287037063, 10900.1279897608, 10902.345859248431, 10914.072303854142, 10967.341959482417, 11016.669499915015, 11025.669229923074, 11035.172362072877, 11042.950919662619, 10912.072473839693, 10927.289726167774, 10939.234253602252, 10952.014318711314, 10966.616168434146, 10696.411697356642, 10727.892721072767, 10729.785404291948, 10770.78458430827, 10771.138308935266, 43143.56856431427, 43562.56437435617, 43572.0, 43574.34638480425, 43598.56401435977, 3586.0317714217276, 3749.046282120973, 3840.2127563849344, 3858.8070596470066, 4278.935815962763, 32227.710891564308, 33297.833510832534, 33381.83309083439, 33774.1556461088, 34214.82892585546, 4304.160688665712, 4461.353103799964, 4488.84289049885, 4608.493065762764, 4608.746518941457, 345550.0, 349124.0, 350011.0, 350299.2485037584, 350675.0, 60283.397166028655, 60504.39495605075, 60684.393156068756, 60687.69656151691, 60709.0, 63670.1760700682, 63905.0, 63923.68038159779, 64102.35897640964, 64145.0, 15778.605534861721, 16026.839731602768, 16054.518364449084, 16056.0, 16158.27287772053, 11038.613648522423, 11729.35488548138, 12037.217580857216, 12110.0, 12121.878781212075, 18680.34618788336, 18780.624387512173, 18799.15403806832, 18800.905995469937, 19078.713819292723, 5985.22192115031, 6048.939510604926, 6102.115193297036, 6224.595401298901, 6261.279952805395, 943.4150826487621, 946.6781294359813, 1043.0, 1099.2140619457127, 1112.0880877680224, 32225.194370140463, 32406.18984525406, 32716.672833271838, 32859.3428131436, 33329.50005749916, 1077.8113830079863, 1120.456578559398, 1124.083871644607, 1132.3941691195337, 1192.1595275330872, 16915.746263806053, 17302.567435814206, 17345.826541734674, 17443.651126977642, 17491.30034798619, 145150.2742486281, 145295.0, 145841.0, 147203.0, 148244.2587787054, 59112.0, 59707.40292597105, 59852.70073649604, 59933.40066599278, 59975.70012149911, 1196.485511230162, 1312.8424589049184, 1348.615644541301, 1365.0956915103375, 1373.1006190944747, 31466.213344666565, 33504.16239594029, 33756.0, 33992.320153596294, 34424.31151377009, 50348.74825625995, 55925.0, 57442.42557574538, 57489.71255143865, 63008.68495657492, 462788.0, 463145.0, 465671.0, 465676.0, 466094.0, 26044.869775651, 26314.21057368282, 26507.0, 28980.0, 29533.409331813673, 46268.537314626425, 46427.303590445496, 46720.29919551277, 47040.29439558478, 47876.0, 39510.0, 39735.80132099321, 41123.7943810291, 41486.377704335064, 42262.788686056374, 39422.408663870636, 39674.206515868944, 40276.39585406163, 40756.38865416962, 41179.7941010293, 39571.0, 39847.60152398439, 40617.390739139526, 40823.79588102041, 41072.79463602663, 33387.499187512694, 36201.637983619825, 36474.45288320624, 37164.44253336148, 37424.43863341997, 27197.32006699769, 27329.453410931274, 27408.58887116655, 27586.448271034868, 27616.723832762218], "value": 19982.8757220907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8114199474276, 384.86144987804386, 391.58687584598255, 399.6862462966571, 419.12403077567876, 14520.05943536404, 16938.66122677547, 19121.71317430236, 19888.303909363174, 19892.303769368056, 18837.340693075745, 18875.716864247046, 18888.905555472204, 19186.520336991583, 19210.0, 4093.283675356801, 5629.8592535186535, 5780.104083866986, 5802.12968054791, 5814.4766970972605, 6157.6305421674615, 6629.105070815426, 6635.037919501669, 6654.70053847578, 6702.530822842403, 5484.890302193974, 5736.770529178849, 5768.336641286242, 6599.406053455188, 6612.338766123373, 5802.100674395476, 5810.680412577307, 5813.360530341659, 5828.388019257981, 5870.73581688825, 5428.565714742811, 5623.746931388097, 5673.546116310686, 5675.886482270332, 5694.487496125327, 14035.403450361613, 14313.0, 16550.66898662032, 22973.0, 23013.194538191085, 2247.3370355745096, 2278.1001504405667, 2422.854628722282, 2446.5963116085823, 3003.0840593618937, 10053.396796192252, 10159.847602285972, 10163.339382940085, 10558.736031599195, 10638.521266543024, 1934.7678278606516, 1945.3963732747773, 1983.4545499987476, 2006.367994081874, 2007.4479518132484, 80246.0, 80864.19135808684, 80977.59511202465, 81276.0, 82414.17585824124, 10901.672949811518, 11071.944640276746, 11157.995780379642, 11160.497777600027, 11427.0, 15691.372345106069, 15692.0, 15716.921415393079, 15723.685526289639, 15740.763888541682, 8173.223543763333, 8373.41386102979, 8475.237228649452, 8561.357898157663, 8570.100139485265, 7990.880136797953, 8012.198780121941, 8045.396595255379, 8214.507129572245, 8228.094909559944, 4735.881602959954, 4840.419149702058, 4868.488808675038, 4951.851444456672, 4953.43035550909, 1953.082051435823, 1974.7136665183755, 1976.555275063128, 1998.4504261328252, 2014.0634604908787, 916.9449833010041, 973.9659111931048, 982.886967998675, 997.4663554998041, 1076.8330908709163, 18723.625527489374, 19216.231350745813, 19224.231030758612, 19236.519087022938, 19774.209031638573, 930.1907340613574, 944.4380593546829, 991.9900800991898, 1024.9743756406, 1025.4308858583408, 10253.282270241161, 10572.577096916037, 10779.299345542671, 10847.837282440769, 10912.23614347004, 333001.0, 483514.0, 486399.0, 491118.0, 491385.15953869384, 84302.57848710717, 84910.57544712236, 86822.13177868267, 88124.0, 89859.0, 1013.1438934100673, 1052.1530168214508, 1054.225144518778, 1067.7971185474735, 1075.9246852720235, 17517.21172547264, 17652.558686032953, 18277.451676449728, 18344.816551834843, 18582.256709732, 41415.7929210352, 41778.37332439955, 43366.34950475682, 43486.56513434825, 44754.0, 58340.708296458244, 58364.4163558359, 59547.40452595419, 59749.70125149346, 60255.39744602498, 8269.255766981001, 8461.32309415233, 8532.70135545253, 8718.782030449289, 8731.170538798804, 9291.256699464162, 12024.458899349374, 13461.259630720013, 13683.931580342034, 13839.861601383856, 11673.066154707432, 11764.529418823151, 11799.0, 11887.28676279426, 12307.323097229739, 11456.599019034295, 11573.594924177612, 11712.414379281172, 11843.348615826213, 11950.402479876146, 11679.474423651127, 11771.882281177079, 11974.700632484257, 12493.43779529905, 12566.371681416076, 7258.963705181441, 7593.1647518774, 7624.580648064188, 8506.234438900528, 8645.654173832976, 8853.15894989975, 10652.147828173573, 11604.941975290407, 11790.115741319263, 11791.29252244868], "value": 9194.417965700173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.3004437692407, 1477.5130691567897, 1482.5774654223549, 1602.5192442267323, 1756.6662334156501, 8645.783855403619, 9012.819743605132, 9124.81750364993, 9323.487208203545, 9339.766505837357, 9020.72937811865, 9216.308776841746, 9220.953895230532, 9227.169554740072, 9235.39969901956, 2286.416963674265, 2316.698829152208, 2319.199876042771, 2321.58211521926, 2323.570139524185, 2312.19073324336, 2335.3344296875393, 2369.869657168855, 2370.7984821290124, 2373.6083546214854, 2341.1454818991033, 2365.077619728307, 2366.0299277296313, 2369.230000249917, 2370.300761275419, 2287.0623044551653, 2302.5510025545027, 2307.7230732312146, 2311.9075236990584, 2333.1134169015663, 2304.896279667419, 2305.91929282476, 2310.5609934112463, 2311.653252012195, 2311.6763653088583, 8854.29165666745, 9063.954680226556, 9148.313876459226, 9177.862332065024, 9201.677941272023, 5188.143956247215, 5346.91979620306, 5405.621606487547, 5416.350037995427, 5420.24116623673, 3440.088376580208, 3464.2725027744204, 3529.770564913298, 3544.167120726627, 3559.323728491604, 1123.8089524780808, 1135.7444574970648, 1160.0893298760516, 1160.9435413773426, 1167.4629670351649, 12707.555235566711, 12884.162529435556, 12973.41619627119, 13006.479740810357, 13028.934855325757, 4687.648426368036, 4723.82703956184, 4763.3807605011125, 4823.2282834746275, 4943.876403089879, 10865.0, 10888.074513666268, 10892.237543372046, 10901.34591924487, 10913.072388846878, 5447.700376479253, 5478.972605137029, 5481.369642491085, 5487.945120548823, 5489.698066606375, 4392.165488557228, 4710.222813235778, 4828.034393121319, 4848.587870031087, 5038.622103342264, 3926.096997690547, 4048.109415928491, 4100.138970816102, 4158.91682166355, 4225.661947044229, 1253.8119282107757, 1308.8298521192185, 1309.502389092158, 1309.5154792726753, 1318.2683610596212, 890.4879694175875, 937.9718608441758, 1014.5028935821542, 1017.1100287248657, 1034.5086084109987, 6066.120412540157, 6080.665563393967, 6202.658853762996, 6232.3144454110015, 6296.5592408531875, 448.61867412698945, 459.993100103492, 466.8809453589313, 468.3747197491319, 468.5735980258017, 4312.525622181557, 4363.650907927358, 4368.388425620352, 4393.538678438782, 4403.3174857897075, 11269.323840569592, 11765.941170294094, 11767.411629418495, 11777.116716246315, 11844.348560829065, 11636.12729045325, 11637.301761894314, 11647.068234541217, 11650.475728592233, 11661.125415593695, 7952.522848629101, 8213.876791848126, 8250.422470427133, 8471.110533394152, 8471.49171049739, 6273.435390814849, 6329.683515824098, 6525.0, 6603.504737144637, 6650.600963942179, 10265.435401053013, 10511.26421150512, 10676.199285053497, 10723.0, 10846.566137354734, 10388.948055259676, 10961.232713709964, 10962.123030157727, 10962.835557466486, 10972.396518191576, 7040.401565866754, 7664.80837979055, 7669.348105411103, 7810.297073263434, 7873.645685944261, 8848.690295839871, 8867.157620026088, 8874.911250887408, 8960.417572857743, 8962.0, 7764.495307804975, 7968.561729104955, 8085.0, 8115.4724942880885, 8272.296854767412, 7659.195784442776, 7799.103103143211, 7853.293203611703, 7874.448788584744, 7925.207479252259, 7017.789466316019, 7153.463490238149, 7153.570785752871, 7158.534695244793, 7164.104486939133, 5210.817621383233, 5237.502437268454, 5320.973395133, 5323.653962492425, 5422.77023921342, 5339.519443250126, 5375.758090885842, 5457.154141108134, 5489.313835770528, 5529.529989950738], "value": 4689.800396819889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.5456778290301, 293.1703279718397, 301.4664044640986, 305.80122920101945, 306.5845778969498, 5052.797888084481, 5133.0, 5155.3040339554145, 5198.168293073114, 5211.713355765436, 5179.4561571035065, 5211.921821172676, 5218.921716174251, 5220.190870415092, 5222.738863056851, 4042.6361627453525, 4049.9190016199805, 4064.695147863915, 4067.5525692173987, 4070.104576993057, 3884.3008258513455, 4000.9799951000205, 4070.8778736637946, 4071.5521292657786, 4072.7759973201464, 3977.781222032787, 3981.86063487778, 3984.681225501967, 3987.8006099695044, 3989.8603548875794, 3956.3867600521967, 3962.1877515109477, 3967.4643923070303, 3968.3253846846105, 3980.0248939009984, 3342.548755917944, 3453.395655760257, 3457.94813077804, 3474.4788281757687, 3482.7736197147105, 5039.874003149951, 5044.949550504484, 5049.621278404097, 5066.822661206877, 5082.932584157332, 4525.389072475206, 4528.230200865861, 4528.569785870337, 4531.660125490602, 4535.977320113411, 5115.544538621482, 5342.679439233659, 5402.37872644647, 5407.459254074561, 5408.432114627986, 3797.240551889633, 3797.4303854421782, 3799.3920972644246, 3802.4676545283683, 3812.989557767194, 5621.522170615462, 5634.1829085457275, 5653.9151912721345, 5656.066748986413, 5657.32112146545, 3777.490038844776, 3835.6547910688173, 3878.9139041068547, 3882.5729169791302, 3888.416737489399, 3873.573906870242, 3894.6300101490315, 3898.1618951924906, 3899.454076429302, 3902.824372903169, 4475.552444755564, 4506.81972721094, 4513.842015529441, 4545.204589196877, 4546.295139322754, 5225.242339860775, 5347.679139251657, 5413.2150838128255, 5454.618136755237, 5469.1249400096585, 1320.683036071336, 1347.2590075458459, 1353.8307711536058, 1358.4973559782745, 1360.5306169371552, 835.8996920369473, 848.9448185867899, 857.9918595650087, 863.404251066762, 865.191046371632, 4605.585497305192, 4637.721736695809, 4649.907271791127, 4662.114198302312, 4707.270373092176, 4861.225652636762, 4891.290762839369, 4902.632302577321, 4912.189488734319, 4918.163912134945, 4407.471103467605, 4563.8134085137435, 4631.0, 4654.394928659321, 4658.254679251304, 2569.982563687496, 2595.4419799743146, 2609.069288726329, 2621.5843444540114, 2622.973770262311, 4956.628252880976, 5018.924716129261, 5026.084870774942, 5034.345535080416, 5054.332070416754, 4948.935978764583, 4972.204447288416, 4977.427595826454, 4986.326845875833, 5284.841454756363, 5734.913976290359, 5767.538596912237, 5773.430823283682, 5781.277340332458, 5801.970990145022, 5548.55611551083, 5561.4716601922755, 5581.944180558143, 5582.49757521825, 5597.020521408818, 5372.489613486712, 5465.180222966586, 5486.780528778804, 5534.086875665631, 5535.903431460771, 5725.16985037159, 5725.627834190931, 5732.398098199796, 5746.856328591819, 5749.453801888814, 3596.568411790497, 3785.4511095891494, 3835.271298453285, 3874.53505579321, 3880.922381552297, 5541.861453463695, 5544.112941929272, 5547.334319881478, 5549.916751248654, 5569.805056822992, 5396.865078373072, 5421.484958928895, 5441.455854414527, 5451.727413629382, 5457.481539253765, 5237.319148510669, 5390.164524498709, 5413.621046526705, 5418.485243901823, 5420.864478388072, 5350.411454739898, 5353.143497040455, 5363.302770639792, 5366.490183432567, 5373.408925018167, 5168.715720635401, 5431.375391829832, 5435.456454354691, 5436.640839790052, 5439.782408703608, 5292.179712144623, 5353.384360798403, 5373.629724420248, 5382.407935127211, 5389.83830485086], "value": 4010.745394330021, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.4660297982473, 742.2651574940807, 803.3934379543443, 855.9572021398936, 865.8181781825818, 16054.59863503413, 17139.057351845644, 17178.05520696363, 17187.914060429695, 17193.828061719378, 15582.065076095414, 15726.84273157268, 15728.449504267353, 15754.0, 15763.84236157638, 640.2317219336803, 783.8589053970283, 810.4853418079502, 814.027237451246, 814.3770015937812, 811.5333683132193, 812.6708682983401, 812.6830536090929, 813.9430239883211, 814.0963530481162, 852.4842470305468, 854.1287886355914, 854.2141230068352, 855.7133360324299, 856.019857263433, 686.6669665212393, 702.6381413572014, 703.5673061067458, 839.836231934773, 849.4563479373206, 610.3652201710216, 615.1019511513196, 615.6860001399274, 616.214326733414, 616.22355831652, 16271.430499932563, 16484.175791210393, 16486.505404837873, 16517.83482165175, 16531.91734041322, 15470.303836327392, 15592.0, 15646.295916683663, 15830.970986885815, 15859.841401585953, 12678.0, 12864.09951303409, 13299.401526931311, 13308.80036799439, 13432.32838358088, 3896.980515097435, 3993.6805055595482, 4018.136100738326, 4089.2434899543678, 4091.8747344480207, 81667.9999999994, 83362.0, 86516.56741716314, 86746.56626716827, 87374.0, 11832.155880804004, 11837.822432663517, 12040.21738586989, 12117.212381195193, 12390.5663301784, 23889.0, 23919.52160956771, 23941.7605823943, 23960.760392395852, 23979.52040959171, 9048.909510904938, 9437.292203084797, 9594.280428967855, 9776.217902567778, 9776.41341519497, 5154.252633368215, 5173.508516690908, 5207.140821764442, 5208.765605547759, 5398.514133727984, 3649.39784935488, 3747.9250414991548, 3760.9435858462143, 3760.9623903761158, 3761.6990640748672, 626.2797782550012, 635.8791829552371, 637.2225884420999, 643.996780016097, 650.8665723526666, 678.3453966921944, 722.7253643615497, 737.7049180327912, 761.4200533892196, 778.0468925566137, 10250.487475626189, 10592.099671528007, 10609.021735895532, 10922.672319830259, 10950.0, 673.5554534007531, 702.6416527570975, 713.0552018575409, 715.4169351978121, 716.2050124361954, 5005.273946703274, 5013.222950442687, 5106.719130447861, 5124.615653825978, 5208.270842082112, 69863.65068174627, 92791.0, 121375.0, 126519.0, 130049.34975325063, 107996.46001769941, 109997.0, 111253.0, 111801.44099279614, 111971.0, 58142.70928645414, 80309.59845200737, 80605.0, 85436.57281713551, 88393.55803221071, 9713.660021899199, 10307.535489645406, 10729.248952573245, 10974.341539507335, 11024.448777560929, 47964.5203547974, 52163.47836521586, 53086.2037069452, 53463.0, 54288.72855635697, 45257.77371113255, 45722.31416528688, 45771.56713246586, 50905.236421452966, 71921.6403917977, 14671.193084380462, 14808.0, 14831.33259003369, 14871.330790114254, 14950.925245373703, 15920.442784502487, 16239.675206495567, 16313.429029983894, 16486.34054637801, 16580.088095154882, 14954.90631311639, 15061.849381506483, 15307.846921531087, 15794.0, 16036.599085022968, 14563.635909102357, 14917.47788827386, 15182.696346073237, 15223.467178649138, 15579.0, 14291.285435727965, 14558.199299038655, 14672.3717597893, 14886.627834304229, 14940.626484337978, 11232.719182020188, 11252.099086835293, 11857.34784586856, 11941.16411851162, 12287.754244914873, 11622.302661840316, 11734.354610496504, 12061.457234424297, 12072.698182545506, 12134.150609457252], "value": 7877.006902986366, "unit": "score"}], "name": "dromaeo_css", "value": 7235.138661776857, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 114.0, 110.0, 112.0, 111.0, 113.0, 119.0, 114.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 119.0, 146.0, 184.0, 118.0, 149.0, 143.0, 121.0, 171.0, 117.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 75.0, 171.0, 76.0, 75.0, 74.0, 73.0, 170.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 152.0, 85.0, 85.0, 84.0, 136.0, 85.0, 86.0, 156.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 52.0, 52.0, 51.0, 51.0, 51.0, 52.0, 52.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 65.0, 65.0, 63.0, 63.0, 63.0, 65.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 91.0, 82.0, 78.0, 78.0, 77.0, 78.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 124.0, 130.0, 126.0, 124.0, 132.0, 131.0, 158.0, 131.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 166.0, 163.0, 161.0, 162.0, 164.0, 169.0, 160.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 68.0, 66.0, 63.0, 68.0, 64.0, 64.0, 66.0, 69.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1528.3000000000002, "alertThreshold": 2.0}]} 08:25:59 INFO - Return code: 0 08:25:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:59 INFO - # TBPL SUCCESS # 08:25:59 INFO - Running post-action listener: _resource_record_post_action 08:25:59 INFO - [mozharness: 2016-08-23 15:25:59.757218Z] Finished run-tests step (success) 08:25:59 INFO - Running post-run listener: _resource_record_post_run 08:25:59 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 418029568; Read time: 216; Write time: 295084 08:25:59 INFO - TinderboxPrint: CPU usage
13.3% 08:25:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 08:25:59 INFO - TinderboxPrint: I/O write bytes / time
418,029,568 / 295,084 08:25:59 INFO - TinderboxPrint: CPU idle
8,278.9 (86.7%) 08:25:59 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 08:25:59 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128917504; Read time: 0; Write time: 87868 08:25:59 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288600064; Read time: 200; Write time: 207188 08:26:00 INFO - Running post-run listener: _upload_blobber_files 08:26:00 INFO - Blob upload gear active. 08:26:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:26:00 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'] 08:26:00 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 08:26:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:01 INFO - (blobuploader) - INFO - Done attempting. 08:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:02 INFO - (blobuploader) - INFO - Done attempting. 08:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:08 INFO - (blobuploader) - INFO - Done attempting. 08:26:08 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:08 INFO - Return code: 0 08:26:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf0902ce0ae295e8571cb2981037170caadefb155bab54763db8d1d3e9a6e5ca027063367a90424ca9e66258f0c53509e1a88009222409a847052b10615f590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12bbffa862176c603ffc86a982100fdd529ef56e902d13624da547f287cb89acc5918aa5d9ba4b6526486baaac64319b65be2bf98f8b9e561be508b5bb9b4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e1965368993792f3becae9f814d2d757d0aa1392a174923f1534542061728a0d8462589e9926e20f8b8a99836e33894d9d245e8c99282402b1f86e6ea69f593"} 08:26:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:08 INFO - Contents: 08:26:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf0902ce0ae295e8571cb2981037170caadefb155bab54763db8d1d3e9a6e5ca027063367a90424ca9e66258f0c53509e1a88009222409a847052b10615f590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12bbffa862176c603ffc86a982100fdd529ef56e902d13624da547f287cb89acc5918aa5d9ba4b6526486baaac64319b65be2bf98f8b9e561be508b5bb9b4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e1965368993792f3becae9f814d2d757d0aa1392a174923f1534542061728a0d8462589e9926e20f8b8a99836e33894d9d245e8c99282402b1f86e6ea69f593"} 08:26:08 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:08 INFO - Copying logs to upload dir... 08:26:08 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.632165 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-23 08:26:08.334396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:26:08.337544) ========= 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=0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989 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/aaf0902ce0ae295e8571cb2981037170caadefb155bab54763db8d1d3e9a6e5ca027063367a90424ca9e66258f0c53509e1a88009222409a847052b10615f590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12bbffa862176c603ffc86a982100fdd529ef56e902d13624da547f287cb89acc5918aa5d9ba4b6526486baaac64319b65be2bf98f8b9e561be508b5bb9b4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e1965368993792f3becae9f814d2d757d0aa1392a174923f1534542061728a0d8462589e9926e20f8b8a99836e33894d9d245e8c99282402b1f86e6ea69f593"} build_url:https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf0902ce0ae295e8571cb2981037170caadefb155bab54763db8d1d3e9a6e5ca027063367a90424ca9e66258f0c53509e1a88009222409a847052b10615f590", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e12bbffa862176c603ffc86a982100fdd529ef56e902d13624da547f287cb89acc5918aa5d9ba4b6526486baaac64319b65be2bf98f8b9e561be508b5bb9b4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e1965368993792f3becae9f814d2d757d0aa1392a174923f1534542061728a0d8462589e9926e20f8b8a99836e33894d9d245e8c99282402b1f86e6ea69f593"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:26:08.367430) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:26:08.367807) ========= 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=0e2a256762fed810e2f0f810000001b3-1471963622.829347-122288989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:26:08.448383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:26:08.448972) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:26:08.449699) ========= ========= Total master_lag: 0.16 =========