builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1471674084.43 results: success (0) buildid: 20160819203012 builduid: 6d844420b7d14b26bde65b708d671c21 revision: 1720386f83dc19ec161f70ae46d370edbf1e5e5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.432683) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.433078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.433348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.486528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.486807) ========= 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=836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 23:21: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% 225M=0s 2016-08-19 23:21:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.607245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.607573) ========= 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=836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018792 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.656744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:24.657106) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1720386f83dc19ec161f70ae46d370edbf1e5e5c --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 1720386f83dc19ec161f70ae46d370edbf1e5e5c --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=836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 23:21:25,433 truncating revision to first 12 chars 2016-08-19 23:21:25,433 Setting DEBUG logging. 2016-08-19 23:21:25,433 attempt 1/10 2016-08-19 23:21:25,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1720386f83dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 23:21:25,752 unpacking tar archive at: fx-team-1720386f83dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:25.311407) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:25.311765) ========= script_repo_revision: 1720386f83dc19ec161f70ae46d370edbf1e5e5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:25.312161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:25.312438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 23:21:25.319855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-19 23:21:25.320197) ========= /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=836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:21:26 INFO - MultiFileLogger online at 20160819 23:21:26 in /builds/slave/test 23:21: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 23:21:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:21:26 INFO - {'append_to_log': False, 23:21:26 INFO - 'base_work_dir': '/builds/slave/test', 23:21:26 INFO - 'blob_upload_branch': 'Fx-Team', 23:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:21:26 INFO - 'branch': 'Fx-Team', 23:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:21:26 INFO - 'config_files': ('talos/linux_config.py',), 23:21:26 INFO - 'default_actions': ('clobber', 23:21:26 INFO - 'read-buildbot-config', 23:21:26 INFO - 'download-and-extract', 23:21:26 INFO - 'populate-webroot', 23:21:26 INFO - 'create-virtualenv', 23:21:26 INFO - 'install', 23:21:26 INFO - 'run-tests'), 23:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:21:26 INFO - 'download_minidump_stackwalk': True, 23:21:26 INFO - 'download_symbols': 'ondemand', 23:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 23:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 23:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:21:26 INFO - 'installer_path': 'installer.exe', 23:21:26 INFO - 'log_level': 'info', 23:21:26 INFO - 'log_name': 'talos', 23:21:26 INFO - 'log_to_console': True, 23:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:21:26 INFO - 'opt_config_files': (), 23:21:26 INFO - 'pip_index': False, 23:21:26 INFO - 'sps_profile': False, 23:21:26 INFO - 'sps_profile_interval': 0, 23:21:26 INFO - 'suite': 'dromaeojs', 23:21:26 INFO - 'system_bits': '32', 23:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:21:26 INFO - 'title': 'talos-linux64-ix-028', 23:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:21:26 INFO - 'use_talos_json': True, 23:21:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:21:26 INFO - 'work_dir': 'build'} 23:21:26 INFO - [mozharness: 2016-08-20 06:21:26.191084Z] Running clobber step. 23:21:26 INFO - Running pre-action listener: _resource_record_pre_action 23:21:26 INFO - Running main action method: clobber 23:21:26 INFO - rmtree: /builds/slave/test/build 23:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:21:26 INFO - Running post-action listener: _resource_record_post_action 23:21:26 INFO - [mozharness: 2016-08-20 06:21:26.655069Z] Finished clobber step (success) 23:21:26 INFO - [mozharness: 2016-08-20 06:21:26.655168Z] Running read-buildbot-config step. 23:21:26 INFO - Running pre-action listener: _resource_record_pre_action 23:21:26 INFO - Running main action method: read_buildbot_config 23:21:26 INFO - Using buildbot properties: 23:21:26 INFO - { 23:21:26 INFO - "project": "", 23:21:26 INFO - "product": "firefox", 23:21:26 INFO - "script_repo_revision": "production", 23:21:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:21:26 INFO - "repository": "", 23:21:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:21:26 INFO - "buildid": "20160819203012", 23:21:26 INFO - "pgo_build": "True", 23:21:26 INFO - "basedir": "/builds/slave/test", 23:21:26 INFO - "buildnumber": 378, 23:21:26 INFO - "slavename": "talos-linux64-ix-028", 23:21:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:21:26 INFO - "platform": "ubuntu64_hw", 23:21:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:21:26 INFO - "branch": "fx-team", 23:21:26 INFO - "repo_path": "integration/fx-team", 23:21:26 INFO - "revision": "1720386f83dc19ec161f70ae46d370edbf1e5e5c", 23:21:26 INFO - "stage_platform": "linux64-pgo", 23:21:26 INFO - "builduid": "6d844420b7d14b26bde65b708d671c21", 23:21:26 INFO - "slavebuilddir": "test" 23:21:26 INFO - } 23:21:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:21:26 INFO - Running post-action listener: _resource_record_post_action 23:21:26 INFO - [mozharness: 2016-08-20 06:21:26.657607Z] Finished read-buildbot-config step (success) 23:21:26 INFO - [mozharness: 2016-08-20 06:21:26.657695Z] Running download-and-extract step. 23:21:26 INFO - Running pre-action listener: _resource_record_pre_action 23:21:26 INFO - Running main action method: download_and_extract 23:21:26 INFO - mkdir: /builds/slave/test/build/tests 23:21: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')]} 23:21:26 INFO - trying https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:21:26 INFO - Downloading https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:27 INFO - Downloaded 1361 bytes. 23:21:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:21:27 INFO - Using the following test package requirements: 23:21:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:21:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:21:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:21:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'jsshell-linux-x86_64.zip'], 23:21:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:21:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:21:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:21:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:21:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:21:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:21:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:21: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')]} 23:21:27 INFO - trying https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:21:27 INFO - Downloading https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:28 INFO - Downloaded 21920435 bytes. 23:21: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 23:21: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 23:21: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')]} 23:21:32 INFO - trying https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:21:32 INFO - Downloading https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:33 INFO - Downloaded 21920435 bytes. 23:21: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 23:21: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')]} 23:21:37 INFO - trying https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:21:37 INFO - Downloading https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:38 INFO - Downloaded 14413981 bytes. 23:21: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 23:21: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')]} 23:21:38 INFO - trying https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:21:38 INFO - Downloading https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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 23:21:40 INFO - Downloaded 59693597 bytes. 23:21:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:21:40 INFO - mkdir: /builds/slave/test/properties 23:21:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:21:40 INFO - Writing to file /builds/slave/test/properties/build_url 23:21:40 INFO - Contents: 23:21:40 INFO - build_url:https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:21:40 INFO - Running post-action listener: _resource_record_post_action 23:21:40 INFO - Running post-action listener: set_extra_try_arguments 23:21:40 INFO - [mozharness: 2016-08-20 06:21:40.702896Z] Finished download-and-extract step (success) 23:21:40 INFO - [mozharness: 2016-08-20 06:21:40.703191Z] Running populate-webroot step. 23:21:40 INFO - Running pre-action listener: _resource_record_pre_action 23:21:40 INFO - Running main action method: populate_webroot 23:21:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:21:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:21:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:21:40 INFO - '--tppagecycles', 23:21:40 INFO - '7'], 23:21:40 INFO - 'tests': ['tsvgm']}}, 23:21:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:21:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:21:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:21:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:21:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:21:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:21:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['damp', 'tps']}, 23:21:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'tests': ['damp', 'tps']}, 23:21:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['dromaeo_dom']}, 23:21:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:21:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['basic_compositor_video']}, 23:21:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:21:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['a11yr', 23:21:40 INFO - 'ts_paint', 23:21:40 INFO - 'tpaint', 23:21:40 INFO - 'sessionrestore', 23:21:40 INFO - 'sessionrestore_no_auto_restore', 23:21:40 INFO - 'tabpaint']}, 23:21:40 INFO - 'other-e10s': {'tests': ['a11yr', 23:21:40 INFO - 'ts_paint', 23:21:40 INFO - 'tpaint', 23:21:40 INFO - 'sessionrestore', 23:21:40 INFO - 'sessionrestore_no_auto_restore', 23:21:40 INFO - 'tabpaint']}, 23:21:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:21:40 INFO - 'ts_paint', 23:21:40 INFO - 'tpaint', 23:21:40 INFO - 'sessionrestore', 23:21:40 INFO - 'sessionrestore_no_auto_restore', 23:21:40 INFO - 'tabpaint']}, 23:21:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:21:40 INFO - 'ts_paint', 23:21:40 INFO - 'tpaint', 23:21:40 INFO - 'sessionrestore', 23:21:40 INFO - 'sessionrestore_no_auto_restore', 23:21:40 INFO - 'tabpaint']}, 23:21:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['a11yr', 23:21:40 INFO - 'ts_paint', 23:21:40 INFO - 'tpaint', 23:21:40 INFO - 'sessionrestore', 23:21:40 INFO - 'sessionrestore_no_auto_restore', 23:21:40 INFO - 'tabpaint']}, 23:21:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['a11yr', 23:21:40 INFO - 'ts_paint', 23:21:40 INFO - 'tpaint', 23:21:40 INFO - 'sessionrestore', 23:21:40 INFO - 'sessionrestore_no_auto_restore', 23:21:40 INFO - 'tabpaint']}, 23:21:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['tsvgx', 23:21:40 INFO - 'tsvgr_opacity', 23:21:40 INFO - 'tart', 23:21:40 INFO - 'tscrollx', 23:21:40 INFO - 'cart']}, 23:21:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:21:40 INFO - 'tsvgr_opacity', 23:21:40 INFO - 'tart', 23:21:40 INFO - 'tscrollx', 23:21:40 INFO - 'cart']}, 23:21:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'talos_options': ['--disable-e10s'], 23:21:40 INFO - 'tests': ['tp5o']}, 23:21:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'tests': ['tp5o']}, 23:21:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'talos_options': ['--disable-e10s', 23:21:40 INFO - '--xperf_path', 23:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:21:40 INFO - 'tests': ['tp5n']}, 23:21:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:40 INFO - 'talos_options': ['--xperf_path', 23:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:21:40 INFO - 'tests': ['tp5n']}}, 23:21:40 INFO - 'talos.zip': {'path': '', 23:21:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:21:40 INFO - Running post-action listener: _resource_record_post_action 23:21:40 INFO - [mozharness: 2016-08-20 06:21:40.722397Z] Finished populate-webroot step (success) 23:21:40 INFO - [mozharness: 2016-08-20 06:21:40.722491Z] Running create-virtualenv step. 23:21:40 INFO - Running pre-action listener: _resource_record_pre_action 23:21:40 INFO - Running main action method: create_virtualenv 23:21:40 INFO - Creating virtualenv /builds/slave/test/build/venv 23:21: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 23:21:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:21:40 INFO - Using real prefix '/usr' 23:21:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:21:41 INFO - Installing distribute.............................................................................................................................................................................................done. 23:21:43 INFO - Installing pip.................done. 23:21:43 INFO - Return code: 0 23:21:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:43 INFO - Using env: {'DISPLAY': ':0', 23:21:43 INFO - 'HOME': '/home/cltbld', 23:21:43 INFO - 'LANG': 'en_US.UTF-8', 23:21:43 INFO - 'LANGUAGE': 'en_US:en', 23:21:43 INFO - 'LOGNAME': 'cltbld', 23:21:43 INFO - 'MAIL': '/var/mail/cltbld', 23:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:43 INFO - 'MOZ_NO_REMOTE': '1', 23:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:43 INFO - 'NO_EM_RESTART': '1', 23:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:43 INFO - 'PWD': '/builds/slave/test', 23:21:43 INFO - 'SHELL': '/bin/bash', 23:21:43 INFO - 'SHLVL': '1', 23:21:43 INFO - 'TERM': 'linux', 23:21:43 INFO - 'TMOUT': '86400', 23:21:43 INFO - 'USER': 'cltbld', 23:21:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:43 INFO - '_': '/tools/buildbot/bin/python'} 23:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21: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 23:21:43 INFO - Cleaning up... 23:21:43 INFO - Return code: 0 23:21:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:43 INFO - Using env: {'DISPLAY': ':0', 23:21:43 INFO - 'HOME': '/home/cltbld', 23:21:43 INFO - 'LANG': 'en_US.UTF-8', 23:21:43 INFO - 'LANGUAGE': 'en_US:en', 23:21:43 INFO - 'LOGNAME': 'cltbld', 23:21:43 INFO - 'MAIL': '/var/mail/cltbld', 23:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:43 INFO - 'MOZ_NO_REMOTE': '1', 23:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:43 INFO - 'NO_EM_RESTART': '1', 23:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:43 INFO - 'PWD': '/builds/slave/test', 23:21:43 INFO - 'SHELL': '/bin/bash', 23:21:43 INFO - 'SHLVL': '1', 23:21:43 INFO - 'TERM': 'linux', 23:21:43 INFO - 'TMOUT': '86400', 23:21:43 INFO - 'USER': 'cltbld', 23:21:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:43 INFO - '_': '/tools/buildbot/bin/python'} 23:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:43 INFO - Downloading/unpacking psutil>=3.1.1 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:21:45 INFO - Installing collected packages: psutil 23:21:45 INFO - Running setup.py install for psutil 23:21:45 INFO - building 'psutil._psutil_linux' extension 23:21: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 23:21:45 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 23:21:45 INFO - building 'psutil._psutil_posix' extension 23:21:45 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 23:21: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 23:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:21:46 INFO - Successfully installed psutil 23:21:46 INFO - Cleaning up... 23:21:46 INFO - Return code: 0 23:21:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:46 INFO - Using env: {'DISPLAY': ':0', 23:21:46 INFO - 'HOME': '/home/cltbld', 23:21:46 INFO - 'LANG': 'en_US.UTF-8', 23:21:46 INFO - 'LANGUAGE': 'en_US:en', 23:21:46 INFO - 'LOGNAME': 'cltbld', 23:21:46 INFO - 'MAIL': '/var/mail/cltbld', 23:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:46 INFO - 'MOZ_NO_REMOTE': '1', 23:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:46 INFO - 'NO_EM_RESTART': '1', 23:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:46 INFO - 'PWD': '/builds/slave/test', 23:21:46 INFO - 'SHELL': '/bin/bash', 23:21:46 INFO - 'SHLVL': '1', 23:21:46 INFO - 'TERM': 'linux', 23:21:46 INFO - 'TMOUT': '86400', 23:21:46 INFO - 'USER': 'cltbld', 23:21:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:46 INFO - '_': '/tools/buildbot/bin/python'} 23:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:21:48 INFO - Installing collected packages: mozsystemmonitor 23:21:48 INFO - Running setup.py install for mozsystemmonitor 23:21:48 INFO - Successfully installed mozsystemmonitor 23:21:48 INFO - Cleaning up... 23:21:48 INFO - Return code: 0 23:21:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:48 INFO - Using env: {'DISPLAY': ':0', 23:21:48 INFO - 'HOME': '/home/cltbld', 23:21:48 INFO - 'LANG': 'en_US.UTF-8', 23:21:48 INFO - 'LANGUAGE': 'en_US:en', 23:21:48 INFO - 'LOGNAME': 'cltbld', 23:21:48 INFO - 'MAIL': '/var/mail/cltbld', 23:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:48 INFO - 'MOZ_NO_REMOTE': '1', 23:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:48 INFO - 'NO_EM_RESTART': '1', 23:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:48 INFO - 'PWD': '/builds/slave/test', 23:21:48 INFO - 'SHELL': '/bin/bash', 23:21:48 INFO - 'SHLVL': '1', 23:21:48 INFO - 'TERM': 'linux', 23:21:48 INFO - 'TMOUT': '86400', 23:21:48 INFO - 'USER': 'cltbld', 23:21:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:48 INFO - '_': '/tools/buildbot/bin/python'} 23:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:48 INFO - Downloading/unpacking jsonschema==2.5.1 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:21:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:50 INFO - Downloading functools32-3.2.3-2.tar.gz 23:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:21:50 INFO - warning: no files found matching '*.txt' 23:21:50 INFO - no previously-included directories found matching 'build' 23:21:50 INFO - no previously-included directories found matching 'dist' 23:21:50 INFO - no previously-included directories found matching '.git*' 23:21:50 INFO - Installing collected packages: jsonschema, functools32 23:21:51 INFO - Running setup.py install for functools32 23:21:51 INFO - warning: no files found matching '*.txt' 23:21:51 INFO - no previously-included directories found matching 'build' 23:21:51 INFO - no previously-included directories found matching 'dist' 23:21:51 INFO - no previously-included directories found matching '.git*' 23:21:51 INFO - Successfully installed jsonschema functools32 23:21:51 INFO - Cleaning up... 23:21:51 INFO - Return code: 0 23:21:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:51 INFO - Using env: {'DISPLAY': ':0', 23:21:51 INFO - 'HOME': '/home/cltbld', 23:21:51 INFO - 'LANG': 'en_US.UTF-8', 23:21:51 INFO - 'LANGUAGE': 'en_US:en', 23:21:51 INFO - 'LOGNAME': 'cltbld', 23:21:51 INFO - 'MAIL': '/var/mail/cltbld', 23:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:51 INFO - 'MOZ_NO_REMOTE': '1', 23:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:51 INFO - 'NO_EM_RESTART': '1', 23:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:51 INFO - 'PWD': '/builds/slave/test', 23:21:51 INFO - 'SHELL': '/bin/bash', 23:21:51 INFO - 'SHLVL': '1', 23:21:51 INFO - 'TERM': 'linux', 23:21:51 INFO - 'TMOUT': '86400', 23:21:51 INFO - 'USER': 'cltbld', 23:21:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:51 INFO - '_': '/tools/buildbot/bin/python'} 23:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:21:51 INFO - Cleaning up... 23:21:51 INFO - Return code: 0 23:21:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:51 INFO - Using env: {'DISPLAY': ':0', 23:21:51 INFO - 'HOME': '/home/cltbld', 23:21:51 INFO - 'LANG': 'en_US.UTF-8', 23:21:51 INFO - 'LANGUAGE': 'en_US:en', 23:21:51 INFO - 'LOGNAME': 'cltbld', 23:21:51 INFO - 'MAIL': '/var/mail/cltbld', 23:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:51 INFO - 'MOZ_NO_REMOTE': '1', 23:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:51 INFO - 'NO_EM_RESTART': '1', 23:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:51 INFO - 'PWD': '/builds/slave/test', 23:21:51 INFO - 'SHELL': '/bin/bash', 23:21:51 INFO - 'SHLVL': '1', 23:21:51 INFO - 'TERM': 'linux', 23:21:51 INFO - 'TMOUT': '86400', 23:21:51 INFO - 'USER': 'cltbld', 23:21:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:51 INFO - '_': '/tools/buildbot/bin/python'} 23:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:51 INFO - Downloading/unpacking blobuploader==1.2.4 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:53 INFO - Downloading blobuploader-1.2.4.tar.gz 23:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:21:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21:54 INFO - Downloading docopt-0.6.1.tar.gz 23:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:21:54 INFO - Running setup.py install for blobuploader 23:21:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:21:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:21:54 INFO - Running setup.py install for requests 23:21:54 INFO - Running setup.py install for docopt 23:21:54 INFO - Successfully installed blobuploader requests docopt 23:21:54 INFO - Cleaning up... 23:21:54 INFO - Return code: 0 23:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:54 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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21:54 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 23:21:54 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 23:21:54 INFO - Using env: {'DISPLAY': ':0', 23:21:54 INFO - 'HOME': '/home/cltbld', 23:21:54 INFO - 'LANG': 'en_US.UTF-8', 23:21:54 INFO - 'LANGUAGE': 'en_US:en', 23:21:54 INFO - 'LOGNAME': 'cltbld', 23:21:54 INFO - 'MAIL': '/var/mail/cltbld', 23:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:54 INFO - 'MOZ_NO_REMOTE': '1', 23:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:54 INFO - 'NO_EM_RESTART': '1', 23:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:54 INFO - 'PWD': '/builds/slave/test', 23:21:54 INFO - 'SHELL': '/bin/bash', 23:21:54 INFO - 'SHLVL': '1', 23:21:54 INFO - 'TERM': 'linux', 23:21:54 INFO - 'TMOUT': '86400', 23:21:54 INFO - 'USER': 'cltbld', 23:21:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:54 INFO - '_': '/tools/buildbot/bin/python'} 23:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:21:55 INFO - Running setup.py (path:/tmp/pip-3HTBMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:21:55 INFO - Running setup.py (path:/tmp/pip-3unw6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:21:55 INFO - Running setup.py (path:/tmp/pip-3haYaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:21:55 INFO - Running setup.py (path:/tmp/pip-NLmRVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:21:55 INFO - Running setup.py (path:/tmp/pip-66HgYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:21:55 INFO - Running setup.py (path:/tmp/pip-f2YNvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:21:55 INFO - Running setup.py (path:/tmp/pip-MDdXFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:21:55 INFO - Running setup.py (path:/tmp/pip-eX1gFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:21:55 INFO - Running setup.py (path:/tmp/pip-VZasWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:21:55 INFO - Running setup.py (path:/tmp/pip-_KXCFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:21:55 INFO - Running setup.py (path:/tmp/pip-JMXBl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:21:55 INFO - Running setup.py (path:/tmp/pip-6BHmhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:21:55 INFO - Running setup.py (path:/tmp/pip-UI2BQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:21:56 INFO - Running setup.py (path:/tmp/pip-AdyX9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:56 INFO - Running setup.py (path:/tmp/pip-PHplAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:21:56 INFO - Running setup.py (path:/tmp/pip-yfafKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:21:56 INFO - Running setup.py (path:/tmp/pip-o2ArRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:21:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:21:56 INFO - Running setup.py install for manifestparser 23:21:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:21:56 INFO - Running setup.py install for mozcrash 23:21:56 INFO - Running setup.py install for mozdebug 23:21:56 INFO - Running setup.py install for mozdevice 23:21:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:21:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:21:56 INFO - Running setup.py install for mozfile 23:21:56 INFO - Running setup.py install for mozhttpd 23:21:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:21:56 INFO - Running setup.py install for mozinfo 23:21:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Running setup.py install for mozInstall 23:21:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Running setup.py install for mozleak 23:21:57 INFO - Running setup.py install for mozlog 23:21:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Running setup.py install for moznetwork 23:21:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Running setup.py install for mozprocess 23:21:57 INFO - Running setup.py install for mozprofile 23:21:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Running setup.py install for mozrunner 23:21:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:21:57 INFO - Running setup.py install for mozscreenshot 23:21:57 INFO - Running setup.py install for moztest 23:21:57 INFO - Running setup.py install for mozversion 23:21:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:21:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:21:58 INFO - Cleaning up... 23:21:58 INFO - Return code: 0 23:21:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:21: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 23:21: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 23:21:58 INFO - Using env: {'DISPLAY': ':0', 23:21:58 INFO - 'HOME': '/home/cltbld', 23:21:58 INFO - 'LANG': 'en_US.UTF-8', 23:21:58 INFO - 'LANGUAGE': 'en_US:en', 23:21:58 INFO - 'LOGNAME': 'cltbld', 23:21:58 INFO - 'MAIL': '/var/mail/cltbld', 23:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:58 INFO - 'MOZ_NO_REMOTE': '1', 23:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:58 INFO - 'NO_EM_RESTART': '1', 23:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:58 INFO - 'PWD': '/builds/slave/test', 23:21:58 INFO - 'SHELL': '/bin/bash', 23:21:58 INFO - 'SHLVL': '1', 23:21:58 INFO - 'TERM': 'linux', 23:21:58 INFO - 'TMOUT': '86400', 23:21:58 INFO - 'USER': 'cltbld', 23:21:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:58 INFO - '_': '/tools/buildbot/bin/python'} 23:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:21:58 INFO - Running setup.py (path:/tmp/pip-JEJL0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:21: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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:21:58 INFO - Running setup.py (path:/tmp/pip-S7mCNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:21: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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:21:58 INFO - Running setup.py (path:/tmp/pip-kxRFW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:21: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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:21:58 INFO - Running setup.py (path:/tmp/pip-vZRQkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:21: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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:21:58 INFO - Running setup.py (path:/tmp/pip-zZM_MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:21: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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:21:58 INFO - Running setup.py (path:/tmp/pip-rho2dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:21: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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:21:58 INFO - Running setup.py (path:/tmp/pip-yRTaG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:21:58 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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:21:58 INFO - Running setup.py (path:/tmp/pip-sCOx_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:21:58 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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:21:58 INFO - Running setup.py (path:/tmp/pip-BCm3F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:21:58 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)) 23:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:21:58 INFO - Running setup.py (path:/tmp/pip-ATues9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:21:59 INFO - Running setup.py (path:/tmp/pip-NpyEEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:21:59 INFO - Running setup.py (path:/tmp/pip-wnapYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:21:59 INFO - Running setup.py (path:/tmp/pip-MMSQ0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:21:59 INFO - Running setup.py (path:/tmp/pip-JirgZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:59 INFO - Running setup.py (path:/tmp/pip-9_Yq2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:21:59 INFO - Running setup.py (path:/tmp/pip-xgKdZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:21: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)) 23:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:21:59 INFO - Running setup.py (path:/tmp/pip-lJh52c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21: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)) 23:21:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:21: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 23:22:01 INFO - Downloading blessings-1.6.tar.gz 23:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:22:01 INFO - Installing collected packages: blessings 23:22:01 INFO - Running setup.py install for blessings 23:22:01 INFO - Successfully installed blessings 23:22:01 INFO - Cleaning up... 23:22:01 INFO - Return code: 0 23:22:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:22:01 INFO - Reading from file tmpfile_stdout 23:22:01 INFO - Current package versions: 23:22:01 INFO - argparse == 1.2.1 23:22:01 INFO - blessings == 1.6 23:22:01 INFO - blobuploader == 1.2.4 23:22:01 INFO - docopt == 0.6.1 23:22:01 INFO - functools32 == 3.2.3-2 23:22:01 INFO - jsonschema == 2.5.1 23:22:01 INFO - manifestparser == 1.1 23:22:01 INFO - mozInstall == 1.12 23:22:01 INFO - mozcrash == 0.17 23:22:01 INFO - mozdebug == 0.1 23:22:01 INFO - mozdevice == 0.48 23:22:01 INFO - mozfile == 1.2 23:22:01 INFO - mozhttpd == 0.7 23:22:01 INFO - mozinfo == 0.9 23:22:01 INFO - mozleak == 0.1 23:22:01 INFO - mozlog == 3.3 23:22:01 INFO - moznetwork == 0.27 23:22:01 INFO - mozprocess == 0.23 23:22:01 INFO - mozprofile == 0.28 23:22:01 INFO - mozrunner == 6.12 23:22:01 INFO - mozscreenshot == 0.1 23:22:01 INFO - mozsystemmonitor == 0.3 23:22:01 INFO - moztest == 0.7 23:22:01 INFO - mozversion == 1.4 23:22:01 INFO - psutil == 3.1.1 23:22:01 INFO - requests == 1.2.3 23:22:01 INFO - wsgiref == 0.1.2 23:22:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:01 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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:22:01 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 23:22:01 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 23:22:01 INFO - Using env: {'DISPLAY': ':0', 23:22:01 INFO - 'HOME': '/home/cltbld', 23:22:01 INFO - 'LANG': 'en_US.UTF-8', 23:22:01 INFO - 'LANGUAGE': 'en_US:en', 23:22:01 INFO - 'LOGNAME': 'cltbld', 23:22:01 INFO - 'MAIL': '/var/mail/cltbld', 23:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:01 INFO - 'MOZ_NO_REMOTE': '1', 23:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:01 INFO - 'NO_EM_RESTART': '1', 23:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:01 INFO - 'PWD': '/builds/slave/test', 23:22:01 INFO - 'SHELL': '/bin/bash', 23:22:01 INFO - 'SHLVL': '1', 23:22:01 INFO - 'TERM': 'linux', 23:22:01 INFO - 'TMOUT': '86400', 23:22:01 INFO - 'USER': 'cltbld', 23:22:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:01 INFO - '_': '/tools/buildbot/bin/python'} 23:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22: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)) 23:22:02 INFO - Cleaning up... 23:22:02 INFO - Return code: 0 23:22:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:22: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')]} 23:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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 0x7f51eb8b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, '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': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', '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 23:22: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 23:22: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 23:22:02 INFO - Using env: {'DISPLAY': ':0', 23:22:02 INFO - 'HOME': '/home/cltbld', 23:22:02 INFO - 'LANG': 'en_US.UTF-8', 23:22:02 INFO - 'LANGUAGE': 'en_US:en', 23:22:02 INFO - 'LOGNAME': 'cltbld', 23:22:02 INFO - 'MAIL': '/var/mail/cltbld', 23:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:02 INFO - 'MOZ_NO_REMOTE': '1', 23:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:02 INFO - 'NO_EM_RESTART': '1', 23:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:02 INFO - 'PWD': '/builds/slave/test', 23:22:02 INFO - 'SHELL': '/bin/bash', 23:22:02 INFO - 'SHLVL': '1', 23:22:02 INFO - 'TERM': 'linux', 23:22:02 INFO - 'TMOUT': '86400', 23:22:02 INFO - 'USER': 'cltbld', 23:22:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:02 INFO - '_': '/tools/buildbot/bin/python'} 23:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:22:02 INFO - Cleaning up... 23:22:02 INFO - Return code: 0 23:22:02 INFO - Running post-action listener: _resource_record_post_action 23:22:02 INFO - Running post-action listener: _start_resource_monitoring 23:22:02 INFO - Starting resource monitoring. 23:22:02 INFO - [mozharness: 2016-08-20 06:22:02.386915Z] Finished create-virtualenv step (success) 23:22:02 INFO - [mozharness: 2016-08-20 06:22:02.387372Z] Running install step. 23:22:02 INFO - Running pre-action listener: _resource_record_pre_action 23:22:02 INFO - Running main action method: install 23:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:22:02 INFO - Reading from file tmpfile_stdout 23:22:02 INFO - Detecting whether we're running mozinstall >=1.0... 23:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:22:02 INFO - Reading from file tmpfile_stdout 23:22:02 INFO - Output received: 23:22:02 INFO - Usage: mozinstall [options] installer 23:22:02 INFO - Options: 23:22:02 INFO - -h, --help show this help message and exit 23:22:02 INFO - -d DEST, --destination=DEST 23:22:02 INFO - Directory to install application into. [default: 23:22:02 INFO - "/builds/slave/test"] 23:22:02 INFO - --app=APP Application being installed. [default: firefox] 23:22:02 INFO - mkdir: /builds/slave/test/build/application 23:22: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'] 23:22: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 23:22:19 INFO - Reading from file tmpfile_stdout 23:22:19 INFO - Output received: 23:22:19 INFO - /builds/slave/test/build/application/firefox/firefox 23:22:19 INFO - Running post-action listener: _resource_record_post_action 23:22:19 INFO - [mozharness: 2016-08-20 06:22:19.682445Z] Finished install step (success) 23:22:19 INFO - [mozharness: 2016-08-20 06:22:19.682691Z] Running run-tests step. 23:22:19 INFO - Running pre-action listener: _resource_record_pre_action 23:22:19 INFO - Running main action method: run_tests 23:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:22:19 INFO - Python 2.7.3 23:22:19 INFO - Return code: 0 23:22:19 INFO - grabbing minidump binary from tooltool 23:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:19 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 0x1d2c370>, '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 0x1d2f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2fd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:22:19 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 23:22:19 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 23:22:19 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 23:22:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:22:19 INFO - Return code: 0 23:22:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:22:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:22:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:22:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:22:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:22:19 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/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 23:22:19 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/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 23:22:19 INFO - Using env: {'DISPLAY': ':0', 23:22:19 INFO - 'HOME': '/home/cltbld', 23:22:19 INFO - 'LANG': 'en_US.UTF-8', 23:22:19 INFO - 'LANGUAGE': 'en_US:en', 23:22:19 INFO - 'LOGNAME': 'cltbld', 23:22:19 INFO - 'MAIL': '/var/mail/cltbld', 23:22:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:22:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:19 INFO - 'MOZ_NO_REMOTE': '1', 23:22:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:19 INFO - 'NO_EM_RESTART': '1', 23:22:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:19 INFO - 'PWD': '/builds/slave/test', 23:22:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:22:19 INFO - 'SHELL': '/bin/bash', 23:22:19 INFO - 'SHLVL': '1', 23:22:19 INFO - 'TERM': 'linux', 23:22:19 INFO - 'TMOUT': '86400', 23:22:19 INFO - 'USER': 'cltbld', 23:22:19 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843', 23:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:19 INFO - '_': '/tools/buildbot/bin/python'} 23:22:19 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/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 23:22:19 INFO - mozversion application_buildid: 20160819203012 23:22:19 INFO - mozversion application_changeset: 1720386f83dc19ec161f70ae46d370edbf1e5e5c 23:22:19 INFO - mozversion application_display_name: Nightly 23:22:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:22:19 INFO - mozversion application_name: Firefox 23:22:19 INFO - mozversion application_remotingname: firefox 23:22:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:22:19 INFO - mozversion application_vendor: Mozilla 23:22:19 INFO - mozversion application_version: 51.0a1 23:22:19 INFO - mozversion platform_buildid: 20160819203012 23:22:19 INFO - mozversion platform_changeset: 1720386f83dc19ec161f70ae46d370edbf1e5e5c 23:22:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:22:19 INFO - mozversion platform_version: 51.0a1 23:22:19 INFO - using testdate: 1471674139 23:22:19 INFO - actual date: 1471674139 23:22:19 INFO - starting webserver on 'localhost:33254' 23:22:19 INFO - SUITE-START | Running 2 tests 23:22:19 INFO - TEST-START | dromaeo_css 23:22:19 INFO - operating with platform_type : linux_ 23:22:19 INFO - Initialising browser for dromaeo_css test... 23:22:19 INFO - TEST-INFO | started process 22514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8VSuEo/profile http://localhost:33254/getInfo.html) 23:22:24 INFO - PROCESS | 22514 | __metrics Screen width/height:1600/1200 23:22:24 INFO - PROCESS | 22514 | colorDepth:24 23:22:24 INFO - PROCESS | 22514 | Browser inner width/height: 1024/697 23:22:24 INFO - PROCESS | 22514 | __metrics 23:22:25 INFO - PROCESS | 22514 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:22:25 INFO - PROCESS | 22514 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:26 INFO - TEST-INFO | 22514: exit 0 23:22:26 INFO - Browser initialized. 23:22:26 INFO - Running cycle 1/1 for dromaeo_css test... 23:22:26 INFO - TEST-INFO | started process 22592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8VSuEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:38 INFO - PROCESS | 22592 | RSS: Main: 173563904 23:22:38 INFO - PROCESS | 22592 | 23:23:29 INFO - PROCESS | 22592 | 1471674209810 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:25:39 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:33254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33254/tests/dromaeo/cssquery-ext.html) 23:25:40 INFO - PROCESS | 22592 | RSS: Main: 271024128 23:25:40 INFO - PROCESS | 22592 | 23:28:42 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:33254/tests/dromaeo/cssquery-ext.html (next: http://localhost:33254/tests/dromaeo/cssquery-jquery.html) 23:28:43 INFO - PROCESS | 22592 | RSS: Main: 275976192 23:28:43 INFO - PROCESS | 22592 | 23:31:45 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:33254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33254/tests/dromaeo/cssquery-mootools.html) 23:31:45 INFO - PROCESS | 22592 | RSS: Main: 247312384 23:31:45 INFO - PROCESS | 22592 | 23:34:47 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:33254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33254/tests/dromaeo/cssquery-prototype.html) 23:34:48 INFO - PROCESS | 22592 | RSS: Main: 214732800 23:34:48 INFO - PROCESS | 22592 | 23:37:51 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:33254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33254/tests/dromaeo/cssquery-yui.html) 23:37:52 INFO - PROCESS | 22592 | RSS: Main: 213942272 23:37:52 INFO - PROCESS | 22592 | 23:40:54 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:33254/tests/dromaeo/cssquery-yui.html (next: http://localhost:33254/tests/dromaeo/cssquery-dojo.html) 23:40:55 INFO - PROCESS | 22592 | RSS: Main: 308822016 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | __start_tp_report 23:40:55 INFO - PROCESS | 22592 | _x_x_mozilla_page_load 23:40:55 INFO - PROCESS | 22592 | _x_x_mozilla_page_load_details 23:40:55 INFO - PROCESS | 22592 | |i|pagename|runs| 23:40:55 INFO - PROCESS | 22592 | |0;dojo.html;3034.0442760530436;3046.52778819283;3081.2142903559616;3081.8150910945346;3098.6281646202447;5192.974035129829;5232.189010703338;5280.831501099338;5349.866253343668;5404.351477822662;5279.577633789298;5292.788288468466;5318.441563635821;5338.332708411449;5407.891842163154;4776.450708168553;4836.854894353175;4851.442084160314;4905.730184839832;4986.152354099793;4932.358793356859;4946.703197808143;4964.056829202458;4965.627577931651;4971.204607262839;4774.092922344778;4826.179549476562;4828.927566086511;4903.68126071806;4925.507449255064;4778.952210477885;4803.471618122004;4816.759162041884;4835.927461088087;4872.074305881871;4721.433427988663;4749.715017098985;4782.856514304576;4790.904181916377;4800.0879832832;5298.072837253504;5311.73441327936;5319.6808191508635;5328.706921119337;5329.786808527654;5558.277423934903;5646.378898321223;5668.801591944303;5714.085746280575;5730.140478928152;5757.827265182052;5801.245838041028;5813.331466881321;5823.79616713413;5830.212921255618;5389.083855744494;5403.918941215885;5406.594505412031;5407.810726624549;5407.918881216785;5631.746571404296;5648.350439699405;5689;5691.231683722727;5799.971000144972;5567.832965010975;5569.944300557024;5572.888542229132;5574.358948720868;5576.247206627054;5639.238702775155;5649.322081350182;5658.773649054074;5663.405342439067;5667.489925906688;5490.945090549123;5569.220309156722;5602.803901863496;5608.270924779753;5652.547796176296;5645.463680950304;5658.660480371191;5661.830145095653;5661.915071273934;5663.093904975184;4392.802323895432;4429.269170586882;4431.8448854289945;4437.112577484516;4440.200763862471;3801.7718936863876;3894.4547763313158;3907.6873850091924;3939.9606003940166;3946.427767973628;5511.448855114457;5512.531434828004;5515.090010148361;5516.531094856902;5518.034343989786;5743.770249189985;5767.826965191051;5771.249737534094;5779.075347944308;5782.306123265235;5316.308879845596;5367.946320536823;5403.945960540423;5406.91889621656;5528.502434780889;4920.335754673145;4921.163402221631;4931.679440836334;4932.21084626458;4932.4081110267;5930.614510056833;5958.463738263577;5963.403659634088;5966;5968.940310596925;5521.171824226398;5537.944620553904;5577.024020796425;5588.6646801192055;5694.974904517227;5860;5870.148828419769;5902.704864756831;5910.852228694317;5913.172155898092;5532.695701736443;5537.723113844372;5540.445955404589;5558.861028474321;5563.666180029211;5401.837944861661;5647.350554686263;5664.150377443417;5694.117411801012;5700.743466543932;5638.9436105638415;5645.068563686946;5646;5646.915296270641;5648.265725455664;5633.155026745857;5642.153676948491;5643.548516118783;5648.068068768607;5651.237082993744;5367.892642147213;5411.458854114557;5434.5652347812875;5462;5585.720713964367;5602.52378547828;5628.605997580294;5633.8591535211945;5639.7180140993605;5647.237622921018;5477.726113694379;5502.064649009758;5502.119660854244;5514.448555144453;5521.061419558765 23:40:55 INFO - PROCESS | 22592 | |1;ext.html;573.3406582430206;595.1132812109958;609.7134346856978;615.5844804756788;618.2056057965515;42769.78615106924;43769;43810.342844857354;43984.560154398445;47470.762646186806;45042.54957450424;45849.541504584944;45882;45940;46279.768601156946;8783.209511143996;9012.963509196461;9014.774630634221;9019.278457723367;9023.864642030341;9087.454752714826;9191.264698824112;9197.770055748626;9212.401193922407;9214.44713317203;9249.722508324761;9302.581383837709;9310.255179585616;9315.115064068903;9327.953360233189;9250.67622633208;9297.023812499658;9303.58133883977;9305.232005918853;9307;9072.682456114004;9160.725178244596;9165.31260155491;9170.266378689756;9172.724818255463;43308.133837323396;43647.34528982068;43776.56223437757;43844.78077609623;43907.560924390986;3331.3670402623425;3410.6698387628844;3638.690711289517;3920.0199950012498;4105.568915263884;32404.837975810206;32773.34453310944;33027;33084.503732444035;33930;4308.978455107705;4449.644028477714;4494.977525112354;4565.155446242456;4681.929771053403;349724;352857.649982252;355819;357283;360150;58969;59232.70383648054;59264.11103833446;59337.703311483165;59451;61666.69166654138;61772;61829.690851545456;61975.07037394443;62169.689151554856;16625.334986600643;16874;16888.493345199662;16940.23768930401;16965.031119554274;12052.819207711891;12071.818922715991;12074;12079.335636540074;12105.152639315163;14901.627459313388;16579.17104144788;16634;16666.4166754163;16673.6665266694;5663.292088488939;6530.967345163243;6542.476601871839;6542.771003014872;6799.660016999131;895.2390468102192;1019.7304356076584;1029.9897001030045;1138.2260063157132;1156.8958793708607;32631.51052734211;33208.1697957553;33483.49774753381;33498.8325058378;33781.49327760086;1084.7505073833063;1120.5461787975883;1144.0790163918125;1190.0717440396504;1208.64949164743;16832.24254908532;17358.739618905474;17367.218475168396;17398.478045658652;17451.214695338742;502513;502892;503535;508438;510821;60165;60367.39632603618;60416;60418.697906511065;60476.697616511636;1210.3827048205303;1288.2206265209413;1324.2915040453504;1335.4190926946615;1344.4487760018542;31970.52044219385;33880.66119338775;34279.48580771241;34400.655993439745;34543;51042.23436648379;51603.74198128985;51786.741066294424;51827.48172518227;51872.481275186765;309640;309920;310684;312592;314102;27950.44099118047;28980.565291520223;29017.709822902347;29910.551341730326;30223.395532089675;48372.5162748368;49047.50952490429;49374.25938610852;49484.257736133266;50961.74519127529;41524.79237603793;41619;42199.7890010548;43581.34627980519;43755.90515754595;41901.79049104735;41928.3710744333;42482.78758606187;43096.78451607847;43407;41635.7918210407;41738.37392439055;42540.57459425366;43159.13681726411;43319.56680433281;33604.663953360156;37565.62434375731;37607.43588846115;37818.81090594529;38452.038699032746;27901.86049069823;28259.858700706365;28491.145265642062;28515.144545663665;28574.142775716762 23:40:55 INFO - PROCESS | 22592 | |2;jquery.html;384.4790309131129;390.50991006287126;400.54338054617733;400.7194963525532;418.38079642129645;14340.74192039336;18730.53173670659;19548;19816;19938.90030549849;12674.873251267485;12899.355032248397;12924.289164095972;12996.675083122904;12997.870021299785;4001.779902105383;5283.181106928422;5426.131818908975;5429.294191755066;5441.347038355403;5755.107958266475;5857.033589457735;5949.137375080611;6076.665783381913;6083.965725826598;5969.13447550105;6076.301225359074;6078.149059131725;6543.411093001629;6596.0435736818135;6559.672016399185;6586.30843761403;6588.242352129519;6588.901166482507;6595.769148079794;5109.20807274873;5291.629585928987;5325.946740532622;5431.158170483582;5438.510534051915;14214.147151170962;14344.784828227585;18329.450116496526;23613.763862361327;23795;2299.9425014374606;2337.2520793346134;2494.3140636324974;2506.884436425791;2725.6184134221226;10159.796804063877;10796.622118225825;10864.782704345947;11957.940210298893;13447.125936814076;1859.7768267807814;1882.8117188281199;1895.9146838392305;1912.9808701913082;1917.731517587539;82060.58969705114;83167.58416207941;83500.58249708773;83637.58181209116;84695.57652211761;10727.463626818784;11049.779004419866;11419.885801142049;11832.349220792767;12284.324362159989;15078.396864125532;15101.32044057998;15115.622109447351;15116.697666046837;15152.469663561722;8001.199880011952;8031.59842007909;8106.47307924983;8331.083580806106;8331.50010999342;7646.350060244941;7885;7912.169222231698;7922.881156782653;8075.313598344206;4547.386102876069;4605.815767369335;4640.744759038218;4671.6262698984;4737.692050016738;1909.7421848050335;2002.3092033248506;2008.126464987735;2022.3427386099577;2036.5010572409853;885.7608445719619;965.4931161140317;980.926430517714;999.7900440907346;1040.7242080848582;20001.199952002047;20036.198552058046;20299.188032478534;20329.390118296476;20447.693284600744;993.8260804359209;1005.6027868991707;1014.1075853249241;1028.1055481730941;1045.8326667733127;10614.150867930546;10628.309159904582;11043.116550675926;11104.615445591633;11173.497192626352;420258;446974;456044;457343;466194;85709;85837.14162858417;85935;88826;89205.55397222973;983.5131609853169;998.2680050113048;1028.711960651019;1031.7523794289316;1037.455335948633;15542.378304867678;17148.742768858727;17238.482845514656;17478.213480393668;17528.633634459184;28728.569071463528;29526.704732952396;40957;41718.58281417147;42800.35799463073;57208.42791572031;57302.68551660741;57915;58292.708536457045;58644;8568.614412351335;8698.347623928357;8776.78058048554;8792.29661627081;9016.143466370684;12961.092723509264;13073.477060917457;13101.410436530188;13210.207387556777;13286.20282783036;11332.320060796379;11426.94286528562;11513.942430287794;11618.302901825917;11832;11452.94273528627;11608.129390295593;11609.071274297867;11843.348615826213;12010.399480026139;11275;11309.434528273388;11339.943300283447;11505.424728763695;11539.36533490666;8588.184122508601;8604.311655067455;8787.91212087871;8860.246879015356;9116.36185467011;8562.186592273723;11175.888241117485;11187.440627968732;11291.491882865455;11408.372539510407 23:40:55 INFO - PROCESS | 22592 | |3;mootools.html;1308.7775078236698;1486.5911874234585;1507.600485871244;1635.4194261037333;1717.321657945111;8645.870311945318;8926;9020.413673111252;9250.67622633208;9272.119148680882;9030.954845225764;9165.175134237918;9173.449593024407;9175.265978721704;9175.54122293886;2383.153980336977;2400.1719406804623;2402.4354276744953;2402.8918698658513;2415.2995631266913;2393.5571919194917;2419.4798118404537;2439.0731522021606;2448.26552034389;2467.3954881054165;2380.7619238076227;2392.1986134644917;2400.7479214682467;2430.4531480416854;2435.3789783605157;2315.8842057897205;2352.1297120065515;2360.8701521416315;2366.7278262999716;2368.3131891751286;2247.7864602862865;2273.6362182050957;2273.6475846243857;2276.7950884420484;2278.327893271489;8913.910860891372;9158.679446219418;9193.126652967958;9250.213731832802;9269;5246.711430871301;5426;5497.230387745719;5499.670019798785;5503.504684578407;3623.6376362363817;3647;3660.871869484555;3702.5371828521434;3707.2029513654425;1169.228309315856;1190.7499425120734;1192.5349113845607;1201.1291813435278;1231.667449788561;12326.753464930742;12509.74980500394;12511.499540018389;12532.561360352434;12554.686132846751;4739.2891066339635;4760.785764640599;4802.495737947465;4915.705057696549;4941.50584941503;10654.254202205771;10678.51946662402;10707.518161682743;10709.946450267855;10713.517891694737;5406.135018397038;5442.2380866678695;5463.207834864002;5473.31583552056;5473.507384335429;4453.955460445419;4840.249761287007;4993.475685053089;4998.375203099613;5034.773435195425;3981.5620281768984;4012.3179059559943;4153.709240353146;4169.60388763067;4209.284421648327;1342.89256859451;1359.0962010263065;1362.216725382889;1366.1188533395905;1385.591250581081;877.0045997792424;901.1439132823843;953.6423841059602;961.3991255465335;974.3949560731652;5663.858403539862;5779.8555036124435;5861.062230043172;6080.14877917092;6089.939100609025;454.9476810166807;460.2957475063159;461.8683675152565;462.6067842333989;466.7899445249651;4035.2534781065597;4109.3425051991535;4127.525334586501;4180.3102488089735;4200.432941552913;10713.410762407986;11131.443427828575;11149.163812713916;11166.720831979266;11185.440727963569;11031.2278140531;11057.557697692164;11065.889341106647;11112.16658750597;11122.277051991594;8171.680161337102;8260.793480162924;8308.750737477885;8318.70884519039;8344.499330040217;5784;5893.499052580579;5918.17145599625;5951;5999.580029398075;9845.409275443497;10053.748656283651;10068.84896726535;10122.949385253027;10148.391096534231;10354.637587684394;10499.950004999439;10581.62964296246;10640.521176547229;10658.520366583678;6895;6919.273476285119;7626.199249078767;7765.145833958373;7897.565633890191;8484.109168537214;8722.781930451789;8728.08355122703;8792.120787921156;8811.33914956368;7523.510971786816;7599.810004749926;7686.3082322591235;7731.149573546792;7808.84382312362;7327.780166595011;7448.366888814511;7641.7707468776025;7680.193579674054;7773;7153.177384600837;7245.855082898418;7259.274072592699;7267.164276108315;7271.381932535794;5075.771590278372;5096.898062038813;5098.694078355311;5141.7686204120155;5374.677519348852;5423.132298832168;5504.6421982571;5572.832815015556;5579.609427340048;5609.868250064949 23:40:55 INFO - PROCESS | 22592 | |4;prototype.html;326.619488296135;327.65432468745473;335.60901549694614;335.82704906972896;336.5170979644212;5142.614303927211;5143.948560514394;5144.356955380577;5148.330717006788;5156.484351564842;5010.749462526877;5054.317667114939;5106.285120083191;5108.948910510894;5113.6931784092885;3819.4531214858025;3871.128995975911;4010.3783913493453;4025.295573274665;4034.5360283567325;4014.3175660137845;4019.77891215983;4040.2121586290687;4058.959410405888;4068.9593104068877;3994.4208089826957;4006.83972641094;4009.8797036088818;4021.9597804022023;4034.616711412411;3808.447775072613;3912.784796836187;3961.9405708914387;3993.381025940984;4020.778857162855;3532.763532763538;3543.7596841105665;3545.592256890439;3559.715222782171;3583.552055993001;4863.465018847924;4891.461939186686;4903.901921961577;4939.506049395068;4947.257911313296;4486.349479325512;4551.40831691878;4575.428071491064;4588.334691469751;4593.40285762852;5175.560077393388;5214.32213812202;5229.241759944786;5230.633855630107;5242.79028838846;3902.278078555448;3902.551206611219;3934.822932967995;3936.8228429720443;3940.468036815022;5270.762815673265;5413.566914646819;5418.2685337479725;5448.318960129984;5496.862578435531;3995.580464051233;3998.460207871958;4010.7994600270454;4017.738846974937;4031.3796032579057;4062.821781683279;4087;4093.6520395766097;4102.917941641151;4105.0763578195265;4371.715838470489;4594.839180628662;4601;4606.378138951266;4626.653001024936;5215.061288967946;5268.894622107613;5274.868128296746;5307.469253074739;5328.786848526015;1385.2035079828936;1389.0415613226842;1392.6769568909576;1392.9721405571831;1397.2454874367727;876.3164731509432;921.7004473545991;925.3383830561181;929.0848514213494;937.9062093790703;4938.604911607063;5069.681882710448;5160.277561141444;5245.3705555332845;5250.2173847860695;5452.863678408072;5460.208269800856;5461.371942226695;5468.144957804738;5476.972615136899;4981.701097934136;5194.272801807674;5218.869528261824;5238.109521381374;5239.711815850089;2796.4826507096254;2887.191586355824;2887.5850833091636;2889.8555072246722;2892.8119672221237;5716.857078573069;5725.914111288334;5730.046268075098;5783.421657834267;5791.739371728198;5475.479829416199;5481.2874326338115;5530.198121272393;5550.972245138749;5663.66018038919;5658.547316214693;5659.518940890071;5660.518855897212;5661.575381846378;5676.68778217202;5352;5401.756920938488;5440.265564148789;5465.562754979672;5465.863353416037;5174.7153906535505;5361.79359644077;5412.56699464034;5416.160495123262;5418.106012507892;5652.3217213934595;5652.463016013472;5684.63049901755;5685.232493613309;5785.566082543742;3777.773333599993;3935.1932853765484;3984.3425834736945;3986.22268657609;4011.7994100294286;5389.75746091419;5392.35291764975;5408.8377348679605;5417.887024060541;5429.918551221814;5290.65610735301;5300.178472336794;5318.787248510016;5380.219868119023;5383.596230282823;5192.221166825007;5277.525022747971;5306.681599104066;5340.3031469107855;5340.546053585489;5149.5323832709;5215.243789650555;5222.242774797709;5224.876651519941;5248.868778280574;5096.694198348111;5218.895622087461;5263.026340127089;5289.57683385336;5290.25936368901;5171.276021357088;5191.974040129775;5196.584273258206;5198.584113271005;5223.686578805284 23:40:55 INFO - PROCESS | 22592 | |5;yui.html;685.3968507713212;791.5646394483035;792.4848848248638;846.5217152308941;849.5285116760195;15174.317155727991;16437.83562164378;16507.504774856774;16531.42140025098;16540.090295033784;14090.57728268151;14374.281285935715;14383.64040898978;14481.710365792704;14643.707125857476;807.1283014344523;825.352098602597;827.2017503109498;827.7475370012144;828.1056459024239;666.473485946102;775.4533054196778;797.6570074867805;802.3220378779922;802.7631848604676;868.5787393114334;868.682930730282;869.074435725953;869.8999615044256;870.0559892516595;859.8968123825118;860.0711231869566;860.2644738748373;860.9526476043815;861.6467248428114;516.2153526639487;607.2257871214193;625.3152797686525;625.8216408323606;626.0546574672233;13788.655283617989;13858.099223550436;13893;13965.790513142209;13981.231032293219;13553.25457099869;14155.079919805283;14307.213103279315;14497.710045799025;14726.410943562245;13368.131071480322;13435;13497.797533037012;13564.796528052088;13692.246926419042;4420.160169567772;4441.666874984357;4491.797869095899;4521.480029796583;4547.567981041796;81893.59053204756;82716;84099.57950210272;85510.99999999937;88015;11153.776924461465;11202.21584489078;11291.153163512769;11335.319880807177;11437.885621143849;22223.333300001024;22239.110435582395;22418.215362462237;22489.662655060187;22495.88752056262;8731.211646915528;8820.11798820113;8854.557272136368;8856.247218986458;8979.955100224457;4716.245400735866;4872.78072486739;4925.87685307863;5007.499250075036;5046.142155833517;3445.207602251496;3549.9290014199573;3557.8221088945447;3558.733095017884;3560.394732895414;589.360543809971;595.2767387623971;599.9940000600026;635.3487675133026;640.0335493404992;666.9133012708317;684.7740245718901;745.1616930952679;752.6124046116255;776.9145394006655;10208.928062553325;10247.29513148634;10677.57289708403;10696.732581685521;10767.730806729895;635.3138610300864;670.3732010570133;722.8807246804218;737.1301863800767;770.3298130626391;4852.199387101089;5055.266986286968;5085.389753229636;5100.081985242692;5102.69383836971;99012.50493747485;124722;128568;131641.34179329043;133230;67332.663336683;68780.3121968784;77963.61018194872;84763.57618211993;112803;82803.58598207092;84563;87279;89074;91618;9711.3202075854;9994.800103998024;10065.7456310488;10251.411031290161;10252.692419227435;47392;48428.515714842404;49521;51470;51730;65804.6709766448;71579.64210179124;74414.62792686002;74797;77773.61113194398;13160.210387376788;13231.66920826987;13568.660783480098;14056.859431405965;14193.787093193818;15172.393104276147;15393.30730117125;15511.84488155104;15853.920730396274;15906.60233494172;14514.274286285854;14689.485867994568;14790.186539740418;14846.257687115816;14918.85081149218;13866.376013079234;15118.168500732125;15209.315580799112;15274.642588412216;15735.842641573438;14288.857111429168;14999.475018374305;15055.924720376766;15644.139572323631;15665.216739163225;10542.525586348786;11298.209125361145;11646.301221926711;11691.415429228335;11827.172097953406;10103.592022166255;10215.438150901771;10921.453927303763;11819.527218911147;11839.526418943145 23:40:55 INFO - PROCESS | 22592 | __end_tp_report 23:40:55 INFO - PROCESS | 22592 | __start_cc_report 23:40:55 INFO - PROCESS | 22592 | _x_x_mozilla_cycle_collect,943 23:40:55 INFO - PROCESS | 22592 | __end_cc_report 23:40:55 INFO - PROCESS | 22592 | __startTimestamp1471675255044__endTimestamp 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | ------- Summary: start ------- 23:40:55 INFO - PROCESS | 22592 | Number of tests: 6 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | [#0] dojo.html Cycles:165 Average:5294.72 Median:5516.53 stddev:594.66 (10.8%) stddev-sans-first:569.43 23:40:55 INFO - PROCESS | 22592 | Values: 3034.0 3046.5 3081.2 3081.8 3098.6 5193.0 5232.2 5280.8 5349.9 5404.4 5279.6 5292.8 5318.4 5338.3 5407.9 4776.5 4836.9 4851.4 4905.7 4986.2 4932.4 4946.7 4964.1 4965.6 4971.2 4774.1 4826.2 4828.9 4903.7 4925.5 4779.0 4803.5 4816.8 4835.9 4872.1 4721.4 4749.7 4782.9 4790.9 4800.1 5298.1 5311.7 5319.7 5328.7 5329.8 5558.3 5646.4 5668.8 5714.1 5730.1 5757.8 5801.2 5813.3 5823.8 5830.2 5389.1 5403.9 5406.6 5407.8 5407.9 5631.7 5648.4 5689.0 5691.2 5800.0 5567.8 5569.9 5572.9 5574.4 5576.2 5639.2 5649.3 5658.8 5663.4 5667.5 5490.9 5569.2 5602.8 5608.3 5652.5 5645.5 5658.7 5661.8 5661.9 5663.1 4392.8 4429.3 4431.8 4437.1 4440.2 3801.8 3894.5 3907.7 3940.0 3946.4 5511.4 5512.5 5515.1 5516.5 5518.0 5743.8 5767.8 5771.2 5779.1 5782.3 5316.3 5367.9 5403.9 5406.9 5528.5 4920.3 4921.2 4931.7 4932.2 4932.4 5930.6 5958.5 5963.4 5966.0 5968.9 5521.2 5537.9 5577.0 5588.7 5695.0 5860.0 5870.1 5902.7 5910.9 5913.2 5532.7 5537.7 5540.4 5558.9 5563.7 5401.8 5647.4 5664.2 5694.1 5700.7 5638.9 5645.1 5646.0 5646.9 5648.3 5633.2 5642.2 5643.5 5648.1 5651.2 5367.9 5411.5 5434.6 5462.0 5585.7 5602.5 5628.6 5633.9 5639.7 5647.2 5477.7 5502.1 5502.1 5514.4 5521.1 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | [#1] ext.html Cycles:180 Average:56612.76 Median:43127.96 stddev:105544.36 (244.7%) stddev-sans-first:105756.58 23:40:55 INFO - PROCESS | 22592 | Values: 573.3 595.1 609.7 615.6 618.2 42769.8 43769.0 43810.3 43984.6 47470.8 45042.5 45849.5 45882.0 45940.0 46279.8 8783.2 9013.0 9014.8 9019.3 9023.9 9087.5 9191.3 9197.8 9212.4 9214.4 9249.7 9302.6 9310.3 9315.1 9328.0 9250.7 9297.0 9303.6 9305.2 9307.0 9072.7 9160.7 9165.3 9170.3 9172.7 43308.1 43647.3 43776.6 43844.8 43907.6 3331.4 3410.7 3638.7 3920.0 4105.6 32404.8 32773.3 33027.0 33084.5 33930.0 4309.0 4449.6 4495.0 4565.2 4681.9 349724.0 352857.6 355819.0 357283.0 360150.0 58969.0 59232.7 59264.1 59337.7 59451.0 61666.7 61772.0 61829.7 61975.1 62169.7 16625.3 16874.0 16888.5 16940.2 16965.0 12052.8 12071.8 12074.0 12079.3 12105.2 14901.6 16579.2 16634.0 16666.4 16673.7 5663.3 6531.0 6542.5 6542.8 6799.7 895.2 1019.7 1030.0 1138.2 1156.9 32631.5 33208.2 33483.5 33498.8 33781.5 1084.8 1120.5 1144.1 1190.1 1208.6 16832.2 17358.7 17367.2 17398.5 17451.2 502513.0 502892.0 503535.0 508438.0 510821.0 60165.0 60367.4 60416.0 60418.7 60476.7 1210.4 1288.2 1324.3 1335.4 1344.4 31970.5 33880.7 34279.5 34400.7 34543.0 51042.2 51603.7 51786.7 51827.5 51872.5 309640.0 309920.0 310684.0 312592.0 314102.0 27950.4 28980.6 29017.7 29910.6 30223.4 48372.5 49047.5 49374.3 49484.3 50961.7 41524.8 41619.0 42199.8 43581.3 43755.9 41901.8 41928.4 42482.8 43096.8 43407.0 41635.8 41738.4 42540.6 43159.1 43319.6 33604.7 37565.6 37607.4 37818.8 38452.0 27901.9 28259.9 28491.1 28515.1 28574.1 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | [#2] jquery.html Cycles:180 Average:27405.69 Median:2616.25 stddev:74331.64 (2841.2%) stddev-sans-first:74512.47 23:40:55 INFO - PROCESS | 22592 | Values: 384.5 390.5 400.5 400.7 418.4 14340.7 18730.5 19548.0 19816.0 19938.9 12674.9 12899.4 12924.3 12996.7 12997.9 4001.8 5283.2 5426.1 5429.3 5441.3 5755.1 5857.0 5949.1 6076.7 6084.0 5969.1 6076.3 6078.1 6543.4 6596.0 6559.7 6586.3 6588.2 6588.9 6595.8 5109.2 5291.6 5325.9 5431.2 5438.5 14214.1 14344.8 18329.5 23613.8 23795.0 2299.9 2337.3 2494.3 2506.9 2725.6 10159.8 10796.6 10864.8 11957.9 13447.1 1859.8 1882.8 1895.9 1913.0 1917.7 82060.6 83167.6 83500.6 83637.6 84695.6 10727.5 11049.8 11419.9 11832.3 12284.3 15078.4 15101.3 15115.6 15116.7 15152.5 8001.2 8031.6 8106.5 8331.1 8331.5 7646.4 7885.0 7912.2 7922.9 8075.3 4547.4 4605.8 4640.7 4671.6 4737.7 1909.7 2002.3 2008.1 2022.3 2036.5 885.8 965.5 980.9 999.8 1040.7 20001.2 20036.2 20299.2 20329.4 20447.7 993.8 1005.6 1014.1 1028.1 1045.8 10614.2 10628.3 11043.1 11104.6 11173.5 420258.0 446974.0 456044.0 457343.0 466194.0 85709.0 85837.1 85935.0 88826.0 89205.6 983.5 998.3 1028.7 1031.8 1037.5 15542.4 17148.7 17238.5 17478.2 17528.6 28728.6 29526.7 40957.0 41718.6 42800.4 57208.4 57302.7 57915.0 58292.7 58644.0 8568.6 8698.3 8776.8 8792.3 9016.1 12961.1 13073.5 13101.4 13210.2 13286.2 11332.3 11426.9 11513.9 11618.3 11832.0 11452.9 11608.1 11609.1 11843.3 12010.4 11275.0 11309.4 11339.9 11505.4 11539.4 8588.2 8604.3 8787.9 8860.2 9116.4 8562.2 11175.9 11187.4 11291.5 11408.4 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | [#3] mootools.html Cycles:180 Average:5902.12 Median:4750.04 stddev:3370.04 (70.9%) stddev-sans-first:3361.82 23:40:55 INFO - PROCESS | 22592 | Values: 1308.8 1486.6 1507.6 1635.4 1717.3 8645.9 8926.0 9020.4 9250.7 9272.1 9031.0 9165.2 9173.4 9175.3 9175.5 2383.2 2400.2 2402.4 2402.9 2415.3 2393.6 2419.5 2439.1 2448.3 2467.4 2380.8 2392.2 2400.7 2430.5 2435.4 2315.9 2352.1 2360.9 2366.7 2368.3 2247.8 2273.6 2273.6 2276.8 2278.3 8913.9 9158.7 9193.1 9250.2 9269.0 5246.7 5426.0 5497.2 5499.7 5503.5 3623.6 3647.0 3660.9 3702.5 3707.2 1169.2 1190.7 1192.5 1201.1 1231.7 12326.8 12509.7 12511.5 12532.6 12554.7 4739.3 4760.8 4802.5 4915.7 4941.5 10654.3 10678.5 10707.5 10709.9 10713.5 5406.1 5442.2 5463.2 5473.3 5473.5 4454.0 4840.2 4993.5 4998.4 5034.8 3981.6 4012.3 4153.7 4169.6 4209.3 1342.9 1359.1 1362.2 1366.1 1385.6 877.0 901.1 953.6 961.4 974.4 5663.9 5779.9 5861.1 6080.1 6089.9 454.9 460.3 461.9 462.6 466.8 4035.3 4109.3 4127.5 4180.3 4200.4 10713.4 11131.4 11149.2 11166.7 11185.4 11031.2 11057.6 11065.9 11112.2 11122.3 8171.7 8260.8 8308.8 8318.7 8344.5 5784.0 5893.5 5918.2 5951.0 5999.6 9845.4 10053.7 10068.8 10122.9 10148.4 10354.6 10500.0 10581.6 10640.5 10658.5 6895.0 6919.3 7626.2 7765.1 7897.6 8484.1 8722.8 8728.1 8792.1 8811.3 7523.5 7599.8 7686.3 7731.1 7808.8 7327.8 7448.4 7641.8 7680.2 7773.0 7153.2 7245.9 7259.3 7267.2 7271.4 5075.8 5096.9 5098.7 5141.8 5374.7 5423.1 5504.6 5572.8 5579.6 5609.9 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | [#4] prototype.html Cycles:180 Average:4500.24 Median:5165.78 stddev:1305.06 (25.3%) stddev-sans-first:1270.57 23:40:55 INFO - PROCESS | 22592 | Values: 326.6 327.7 335.6 335.8 336.5 5142.6 5143.9 5144.4 5148.3 5156.5 5010.7 5054.3 5106.3 5108.9 5113.7 3819.5 3871.1 4010.4 4025.3 4034.5 4014.3 4019.8 4040.2 4059.0 4069.0 3994.4 4006.8 4009.9 4022.0 4034.6 3808.4 3912.8 3961.9 3993.4 4020.8 3532.8 3543.8 3545.6 3559.7 3583.6 4863.5 4891.5 4903.9 4939.5 4947.3 4486.3 4551.4 4575.4 4588.3 4593.4 5175.6 5214.3 5229.2 5230.6 5242.8 3902.3 3902.6 3934.8 3936.8 3940.5 5270.8 5413.6 5418.3 5448.3 5496.9 3995.6 3998.5 4010.8 4017.7 4031.4 4062.8 4087.0 4093.7 4102.9 4105.1 4371.7 4594.8 4601.0 4606.4 4626.7 5215.1 5268.9 5274.9 5307.5 5328.8 1385.2 1389.0 1392.7 1393.0 1397.2 876.3 921.7 925.3 929.1 937.9 4938.6 5069.7 5160.3 5245.4 5250.2 5452.9 5460.2 5461.4 5468.1 5477.0 4981.7 5194.3 5218.9 5238.1 5239.7 2796.5 2887.2 2887.6 2889.9 2892.8 5716.9 5725.9 5730.0 5783.4 5791.7 5475.5 5481.3 5530.2 5551.0 5663.7 5658.5 5659.5 5660.5 5661.6 5676.7 5352.0 5401.8 5440.3 5465.6 5465.9 5174.7 5361.8 5412.6 5416.2 5418.1 5652.3 5652.5 5684.6 5685.2 5785.6 3777.8 3935.2 3984.3 3986.2 4011.8 5389.8 5392.4 5408.8 5417.9 5429.9 5290.7 5300.2 5318.8 5380.2 5383.6 5192.2 5277.5 5306.7 5340.3 5340.5 5149.5 5215.2 5222.2 5224.9 5248.9 5096.7 5218.9 5263.0 5289.6 5290.3 5171.3 5192.0 5196.6 5198.6 5223.7 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - PROCESS | 22592 | [#5] yui.html Cycles:180 Average:21013.23 Median:4506.64 stddev:30122.84 (668.4%) stddev-sans-first:30168.67 23:40:55 INFO - PROCESS | 22592 | Values: 685.4 791.6 792.5 846.5 849.5 15174.3 16437.8 16507.5 16531.4 16540.1 14090.6 14374.3 14383.6 14481.7 14643.7 807.1 825.4 827.2 827.7 828.1 666.5 775.5 797.7 802.3 802.8 868.6 868.7 869.1 869.9 870.1 859.9 860.1 860.3 861.0 861.6 516.2 607.2 625.3 625.8 626.1 13788.7 13858.1 13893.0 13965.8 13981.2 13553.3 14155.1 14307.2 14497.7 14726.4 13368.1 13435.0 13497.8 13564.8 13692.2 4420.2 4441.7 4491.8 4521.5 4547.6 81893.6 82716.0 84099.6 85511.0 88015.0 11153.8 11202.2 11291.2 11335.3 11437.9 22223.3 22239.1 22418.2 22489.7 22495.9 8731.2 8820.1 8854.6 8856.2 8980.0 4716.2 4872.8 4925.9 5007.5 5046.1 3445.2 3549.9 3557.8 3558.7 3560.4 589.4 595.3 600.0 635.3 640.0 666.9 684.8 745.2 752.6 776.9 10208.9 10247.3 10677.6 10696.7 10767.7 635.3 670.4 722.9 737.1 770.3 4852.2 5055.3 5085.4 5100.1 5102.7 99012.5 124722.0 128568.0 131641.3 133230.0 67332.7 68780.3 77963.6 84763.6 112803.0 82803.6 84563.0 87279.0 89074.0 91618.0 9711.3 9994.8 10065.7 10251.4 10252.7 47392.0 48428.5 49521.0 51470.0 51730.0 65804.7 71579.6 74414.6 74797.0 77773.6 13160.2 13231.7 13568.7 14056.9 14193.8 15172.4 15393.3 15511.8 15853.9 15906.6 14514.3 14689.5 14790.2 14846.3 14918.9 13866.4 15118.2 15209.3 15274.6 15735.8 14288.9 14999.5 15055.9 15644.1 15665.2 10542.5 11298.2 11646.3 11691.4 11827.2 10103.6 10215.4 10921.5 11819.5 11839.5 23:40:55 INFO - PROCESS | 22592 | -------- Summary: end -------- 23:40:55 INFO - PROCESS | 22592 | 23:40:55 INFO - TEST-INFO | 22592: exit 0 23:40:55 INFO - TEST-OK | dromaeo_css | took 1116001ms 23:40:55 INFO - TEST-START | kraken 23:40:55 INFO - operating with platform_type : linux_ 23:40:55 INFO - Initialising browser for kraken test... 23:40:55 INFO - TEST-INFO | started process 22896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZrMmWq/profile http://localhost:33254/getInfo.html) 23:41:00 INFO - PROCESS | 22896 | __metrics Screen width/height:1600/1200 23:41:00 INFO - PROCESS | 22896 | colorDepth:24 23:41:00 INFO - PROCESS | 22896 | Browser inner width/height: 1024/697 23:41:00 INFO - PROCESS | 22896 | __metrics 23:41:01 INFO - PROCESS | 22896 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:41:01 INFO - PROCESS | 22896 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:41:01 INFO - PROCESS | 22896 | console.error: PushService: 23:41:01 INFO - PROCESS | 22896 | stateChangeProcessEnqueue: Error transitioning state 23:41:01 INFO - PROCESS | 22896 | UnknownError 23:41:02 INFO - TEST-INFO | 22896: exit 0 23:41:02 INFO - Browser initialized. 23:41:02 INFO - Running cycle 1/1 for kraken test... 23:41:02 INFO - TEST-INFO | started process 22977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZrMmWq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:41:14 INFO - PROCESS | 22977 | RSS: Main: 174030848 23:41:14 INFO - PROCESS | 22977 | 23:41:16 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33254/tests/kraken/driver.html?testName=audio-beat-detection) 23:41:17 INFO - PROCESS | 22977 | RSS: Main: 235282432 23:41:17 INFO - PROCESS | 22977 | 23:41:20 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33254/tests/kraken/driver.html?testName=audio-dft) 23:41:21 INFO - PROCESS | 22977 | RSS: Main: 225923072 23:41:21 INFO - PROCESS | 22977 | 23:41:24 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33254/tests/kraken/driver.html?testName=audio-fft) 23:41:25 INFO - PROCESS | 22977 | RSS: Main: 302305280 23:41:25 INFO - PROCESS | 22977 | 23:41:27 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33254/tests/kraken/driver.html?testName=audio-oscillator) 23:41:27 INFO - PROCESS | 22977 | RSS: Main: 209969152 23:41:27 INFO - PROCESS | 22977 | 23:41:30 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:41:30 INFO - PROCESS | 22977 | RSS: Main: 212611072 23:41:30 INFO - PROCESS | 22977 | 23:41:33 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33254/tests/kraken/driver.html?testName=imaging-darkroom) 23:41:34 INFO - PROCESS | 22977 | RSS: Main: 250351616 23:41:34 INFO - PROCESS | 22977 | 23:41:37 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33254/tests/kraken/driver.html?testName=imaging-desaturate) 23:41:38 INFO - PROCESS | 22977 | RSS: Main: 249188352 23:41:38 INFO - PROCESS | 22977 | 23:41:41 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33254/tests/kraken/driver.html?testName=json-parse-financial) 23:41:41 INFO - PROCESS | 22977 | RSS: Main: 249237504 23:41:41 INFO - PROCESS | 22977 | 23:41:43 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:41:43 INFO - PROCESS | 22977 | RSS: Main: 211800064 23:41:43 INFO - PROCESS | 22977 | 23:41:45 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:41:46 INFO - PROCESS | 22977 | RSS: Main: 219598848 23:41:46 INFO - PROCESS | 22977 | 23:41:48 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:41:49 INFO - PROCESS | 22977 | RSS: Main: 223744000 23:41:49 INFO - PROCESS | 22977 | 23:41:51 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:41:52 INFO - PROCESS | 22977 | RSS: Main: 219209728 23:41:52 INFO - PROCESS | 22977 | 23:41:55 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:41:55 INFO - PROCESS | 22977 | RSS: Main: 221487104 23:41:55 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | Cycle 1(1): loaded http://localhost:33254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33254/tests/kraken/driver.html?testName=ai-astar) 23:41:57 INFO - PROCESS | 22977 | RSS: Main: 273448960 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | __start_tp_report 23:41:57 INFO - PROCESS | 22977 | _x_x_mozilla_page_load 23:41:57 INFO - PROCESS | 22977 | _x_x_mozilla_page_load_details 23:41:57 INFO - PROCESS | 22977 | |i|pagename|runs| 23:41:57 INFO - PROCESS | 22977 | |0;ai-astar;98;117;106;109;109;110;116;110;110;110 23:41:57 INFO - PROCESS | 22977 | |1;audio-beat-detection;146;118;149;195;121;147;148;120;195;118 23:41:57 INFO - PROCESS | 22977 | |2;audio-dft;161;161;161;160;161;163;163;160;163;161 23:41:57 INFO - PROCESS | 22977 | |3;audio-fft;76;75;75;177;75;75;76;74;167;76 23:41:57 INFO - PROCESS | 22977 | |4;audio-oscillator;87;85;157;86;86;86;153;84;85;137 23:41:57 INFO - PROCESS | 22977 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;117 23:41:57 INFO - PROCESS | 22977 | |6;imaging-darkroom;148;147;153;147;147;147;147;147;147;147 23:41:57 INFO - PROCESS | 22977 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;95 23:41:57 INFO - PROCESS | 22977 | |8;json-parse-financial;50;50;50;50;50;52;52;50;52;50 23:41:57 INFO - PROCESS | 22977 | |9;json-stringify-tinderbox;62;64;63;63;63;63;63;63;62;63 23:41:57 INFO - PROCESS | 22977 | |10;stanford-crypto-aes;79;78;81;85;82;84;80;77;78;79 23:41:57 INFO - PROCESS | 22977 | |11;stanford-crypto-ccm;127;127;125;123;142;133;127;133;144;131 23:41:57 INFO - PROCESS | 22977 | |12;stanford-crypto-pbkdf2;163;165;162;161;164;162;162;172;163;162 23:41:57 INFO - PROCESS | 22977 | |13;stanford-crypto-sha256-iterative;66;64;65;69;67;65;66;64;63;65 23:41:57 INFO - PROCESS | 22977 | __end_tp_report 23:41:57 INFO - PROCESS | 22977 | __start_cc_report 23:41:57 INFO - PROCESS | 22977 | _x_x_mozilla_cycle_collect,1718 23:41:57 INFO - PROCESS | 22977 | __end_cc_report 23:41:57 INFO - PROCESS | 22977 | __startTimestamp1471675317803__endTimestamp 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | ------- Summary: start ------- 23:41:57 INFO - PROCESS | 22977 | Number of tests: 14 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:5.21 (4.7%) stddev-sans-first:3.49 23:41:57 INFO - PROCESS | 22977 | Values: 98.0 117.0 106.0 109.0 109.0 110.0 116.0 110.0 110.0 110.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:147.50 stddev:29.22 (19.8%) stddev-sans-first:30.99 23:41:57 INFO - PROCESS | 22977 | Values: 146.0 118.0 149.0 195.0 121.0 147.0 148.0 120.0 195.0 118.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 23:41:57 INFO - PROCESS | 22977 | Values: 161.0 161.0 161.0 160.0 161.0 163.0 163.0 160.0 163.0 161.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:40.87 (54.5%) stddev-sans-first:42.79 23:41:57 INFO - PROCESS | 22977 | Values: 76.0 75.0 75.0 177.0 75.0 75.0 76.0 74.0 167.0 76.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.50 stddev:31.05 (36.3%) stddev-sans-first:32.28 23:41:57 INFO - PROCESS | 22977 | Values: 87.0 85.0 157.0 86.0 86.0 86.0 153.0 84.0 85.0 137.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:41:57 INFO - PROCESS | 22977 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:1.89 (1.3%) stddev-sans-first:2.00 23:41:57 INFO - PROCESS | 22977 | Values: 148.0 147.0 153.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:41:57 INFO - PROCESS | 22977 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.00 stddev:0.97 (1.9%) stddev-sans-first:1.00 23:41:57 INFO - PROCESS | 22977 | Values: 50.0 50.0 50.0 50.0 50.0 52.0 52.0 50.0 52.0 50.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 23:41:57 INFO - PROCESS | 22977 | Values: 62.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:2.67 (3.3%) stddev-sans-first:2.79 23:41:57 INFO - PROCESS | 22977 | Values: 79.0 78.0 81.0 85.0 82.0 84.0 80.0 77.0 78.0 79.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:132.00 stddev:7.04 (5.3%) stddev-sans-first:7.30 23:41:57 INFO - PROCESS | 22977 | Values: 127.0 127.0 125.0 123.0 142.0 133.0 127.0 133.0 144.0 131.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.00 stddev:3.17 (1.9%) stddev-sans-first:3.35 23:41:57 INFO - PROCESS | 22977 | Values: 163.0 165.0 162.0 161.0 164.0 162.0 162.0 172.0 163.0 162.0 23:41:57 INFO - PROCESS | 22977 | 23:41:57 INFO - PROCESS | 22977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.71 (2.6%) stddev-sans-first:1.80 23:41:57 INFO - PROCESS | 22977 | Values: 66.0 64.0 65.0 69.0 67.0 65.0 66.0 64.0 63.0 65.0 23:41:57 INFO - PROCESS | 22977 | -------- Summary: end -------- 23:41:57 INFO - PROCESS | 22977 | 23:41:58 INFO - TEST-INFO | 22977: exit 0 23:41:58 INFO - TEST-OK | kraken | took 62947ms 23:41:58 INFO - SUITE-END | took 1178s 23:41:58 INFO - Completed test suite (00:19:38) 23:41:58 INFO - javascript benchmark 23:41:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.0442760530436, 3046.52778819283, 3081.2142903559616, 3081.8150910945346, 3098.6281646202447, 5192.974035129829, 5232.189010703338, 5280.831501099338, 5349.866253343668, 5404.351477822662, 5279.577633789298, 5292.788288468466, 5318.441563635821, 5338.332708411449, 5407.891842163154, 4776.450708168553, 4836.854894353175, 4851.442084160314, 4905.730184839832, 4986.152354099793, 4932.358793356859, 4946.703197808143, 4964.056829202458, 4965.627577931651, 4971.204607262839, 4774.092922344778, 4826.179549476562, 4828.927566086511, 4903.68126071806, 4925.507449255064, 4778.952210477885, 4803.471618122004, 4816.759162041884, 4835.927461088087, 4872.074305881871, 4721.433427988663, 4749.715017098985, 4782.856514304576, 4790.904181916377, 4800.0879832832, 5298.072837253504, 5311.73441327936, 5319.6808191508635, 5328.706921119337, 5329.786808527654, 5558.277423934903, 5646.378898321223, 5668.801591944303, 5714.085746280575, 5730.140478928152, 5757.827265182052, 5801.245838041028, 5813.331466881321, 5823.79616713413, 5830.212921255618, 5389.083855744494, 5403.918941215885, 5406.594505412031, 5407.810726624549, 5407.918881216785, 5631.746571404296, 5648.350439699405, 5689.0, 5691.231683722727, 5799.971000144972, 5567.832965010975, 5569.944300557024, 5572.888542229132, 5574.358948720868, 5576.247206627054, 5639.238702775155, 5649.322081350182, 5658.773649054074, 5663.405342439067, 5667.489925906688, 5490.945090549123, 5569.220309156722, 5602.803901863496, 5608.270924779753, 5652.547796176296, 5645.463680950304, 5658.660480371191, 5661.830145095653, 5661.915071273934, 5663.093904975184, 4392.802323895432, 4429.269170586882, 4431.8448854289945, 4437.112577484516, 4440.200763862471, 3801.7718936863876, 3894.4547763313158, 3907.6873850091924, 3939.9606003940166, 3946.427767973628, 5511.448855114457, 5512.531434828004, 5515.090010148361, 5516.531094856902, 5518.034343989786, 5743.770249189985, 5767.826965191051, 5771.249737534094, 5779.075347944308, 5782.306123265235, 5316.308879845596, 5367.946320536823, 5403.945960540423, 5406.91889621656, 5528.502434780889, 4920.335754673145, 4921.163402221631, 4931.679440836334, 4932.21084626458, 4932.4081110267, 5930.614510056833, 5958.463738263577, 5963.403659634088, 5966.0, 5968.940310596925, 5521.171824226398, 5537.944620553904, 5577.024020796425, 5588.6646801192055, 5694.974904517227, 5860.0, 5870.148828419769, 5902.704864756831, 5910.852228694317, 5913.172155898092, 5532.695701736443, 5537.723113844372, 5540.445955404589, 5558.861028474321, 5563.666180029211, 5401.837944861661, 5647.350554686263, 5664.150377443417, 5694.117411801012, 5700.743466543932, 5638.9436105638415, 5645.068563686946, 5646.0, 5646.915296270641, 5648.265725455664, 5633.155026745857, 5642.153676948491, 5643.548516118783, 5648.068068768607, 5651.237082993744, 5367.892642147213, 5411.458854114557, 5434.5652347812875, 5462.0, 5585.720713964367, 5602.52378547828, 5628.605997580294, 5633.8591535211945, 5639.7180140993605, 5647.237622921018, 5477.726113694379, 5502.064649009758, 5502.119660854244, 5514.448555144453, 5521.061419558765], "value": 5254.703814867398, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3406582430206, 595.1132812109958, 609.7134346856978, 615.5844804756788, 618.2056057965515, 42769.78615106924, 43769.0, 43810.342844857354, 43984.560154398445, 47470.762646186806, 45042.54957450424, 45849.541504584944, 45882.0, 45940.0, 46279.768601156946, 8783.209511143996, 9012.963509196461, 9014.774630634221, 9019.278457723367, 9023.864642030341, 9087.454752714826, 9191.264698824112, 9197.770055748626, 9212.401193922407, 9214.44713317203, 9249.722508324761, 9302.581383837709, 9310.255179585616, 9315.115064068903, 9327.953360233189, 9250.67622633208, 9297.023812499658, 9303.58133883977, 9305.232005918853, 9307.0, 9072.682456114004, 9160.725178244596, 9165.31260155491, 9170.266378689756, 9172.724818255463, 43308.133837323396, 43647.34528982068, 43776.56223437757, 43844.78077609623, 43907.560924390986, 3331.3670402623425, 3410.6698387628844, 3638.690711289517, 3920.0199950012498, 4105.568915263884, 32404.837975810206, 32773.34453310944, 33027.0, 33084.503732444035, 33930.0, 4308.978455107705, 4449.644028477714, 4494.977525112354, 4565.155446242456, 4681.929771053403, 349724.0, 352857.649982252, 355819.0, 357283.0, 360150.0, 58969.0, 59232.70383648054, 59264.11103833446, 59337.703311483165, 59451.0, 61666.69166654138, 61772.0, 61829.690851545456, 61975.07037394443, 62169.689151554856, 16625.334986600643, 16874.0, 16888.493345199662, 16940.23768930401, 16965.031119554274, 12052.819207711891, 12071.818922715991, 12074.0, 12079.335636540074, 12105.152639315163, 14901.627459313388, 16579.17104144788, 16634.0, 16666.4166754163, 16673.6665266694, 5663.292088488939, 6530.967345163243, 6542.476601871839, 6542.771003014872, 6799.660016999131, 895.2390468102192, 1019.7304356076584, 1029.9897001030045, 1138.2260063157132, 1156.8958793708607, 32631.51052734211, 33208.1697957553, 33483.49774753381, 33498.8325058378, 33781.49327760086, 1084.7505073833063, 1120.5461787975883, 1144.0790163918125, 1190.0717440396504, 1208.64949164743, 16832.24254908532, 17358.739618905474, 17367.218475168396, 17398.478045658652, 17451.214695338742, 502513.0, 502892.0, 503535.0, 508438.0, 510821.0, 60165.0, 60367.39632603618, 60416.0, 60418.697906511065, 60476.697616511636, 1210.3827048205303, 1288.2206265209413, 1324.2915040453504, 1335.4190926946615, 1344.4487760018542, 31970.52044219385, 33880.66119338775, 34279.48580771241, 34400.655993439745, 34543.0, 51042.23436648379, 51603.74198128985, 51786.741066294424, 51827.48172518227, 51872.481275186765, 309640.0, 309920.0, 310684.0, 312592.0, 314102.0, 27950.44099118047, 28980.565291520223, 29017.709822902347, 29910.551341730326, 30223.395532089675, 48372.5162748368, 49047.50952490429, 49374.25938610852, 49484.257736133266, 50961.74519127529, 41524.79237603793, 41619.0, 42199.7890010548, 43581.34627980519, 43755.90515754595, 41901.79049104735, 41928.3710744333, 42482.78758606187, 43096.78451607847, 43407.0, 41635.7918210407, 41738.37392439055, 42540.57459425366, 43159.13681726411, 43319.56680433281, 33604.663953360156, 37565.62434375731, 37607.43588846115, 37818.81090594529, 38452.038699032746, 27901.86049069823, 28259.858700706365, 28491.145265642062, 28515.144545663665, 28574.142775716762], "value": 20166.42968902283, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.4790309131129, 390.50991006287126, 400.54338054617733, 400.7194963525532, 418.38079642129645, 14340.74192039336, 18730.53173670659, 19548.0, 19816.0, 19938.90030549849, 12674.873251267485, 12899.355032248397, 12924.289164095972, 12996.675083122904, 12997.870021299785, 4001.779902105383, 5283.181106928422, 5426.131818908975, 5429.294191755066, 5441.347038355403, 5755.107958266475, 5857.033589457735, 5949.137375080611, 6076.665783381913, 6083.965725826598, 5969.13447550105, 6076.301225359074, 6078.149059131725, 6543.411093001629, 6596.0435736818135, 6559.672016399185, 6586.30843761403, 6588.242352129519, 6588.901166482507, 6595.769148079794, 5109.20807274873, 5291.629585928987, 5325.946740532622, 5431.158170483582, 5438.510534051915, 14214.147151170962, 14344.784828227585, 18329.450116496526, 23613.763862361327, 23795.0, 2299.9425014374606, 2337.2520793346134, 2494.3140636324974, 2506.884436425791, 2725.6184134221226, 10159.796804063877, 10796.622118225825, 10864.782704345947, 11957.940210298893, 13447.125936814076, 1859.7768267807814, 1882.8117188281199, 1895.9146838392305, 1912.9808701913082, 1917.731517587539, 82060.58969705114, 83167.58416207941, 83500.58249708773, 83637.58181209116, 84695.57652211761, 10727.463626818784, 11049.779004419866, 11419.885801142049, 11832.349220792767, 12284.324362159989, 15078.396864125532, 15101.32044057998, 15115.622109447351, 15116.697666046837, 15152.469663561722, 8001.199880011952, 8031.59842007909, 8106.47307924983, 8331.083580806106, 8331.50010999342, 7646.350060244941, 7885.0, 7912.169222231698, 7922.881156782653, 8075.313598344206, 4547.386102876069, 4605.815767369335, 4640.744759038218, 4671.6262698984, 4737.692050016738, 1909.7421848050335, 2002.3092033248506, 2008.126464987735, 2022.3427386099577, 2036.5010572409853, 885.7608445719619, 965.4931161140317, 980.926430517714, 999.7900440907346, 1040.7242080848582, 20001.199952002047, 20036.198552058046, 20299.188032478534, 20329.390118296476, 20447.693284600744, 993.8260804359209, 1005.6027868991707, 1014.1075853249241, 1028.1055481730941, 1045.8326667733127, 10614.150867930546, 10628.309159904582, 11043.116550675926, 11104.615445591633, 11173.497192626352, 420258.0, 446974.0, 456044.0, 457343.0, 466194.0, 85709.0, 85837.14162858417, 85935.0, 88826.0, 89205.55397222973, 983.5131609853169, 998.2680050113048, 1028.711960651019, 1031.7523794289316, 1037.455335948633, 15542.378304867678, 17148.742768858727, 17238.482845514656, 17478.213480393668, 17528.633634459184, 28728.569071463528, 29526.704732952396, 40957.0, 41718.58281417147, 42800.35799463073, 57208.42791572031, 57302.68551660741, 57915.0, 58292.708536457045, 58644.0, 8568.614412351335, 8698.347623928357, 8776.78058048554, 8792.29661627081, 9016.143466370684, 12961.092723509264, 13073.477060917457, 13101.410436530188, 13210.207387556777, 13286.20282783036, 11332.320060796379, 11426.94286528562, 11513.942430287794, 11618.302901825917, 11832.0, 11452.94273528627, 11608.129390295593, 11609.071274297867, 11843.348615826213, 12010.399480026139, 11275.0, 11309.434528273388, 11339.943300283447, 11505.424728763695, 11539.36533490666, 8588.184122508601, 8604.311655067455, 8787.91212087871, 8860.246879015356, 9116.36185467011, 8562.186592273723, 11175.888241117485, 11187.440627968732, 11291.491882865455, 11408.372539510407], "value": 9064.468247697008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.7775078236698, 1486.5911874234585, 1507.600485871244, 1635.4194261037333, 1717.321657945111, 8645.870311945318, 8926.0, 9020.413673111252, 9250.67622633208, 9272.119148680882, 9030.954845225764, 9165.175134237918, 9173.449593024407, 9175.265978721704, 9175.54122293886, 2383.153980336977, 2400.1719406804623, 2402.4354276744953, 2402.8918698658513, 2415.2995631266913, 2393.5571919194917, 2419.4798118404537, 2439.0731522021606, 2448.26552034389, 2467.3954881054165, 2380.7619238076227, 2392.1986134644917, 2400.7479214682467, 2430.4531480416854, 2435.3789783605157, 2315.8842057897205, 2352.1297120065515, 2360.8701521416315, 2366.7278262999716, 2368.3131891751286, 2247.7864602862865, 2273.6362182050957, 2273.6475846243857, 2276.7950884420484, 2278.327893271489, 8913.910860891372, 9158.679446219418, 9193.126652967958, 9250.213731832802, 9269.0, 5246.711430871301, 5426.0, 5497.230387745719, 5499.670019798785, 5503.504684578407, 3623.6376362363817, 3647.0, 3660.871869484555, 3702.5371828521434, 3707.2029513654425, 1169.228309315856, 1190.7499425120734, 1192.5349113845607, 1201.1291813435278, 1231.667449788561, 12326.753464930742, 12509.74980500394, 12511.499540018389, 12532.561360352434, 12554.686132846751, 4739.2891066339635, 4760.785764640599, 4802.495737947465, 4915.705057696549, 4941.50584941503, 10654.254202205771, 10678.51946662402, 10707.518161682743, 10709.946450267855, 10713.517891694737, 5406.135018397038, 5442.2380866678695, 5463.207834864002, 5473.31583552056, 5473.507384335429, 4453.955460445419, 4840.249761287007, 4993.475685053089, 4998.375203099613, 5034.773435195425, 3981.5620281768984, 4012.3179059559943, 4153.709240353146, 4169.60388763067, 4209.284421648327, 1342.89256859451, 1359.0962010263065, 1362.216725382889, 1366.1188533395905, 1385.591250581081, 877.0045997792424, 901.1439132823843, 953.6423841059602, 961.3991255465335, 974.3949560731652, 5663.858403539862, 5779.8555036124435, 5861.062230043172, 6080.14877917092, 6089.939100609025, 454.9476810166807, 460.2957475063159, 461.8683675152565, 462.6067842333989, 466.7899445249651, 4035.2534781065597, 4109.3425051991535, 4127.525334586501, 4180.3102488089735, 4200.432941552913, 10713.410762407986, 11131.443427828575, 11149.163812713916, 11166.720831979266, 11185.440727963569, 11031.2278140531, 11057.557697692164, 11065.889341106647, 11112.16658750597, 11122.277051991594, 8171.680161337102, 8260.793480162924, 8308.750737477885, 8318.70884519039, 8344.499330040217, 5784.0, 5893.499052580579, 5918.17145599625, 5951.0, 5999.580029398075, 9845.409275443497, 10053.748656283651, 10068.84896726535, 10122.949385253027, 10148.391096534231, 10354.637587684394, 10499.950004999439, 10581.62964296246, 10640.521176547229, 10658.520366583678, 6895.0, 6919.273476285119, 7626.199249078767, 7765.145833958373, 7897.565633890191, 8484.109168537214, 8722.781930451789, 8728.08355122703, 8792.120787921156, 8811.33914956368, 7523.510971786816, 7599.810004749926, 7686.3082322591235, 7731.149573546792, 7808.84382312362, 7327.780166595011, 7448.366888814511, 7641.7707468776025, 7680.193579674054, 7773.0, 7153.177384600837, 7245.855082898418, 7259.274072592699, 7267.164276108315, 7271.381932535794, 5075.771590278372, 5096.898062038813, 5098.694078355311, 5141.7686204120155, 5374.677519348852, 5423.132298832168, 5504.6421982571, 5572.832815015556, 5579.609427340048, 5609.868250064949], "value": 4645.609642052009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.619488296135, 327.65432468745473, 335.60901549694614, 335.82704906972896, 336.5170979644212, 5142.614303927211, 5143.948560514394, 5144.356955380577, 5148.330717006788, 5156.484351564842, 5010.749462526877, 5054.317667114939, 5106.285120083191, 5108.948910510894, 5113.6931784092885, 3819.4531214858025, 3871.128995975911, 4010.3783913493453, 4025.295573274665, 4034.5360283567325, 4014.3175660137845, 4019.77891215983, 4040.2121586290687, 4058.959410405888, 4068.9593104068877, 3994.4208089826957, 4006.83972641094, 4009.8797036088818, 4021.9597804022023, 4034.616711412411, 3808.447775072613, 3912.784796836187, 3961.9405708914387, 3993.381025940984, 4020.778857162855, 3532.763532763538, 3543.7596841105665, 3545.592256890439, 3559.715222782171, 3583.552055993001, 4863.465018847924, 4891.461939186686, 4903.901921961577, 4939.506049395068, 4947.257911313296, 4486.349479325512, 4551.40831691878, 4575.428071491064, 4588.334691469751, 4593.40285762852, 5175.560077393388, 5214.32213812202, 5229.241759944786, 5230.633855630107, 5242.79028838846, 3902.278078555448, 3902.551206611219, 3934.822932967995, 3936.8228429720443, 3940.468036815022, 5270.762815673265, 5413.566914646819, 5418.2685337479725, 5448.318960129984, 5496.862578435531, 3995.580464051233, 3998.460207871958, 4010.7994600270454, 4017.738846974937, 4031.3796032579057, 4062.821781683279, 4087.0, 4093.6520395766097, 4102.917941641151, 4105.0763578195265, 4371.715838470489, 4594.839180628662, 4601.0, 4606.378138951266, 4626.653001024936, 5215.061288967946, 5268.894622107613, 5274.868128296746, 5307.469253074739, 5328.786848526015, 1385.2035079828936, 1389.0415613226842, 1392.6769568909576, 1392.9721405571831, 1397.2454874367727, 876.3164731509432, 921.7004473545991, 925.3383830561181, 929.0848514213494, 937.9062093790703, 4938.604911607063, 5069.681882710448, 5160.277561141444, 5245.3705555332845, 5250.2173847860695, 5452.863678408072, 5460.208269800856, 5461.371942226695, 5468.144957804738, 5476.972615136899, 4981.701097934136, 5194.272801807674, 5218.869528261824, 5238.109521381374, 5239.711815850089, 2796.4826507096254, 2887.191586355824, 2887.5850833091636, 2889.8555072246722, 2892.8119672221237, 5716.857078573069, 5725.914111288334, 5730.046268075098, 5783.421657834267, 5791.739371728198, 5475.479829416199, 5481.2874326338115, 5530.198121272393, 5550.972245138749, 5663.66018038919, 5658.547316214693, 5659.518940890071, 5660.518855897212, 5661.575381846378, 5676.68778217202, 5352.0, 5401.756920938488, 5440.265564148789, 5465.562754979672, 5465.863353416037, 5174.7153906535505, 5361.79359644077, 5412.56699464034, 5416.160495123262, 5418.106012507892, 5652.3217213934595, 5652.463016013472, 5684.63049901755, 5685.232493613309, 5785.566082543742, 3777.773333599993, 3935.1932853765484, 3984.3425834736945, 3986.22268657609, 4011.7994100294286, 5389.75746091419, 5392.35291764975, 5408.8377348679605, 5417.887024060541, 5429.918551221814, 5290.65610735301, 5300.178472336794, 5318.787248510016, 5380.219868119023, 5383.596230282823, 5192.221166825007, 5277.525022747971, 5306.681599104066, 5340.3031469107855, 5340.546053585489, 5149.5323832709, 5215.243789650555, 5222.242774797709, 5224.876651519941, 5248.868778280574, 5096.694198348111, 5218.895622087461, 5263.026340127089, 5289.57683385336, 5290.25936368901, 5171.276021357088, 5191.974040129775, 5196.584273258206, 5198.584113271005, 5223.686578805284], "value": 4088.2357303835615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.3968507713212, 791.5646394483035, 792.4848848248638, 846.5217152308941, 849.5285116760195, 15174.317155727991, 16437.83562164378, 16507.504774856774, 16531.42140025098, 16540.090295033784, 14090.57728268151, 14374.281285935715, 14383.64040898978, 14481.710365792704, 14643.707125857476, 807.1283014344523, 825.352098602597, 827.2017503109498, 827.7475370012144, 828.1056459024239, 666.473485946102, 775.4533054196778, 797.6570074867805, 802.3220378779922, 802.7631848604676, 868.5787393114334, 868.682930730282, 869.074435725953, 869.8999615044256, 870.0559892516595, 859.8968123825118, 860.0711231869566, 860.2644738748373, 860.9526476043815, 861.6467248428114, 516.2153526639487, 607.2257871214193, 625.3152797686525, 625.8216408323606, 626.0546574672233, 13788.655283617989, 13858.099223550436, 13893.0, 13965.790513142209, 13981.231032293219, 13553.25457099869, 14155.079919805283, 14307.213103279315, 14497.710045799025, 14726.410943562245, 13368.131071480322, 13435.0, 13497.797533037012, 13564.796528052088, 13692.246926419042, 4420.160169567772, 4441.666874984357, 4491.797869095899, 4521.480029796583, 4547.567981041796, 81893.59053204756, 82716.0, 84099.57950210272, 85510.99999999937, 88015.0, 11153.776924461465, 11202.21584489078, 11291.153163512769, 11335.319880807177, 11437.885621143849, 22223.333300001024, 22239.110435582395, 22418.215362462237, 22489.662655060187, 22495.88752056262, 8731.211646915528, 8820.11798820113, 8854.557272136368, 8856.247218986458, 8979.955100224457, 4716.245400735866, 4872.78072486739, 4925.87685307863, 5007.499250075036, 5046.142155833517, 3445.207602251496, 3549.9290014199573, 3557.8221088945447, 3558.733095017884, 3560.394732895414, 589.360543809971, 595.2767387623971, 599.9940000600026, 635.3487675133026, 640.0335493404992, 666.9133012708317, 684.7740245718901, 745.1616930952679, 752.6124046116255, 776.9145394006655, 10208.928062553325, 10247.29513148634, 10677.57289708403, 10696.732581685521, 10767.730806729895, 635.3138610300864, 670.3732010570133, 722.8807246804218, 737.1301863800767, 770.3298130626391, 4852.199387101089, 5055.266986286968, 5085.389753229636, 5100.081985242692, 5102.69383836971, 99012.50493747485, 124722.0, 128568.0, 131641.34179329043, 133230.0, 67332.663336683, 68780.3121968784, 77963.61018194872, 84763.57618211993, 112803.0, 82803.58598207092, 84563.0, 87279.0, 89074.0, 91618.0, 9711.3202075854, 9994.800103998024, 10065.7456310488, 10251.411031290161, 10252.692419227435, 47392.0, 48428.515714842404, 49521.0, 51470.0, 51730.0, 65804.6709766448, 71579.64210179124, 74414.62792686002, 74797.0, 77773.61113194398, 13160.210387376788, 13231.66920826987, 13568.660783480098, 14056.859431405965, 14193.787093193818, 15172.393104276147, 15393.30730117125, 15511.84488155104, 15853.920730396274, 15906.60233494172, 14514.274286285854, 14689.485867994568, 14790.186539740418, 14846.257687115816, 14918.85081149218, 13866.376013079234, 15118.168500732125, 15209.315580799112, 15274.642588412216, 15735.842641573438, 14288.857111429168, 14999.475018374305, 15055.924720376766, 15644.139572323631, 15665.216739163225, 10542.525586348786, 11298.209125361145, 11646.301221926711, 11691.415429228335, 11827.172097953406, 10103.592022166255, 10215.438150901771, 10921.453927303763, 11819.527218911147, 11839.526418943145], "value": 7742.815884862702, "unit": "score"}], "name": "dromaeo_css", "value": 7216.733429503211, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 117.0, 106.0, 109.0, 109.0, 110.0, 116.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 149.0, 195.0, 121.0, 147.0, 148.0, 120.0, 195.0, 118.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 163.0, 163.0, 160.0, 163.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 177.0, 75.0, 75.0, 76.0, 74.0, 167.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 157.0, 86.0, 86.0, 86.0, 153.0, 84.0, 85.0, 137.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 153.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 50.0, 52.0, 52.0, 50.0, 52.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 81.0, 85.0, 82.0, 84.0, 80.0, 77.0, 78.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 125.0, 123.0, 142.0, 133.0, 127.0, 133.0, 144.0, 131.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 161.0, 164.0, 162.0, 162.0, 172.0, 163.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 69.0, 67.0, 65.0, 66.0, 64.0, 63.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1529.1, "alertThreshold": 2.0}]} 23:41:59 INFO - Return code: 0 23:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:41:59 INFO - # TBPL SUCCESS # 23:41:59 INFO - Running post-action listener: _resource_record_post_action 23:41:59 INFO - [mozharness: 2016-08-20 06:41:59.121906Z] Finished run-tests step (success) 23:41:59 INFO - Running post-run listener: _resource_record_post_run 23:41:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407982080; Read time: 84; Write time: 323308 23:41:59 INFO - TinderboxPrint: CPU usage
13.3% 23:41:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 84 23:41:59 INFO - TinderboxPrint: I/O write bytes / time
407,982,080 / 323,308 23:41:59 INFO - TinderboxPrint: CPU idle
8,275.2 (86.7%) 23:41:59 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 23:41:59 INFO - TinderboxPrint: Swap in / out
0 / 0 23:41:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117477376; Read time: 0; Write time: 84512 23:41:59 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289566720; Read time: 84; Write time: 238764 23:41:59 INFO - Running post-run listener: _upload_blobber_files 23:41:59 INFO - Blob upload gear active. 23:41:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:41:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:41:59 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'] 23:41:59 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 23:42:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:01 INFO - (blobuploader) - INFO - Done attempting. 23:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:05 INFO - (blobuploader) - INFO - Done attempting. 23:42:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:42:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:05 INFO - (blobuploader) - INFO - Done attempting. 23:42:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:42:05 INFO - Return code: 0 23:42:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:42:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:42:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cc3586565b4b6eb06a77c24622738d53c8c39260f0be21db98cf07ad3fc660df5d7e1ccc1168265dfc8c706a5daaeaaf5156f0f250ced4af688d0b3bb981ff5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8cfd13e7dc3596a8fd9e9995f0b2578b94adc7031ebabcb58d37878810cf3083f3e2559048696888d018df1ab4a0d938ec341ffafef1a6b28c27e238d1d1b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bde2951823a077c832486dcdf993c403925b6a8d82535a0532c050e18fcda36a9e5d43655f8e9b2a60719a642e0b7d14e6c966244d6d9ff8b168656cf60f7133"} 23:42:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:42:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:42:05 INFO - Contents: 23:42:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cc3586565b4b6eb06a77c24622738d53c8c39260f0be21db98cf07ad3fc660df5d7e1ccc1168265dfc8c706a5daaeaaf5156f0f250ced4af688d0b3bb981ff5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8cfd13e7dc3596a8fd9e9995f0b2578b94adc7031ebabcb58d37878810cf3083f3e2559048696888d018df1ab4a0d938ec341ffafef1a6b28c27e238d1d1b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bde2951823a077c832486dcdf993c403925b6a8d82535a0532c050e18fcda36a9e5d43655f8e9b2a60719a642e0b7d14e6c966244d6d9ff8b168656cf60f7133"} 23:42:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:42:05 INFO - Copying logs to upload dir... 23:42:05 INFO - mkdir: /builds/slave/test/build/upload/logs 23:42:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.674447 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-19 23:42:05.024776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 23:42:05.029643) ========= 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=836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843 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/9cc3586565b4b6eb06a77c24622738d53c8c39260f0be21db98cf07ad3fc660df5d7e1ccc1168265dfc8c706a5daaeaaf5156f0f250ced4af688d0b3bb981ff5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8cfd13e7dc3596a8fd9e9995f0b2578b94adc7031ebabcb58d37878810cf3083f3e2559048696888d018df1ab4a0d938ec341ffafef1a6b28c27e238d1d1b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bde2951823a077c832486dcdf993c403925b6a8d82535a0532c050e18fcda36a9e5d43655f8e9b2a60719a642e0b7d14e6c966244d6d9ff8b168656cf60f7133"} build_url:https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/VaasKKIfQVmEYTAEAwAHBQ/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/9cc3586565b4b6eb06a77c24622738d53c8c39260f0be21db98cf07ad3fc660df5d7e1ccc1168265dfc8c706a5daaeaaf5156f0f250ced4af688d0b3bb981ff5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8cfd13e7dc3596a8fd9e9995f0b2578b94adc7031ebabcb58d37878810cf3083f3e2559048696888d018df1ab4a0d938ec341ffafef1a6b28c27e238d1d1b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bde2951823a077c832486dcdf993c403925b6a8d82535a0532c050e18fcda36a9e5d43655f8e9b2a60719a642e0b7d14e6c966244d6d9ff8b168656cf60f7133"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 23:42:05.063481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:42:05.063919) ========= 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=836cfdc75598d54cb747368e000001a9-1471671529.935311-1017510843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 23:42:05.144488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 23:42:05.144847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 23:42:05.148277) ========= ========= Total master_lag: 0.19 =========