builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1471312210.83 results: success (0) buildid: 20160815143002 builduid: 6cdb2a75ad874325bd49ddbc0bfb6886 revision: dbb9da97e0e1c021314baf7de44f82fd4a74058d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.831569) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.831997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.832273) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.852024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.852343) ========= 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=52faae308a556c440401f8e5000001e8-1471312211.475059-582163460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 18:50:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-08-15 18:50:12 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.979933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:10.980241) ========= 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=52faae308a556c440401f8e5000001e8-1471312211.475059-582163460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013434 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:11.030916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 18:50:11.031387) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dbb9da97e0e1c021314baf7de44f82fd4a74058d --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 dbb9da97e0e1c021314baf7de44f82fd4a74058d --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=52faae308a556c440401f8e5000001e8-1471312211.475059-582163460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 18:50:12,466 truncating revision to first 12 chars 2016-08-15 18:50:12,466 Setting DEBUG logging. 2016-08-15 18:50:12,466 attempt 1/10 2016-08-15 18:50:12,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dbb9da97e0e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 18:50:13,435 unpacking tar archive at: fx-team-dbb9da97e0e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.306185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 18:50:12.353349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:12.353691) ========= script_repo_revision: dbb9da97e0e1c021314baf7de44f82fd4a74058d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:12.354082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:12.354369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 18:50:12.365157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-15 18:50:12.365829) ========= /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=52faae308a556c440401f8e5000001e8-1471312211.475059-582163460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:50:13 INFO - MultiFileLogger online at 20160815 18:50:13 in /builds/slave/test 18:50:13 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 18:50:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:50:13 INFO - {'append_to_log': False, 18:50:13 INFO - 'base_work_dir': '/builds/slave/test', 18:50:13 INFO - 'blob_upload_branch': 'Fx-Team', 18:50:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:50:13 INFO - 'branch': 'Fx-Team', 18:50:13 INFO - 'buildbot_json_path': 'buildprops.json', 18:50:13 INFO - 'config_files': ('talos/linux_config.py',), 18:50:13 INFO - 'default_actions': ('clobber', 18:50:13 INFO - 'read-buildbot-config', 18:50:13 INFO - 'download-and-extract', 18:50:13 INFO - 'populate-webroot', 18:50:13 INFO - 'create-virtualenv', 18:50:13 INFO - 'install', 18:50:13 INFO - 'run-tests'), 18:50:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:50:13 INFO - 'download_minidump_stackwalk': True, 18:50:13 INFO - 'download_symbols': 'ondemand', 18:50:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:50:13 INFO - 'tooltool.py': '/tools/tooltool.py', 18:50:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:50:13 INFO - '/tools/misc-python/virtualenv.py')}, 18:50:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:50:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:50:13 INFO - 'installer_path': 'installer.exe', 18:50:13 INFO - 'log_level': 'info', 18:50:13 INFO - 'log_name': 'talos', 18:50:13 INFO - 'log_to_console': True, 18:50:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:50:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:50:13 INFO - 'opt_config_files': (), 18:50:13 INFO - 'pip_index': False, 18:50:13 INFO - 'sps_profile': False, 18:50:13 INFO - 'sps_profile_interval': 0, 18:50:13 INFO - 'suite': 'dromaeojs', 18:50:13 INFO - 'system_bits': '32', 18:50:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:50:13 INFO - 'title': 'talos-linux64-ix-056', 18:50:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:50:13 INFO - 'use_talos_json': True, 18:50:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:50:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:50:13 INFO - 'work_dir': 'build'} 18:50:13 INFO - [mozharness: 2016-08-16 01:50:13.891524Z] Running clobber step. 18:50:13 INFO - Running pre-action listener: _resource_record_pre_action 18:50:13 INFO - Running main action method: clobber 18:50:13 INFO - rmtree: /builds/slave/test/build 18:50:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:50:14 INFO - Running post-action listener: _resource_record_post_action 18:50:14 INFO - [mozharness: 2016-08-16 01:50:14.353923Z] Finished clobber step (success) 18:50:14 INFO - [mozharness: 2016-08-16 01:50:14.354023Z] Running read-buildbot-config step. 18:50:14 INFO - Running pre-action listener: _resource_record_pre_action 18:50:14 INFO - Running main action method: read_buildbot_config 18:50:14 INFO - Using buildbot properties: 18:50:14 INFO - { 18:50:14 INFO - "project": "", 18:50:14 INFO - "product": "firefox", 18:50:14 INFO - "script_repo_revision": "production", 18:50:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:50:14 INFO - "repository": "", 18:50:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:50:14 INFO - "buildid": "20160815143002", 18:50:14 INFO - "pgo_build": "True", 18:50:14 INFO - "basedir": "/builds/slave/test", 18:50:14 INFO - "buildnumber": 1459, 18:50:14 INFO - "slavename": "talos-linux64-ix-056", 18:50:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:50:14 INFO - "platform": "ubuntu64_hw", 18:50:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:50:14 INFO - "branch": "fx-team", 18:50:14 INFO - "repo_path": "integration/fx-team", 18:50:14 INFO - "revision": "dbb9da97e0e1c021314baf7de44f82fd4a74058d", 18:50:14 INFO - "stage_platform": "linux64-pgo", 18:50:14 INFO - "builduid": "6cdb2a75ad874325bd49ddbc0bfb6886", 18:50:14 INFO - "slavebuilddir": "test" 18:50:14 INFO - } 18:50:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:50:14 INFO - Running post-action listener: _resource_record_post_action 18:50:14 INFO - [mozharness: 2016-08-16 01:50:14.356449Z] Finished read-buildbot-config step (success) 18:50:14 INFO - [mozharness: 2016-08-16 01:50:14.356537Z] Running download-and-extract step. 18:50:14 INFO - Running pre-action listener: _resource_record_pre_action 18:50:14 INFO - Running main action method: download_and_extract 18:50:14 INFO - mkdir: /builds/slave/test/build/tests 18:50:14 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')]} 18:50:14 INFO - trying https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:50:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:14 INFO - Downloaded 1361 bytes. 18:50:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:50:14 INFO - Using the following test package requirements: 18:50:14 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:50:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:50:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'jsshell-linux-x86_64.zip'], 18:50:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:50:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:50:14 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:50:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:50:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:50:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:50:14 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')]} 18:50:14 INFO - trying https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:50:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:15 INFO - Downloaded 21836399 bytes. 18:50:15 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 18:50:20 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 18:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:20 INFO - trying https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:50:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:20 INFO - Downloaded 21836399 bytes. 18:50:20 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 18:50:25 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')]} 18:50:25 INFO - trying https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:50:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:26 INFO - Downloaded 14413719 bytes. 18:50:26 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 18:50: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')]} 18:50:26 INFO - trying https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:50:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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 18:50:27 INFO - Downloaded 59406236 bytes. 18:50:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:50:27 INFO - mkdir: /builds/slave/test/properties 18:50:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:50:27 INFO - Writing to file /builds/slave/test/properties/build_url 18:50:27 INFO - Contents: 18:50:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:50:28 INFO - Running post-action listener: _resource_record_post_action 18:50:28 INFO - Running post-action listener: set_extra_try_arguments 18:50:28 INFO - [mozharness: 2016-08-16 01:50:28.759222Z] Finished download-and-extract step (success) 18:50:28 INFO - [mozharness: 2016-08-16 01:50:28.759518Z] Running populate-webroot step. 18:50:28 INFO - Running pre-action listener: _resource_record_pre_action 18:50:28 INFO - Running main action method: populate_webroot 18:50:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:50:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:50:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:50:28 INFO - '--tppagecycles', 18:50:28 INFO - '7'], 18:50:28 INFO - 'tests': ['tsvgm']}}, 18:50:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:50:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:50:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:50:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:50:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['damp', 'tps']}, 18:50:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'tests': ['damp', 'tps']}, 18:50:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['dromaeo_dom']}, 18:50:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:50:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['basic_compositor_video']}, 18:50:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:50:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['a11yr', 18:50:28 INFO - 'ts_paint', 18:50:28 INFO - 'tpaint', 18:50:28 INFO - 'sessionrestore', 18:50:28 INFO - 'sessionrestore_no_auto_restore', 18:50:28 INFO - 'tabpaint']}, 18:50:28 INFO - 'other-e10s': {'tests': ['a11yr', 18:50:28 INFO - 'ts_paint', 18:50:28 INFO - 'tpaint', 18:50:28 INFO - 'sessionrestore', 18:50:28 INFO - 'sessionrestore_no_auto_restore', 18:50:28 INFO - 'tabpaint']}, 18:50:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:50:28 INFO - 'ts_paint', 18:50:28 INFO - 'tpaint', 18:50:28 INFO - 'sessionrestore', 18:50:28 INFO - 'sessionrestore_no_auto_restore', 18:50:28 INFO - 'tabpaint']}, 18:50:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:50:28 INFO - 'ts_paint', 18:50:28 INFO - 'tpaint', 18:50:28 INFO - 'sessionrestore', 18:50:28 INFO - 'sessionrestore_no_auto_restore', 18:50:28 INFO - 'tabpaint']}, 18:50:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['a11yr', 18:50:28 INFO - 'ts_paint', 18:50:28 INFO - 'tpaint', 18:50:28 INFO - 'sessionrestore', 18:50:28 INFO - 'sessionrestore_no_auto_restore', 18:50:28 INFO - 'tabpaint']}, 18:50:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['a11yr', 18:50:28 INFO - 'ts_paint', 18:50:28 INFO - 'tpaint', 18:50:28 INFO - 'sessionrestore', 18:50:28 INFO - 'sessionrestore_no_auto_restore', 18:50:28 INFO - 'tabpaint']}, 18:50:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['tsvgx', 18:50:28 INFO - 'tsvgr_opacity', 18:50:28 INFO - 'tart', 18:50:28 INFO - 'tscrollx', 18:50:28 INFO - 'cart']}, 18:50:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:50:28 INFO - 'tsvgr_opacity', 18:50:28 INFO - 'tart', 18:50:28 INFO - 'tscrollx', 18:50:28 INFO - 'cart']}, 18:50:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'talos_options': ['--disable-e10s'], 18:50:28 INFO - 'tests': ['tp5o']}, 18:50:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'tests': ['tp5o']}, 18:50:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'talos_options': ['--disable-e10s', 18:50:28 INFO - '--xperf_path', 18:50:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:28 INFO - 'tests': ['tp5n']}, 18:50:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:28 INFO - 'talos_options': ['--xperf_path', 18:50:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:28 INFO - 'tests': ['tp5n']}}, 18:50:28 INFO - 'talos.zip': {'path': '', 18:50:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:50:28 INFO - Running post-action listener: _resource_record_post_action 18:50:28 INFO - [mozharness: 2016-08-16 01:50:28.780658Z] Finished populate-webroot step (success) 18:50:28 INFO - [mozharness: 2016-08-16 01:50:28.780751Z] Running create-virtualenv step. 18:50:28 INFO - Running pre-action listener: _resource_record_pre_action 18:50:28 INFO - Running main action method: create_virtualenv 18:50:28 INFO - Creating virtualenv /builds/slave/test/build/venv 18:50:28 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 18:50:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:50:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:50:28 INFO - Using real prefix '/usr' 18:50:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:50:29 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:31 INFO - Installing pip.................done. 18:50:31 INFO - Return code: 0 18:50:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:50:31 INFO - Using env: {'DISPLAY': ':0', 18:50:31 INFO - 'HOME': '/home/cltbld', 18:50:31 INFO - 'LANG': 'en_US.UTF-8', 18:50:31 INFO - 'LANGUAGE': 'en_US:en', 18:50:31 INFO - 'LOGNAME': 'cltbld', 18:50:31 INFO - 'MAIL': '/var/mail/cltbld', 18:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:31 INFO - 'MOZ_NO_REMOTE': '1', 18:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:31 INFO - 'NO_EM_RESTART': '1', 18:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:31 INFO - 'PWD': '/builds/slave/test', 18:50:31 INFO - 'SHELL': '/bin/bash', 18:50:31 INFO - 'SHLVL': '1', 18:50:31 INFO - 'TERM': 'linux', 18:50:31 INFO - 'TMOUT': '86400', 18:50:31 INFO - 'USER': 'cltbld', 18:50:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:31 INFO - '_': '/tools/buildbot/bin/python'} 18:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:31 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 18:50:31 INFO - Cleaning up... 18:50:31 INFO - Return code: 0 18:50:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:50:31 INFO - Using env: {'DISPLAY': ':0', 18:50:31 INFO - 'HOME': '/home/cltbld', 18:50:31 INFO - 'LANG': 'en_US.UTF-8', 18:50:31 INFO - 'LANGUAGE': 'en_US:en', 18:50:31 INFO - 'LOGNAME': 'cltbld', 18:50:31 INFO - 'MAIL': '/var/mail/cltbld', 18:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:31 INFO - 'MOZ_NO_REMOTE': '1', 18:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:31 INFO - 'NO_EM_RESTART': '1', 18:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:31 INFO - 'PWD': '/builds/slave/test', 18:50:31 INFO - 'SHELL': '/bin/bash', 18:50:31 INFO - 'SHLVL': '1', 18:50:31 INFO - 'TERM': 'linux', 18:50:31 INFO - 'TMOUT': '86400', 18:50:31 INFO - 'USER': 'cltbld', 18:50:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:31 INFO - '_': '/tools/buildbot/bin/python'} 18:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:31 INFO - Downloading/unpacking psutil>=3.1.1 18:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:33 INFO - Installing collected packages: psutil 18:50:33 INFO - Running setup.py install for psutil 18:50:33 INFO - building 'psutil._psutil_linux' extension 18:50:33 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 18:50:34 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 18:50:34 INFO - building 'psutil._psutil_posix' extension 18:50:34 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 18:50:34 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 18:50:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:34 INFO - Successfully installed psutil 18:50:34 INFO - Cleaning up... 18:50:34 INFO - Return code: 0 18:50:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:50:34 INFO - Using env: {'DISPLAY': ':0', 18:50:34 INFO - 'HOME': '/home/cltbld', 18:50:34 INFO - 'LANG': 'en_US.UTF-8', 18:50:34 INFO - 'LANGUAGE': 'en_US:en', 18:50:34 INFO - 'LOGNAME': 'cltbld', 18:50:34 INFO - 'MAIL': '/var/mail/cltbld', 18:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:34 INFO - 'MOZ_NO_REMOTE': '1', 18:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:34 INFO - 'NO_EM_RESTART': '1', 18:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:34 INFO - 'PWD': '/builds/slave/test', 18:50:34 INFO - 'SHELL': '/bin/bash', 18:50:34 INFO - 'SHLVL': '1', 18:50:34 INFO - 'TERM': 'linux', 18:50:34 INFO - 'TMOUT': '86400', 18:50:34 INFO - 'USER': 'cltbld', 18:50:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:34 INFO - '_': '/tools/buildbot/bin/python'} 18:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:50:36 INFO - Installing collected packages: mozsystemmonitor 18:50:36 INFO - Running setup.py install for mozsystemmonitor 18:50:36 INFO - Successfully installed mozsystemmonitor 18:50:36 INFO - Cleaning up... 18:50:36 INFO - Return code: 0 18:50:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:36 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:36 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 18:50:36 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 18:50:36 INFO - Using env: {'DISPLAY': ':0', 18:50:36 INFO - 'HOME': '/home/cltbld', 18:50:36 INFO - 'LANG': 'en_US.UTF-8', 18:50:36 INFO - 'LANGUAGE': 'en_US:en', 18:50:36 INFO - 'LOGNAME': 'cltbld', 18:50:36 INFO - 'MAIL': '/var/mail/cltbld', 18:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:36 INFO - 'MOZ_NO_REMOTE': '1', 18:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:36 INFO - 'NO_EM_RESTART': '1', 18:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:36 INFO - 'PWD': '/builds/slave/test', 18:50:36 INFO - 'SHELL': '/bin/bash', 18:50:36 INFO - 'SHLVL': '1', 18:50:36 INFO - 'TERM': 'linux', 18:50:36 INFO - 'TMOUT': '86400', 18:50:36 INFO - 'USER': 'cltbld', 18:50:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:36 INFO - '_': '/tools/buildbot/bin/python'} 18:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:36 INFO - Downloading/unpacking jsonschema==2.5.1 18:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:50:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:50:38 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 18:50:38 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 18:50:38 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 18:50:38 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 18:50:38 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 18:50:38 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 18:50:38 INFO - Downloading functools32-3.2.3-2.tar.gz 18:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:50:38 INFO - warning: no files found matching '*.txt' 18:50:38 INFO - no previously-included directories found matching 'build' 18:50:38 INFO - no previously-included directories found matching 'dist' 18:50:38 INFO - no previously-included directories found matching '.git*' 18:50:38 INFO - Installing collected packages: jsonschema, functools32 18:50:39 INFO - Running setup.py install for functools32 18:50:39 INFO - warning: no files found matching '*.txt' 18:50:39 INFO - no previously-included directories found matching 'build' 18:50:39 INFO - no previously-included directories found matching 'dist' 18:50:39 INFO - no previously-included directories found matching '.git*' 18:50:39 INFO - Successfully installed jsonschema functools32 18:50:39 INFO - Cleaning up... 18:50:39 INFO - Return code: 0 18:50:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:39 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:39 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 18:50:39 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 18:50:39 INFO - Using env: {'DISPLAY': ':0', 18:50:39 INFO - 'HOME': '/home/cltbld', 18:50:39 INFO - 'LANG': 'en_US.UTF-8', 18:50:39 INFO - 'LANGUAGE': 'en_US:en', 18:50:39 INFO - 'LOGNAME': 'cltbld', 18:50:39 INFO - 'MAIL': '/var/mail/cltbld', 18:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:39 INFO - 'MOZ_NO_REMOTE': '1', 18:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:39 INFO - 'NO_EM_RESTART': '1', 18:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:39 INFO - 'PWD': '/builds/slave/test', 18:50:39 INFO - 'SHELL': '/bin/bash', 18:50:39 INFO - 'SHLVL': '1', 18:50:39 INFO - 'TERM': 'linux', 18:50:39 INFO - 'TMOUT': '86400', 18:50:39 INFO - 'USER': 'cltbld', 18:50:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:39 INFO - '_': '/tools/buildbot/bin/python'} 18:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:50:39 INFO - Cleaning up... 18:50:39 INFO - Return code: 0 18:50:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:39 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:39 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 18:50:39 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 18:50:39 INFO - Using env: {'DISPLAY': ':0', 18:50:39 INFO - 'HOME': '/home/cltbld', 18:50:39 INFO - 'LANG': 'en_US.UTF-8', 18:50:39 INFO - 'LANGUAGE': 'en_US:en', 18:50:39 INFO - 'LOGNAME': 'cltbld', 18:50:39 INFO - 'MAIL': '/var/mail/cltbld', 18:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:39 INFO - 'MOZ_NO_REMOTE': '1', 18:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:39 INFO - 'NO_EM_RESTART': '1', 18:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:39 INFO - 'PWD': '/builds/slave/test', 18:50:39 INFO - 'SHELL': '/bin/bash', 18:50:39 INFO - 'SHLVL': '1', 18:50:39 INFO - 'TERM': 'linux', 18:50:39 INFO - 'TMOUT': '86400', 18:50:39 INFO - 'USER': 'cltbld', 18:50:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:39 INFO - '_': '/tools/buildbot/bin/python'} 18:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:50:39 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 18:50:39 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 18:50:39 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 18:50:39 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 18:50:39 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 18:50:39 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 18:50:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:50:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 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 18:50:41 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 18:50:42 INFO - Downloading docopt-0.6.1.tar.gz 18:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:42 INFO - Running setup.py install for blobuploader 18:50:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:50:42 INFO - Running setup.py install for requests 18:50:42 INFO - Running setup.py install for docopt 18:50:42 INFO - Successfully installed blobuploader requests docopt 18:50:42 INFO - Cleaning up... 18:50:42 INFO - Return code: 0 18:50:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:42 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')]} 18:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:42 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')]} 18:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:42 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:42 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 18:50:42 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 18:50:42 INFO - Using env: {'DISPLAY': ':0', 18:50:42 INFO - 'HOME': '/home/cltbld', 18:50:42 INFO - 'LANG': 'en_US.UTF-8', 18:50:42 INFO - 'LANGUAGE': 'en_US:en', 18:50:42 INFO - 'LOGNAME': 'cltbld', 18:50:42 INFO - 'MAIL': '/var/mail/cltbld', 18:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:42 INFO - 'MOZ_NO_REMOTE': '1', 18:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:42 INFO - 'NO_EM_RESTART': '1', 18:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:42 INFO - 'PWD': '/builds/slave/test', 18:50:42 INFO - 'SHELL': '/bin/bash', 18:50:42 INFO - 'SHLVL': '1', 18:50:42 INFO - 'TERM': 'linux', 18:50:42 INFO - 'TMOUT': '86400', 18:50:42 INFO - 'USER': 'cltbld', 18:50:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:42 INFO - '_': '/tools/buildbot/bin/python'} 18:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:43 INFO - Running setup.py (path:/tmp/pip-ZHs6_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:43 INFO - Running setup.py (path:/tmp/pip-9gCdMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:43 INFO - Running setup.py (path:/tmp/pip-a1eMRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:43 INFO - Running setup.py (path:/tmp/pip-PaD4gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:43 INFO - Running setup.py (path:/tmp/pip-wrU2B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:43 INFO - Running setup.py (path:/tmp/pip-uBUBzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:43 INFO - Running setup.py (path:/tmp/pip-TS2EcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:43 INFO - Running setup.py (path:/tmp/pip-StQETJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:43 INFO - Running setup.py (path:/tmp/pip-6ZbaGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:43 INFO - Running setup.py (path:/tmp/pip-8j2a19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:43 INFO - Running setup.py (path:/tmp/pip-TuycZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:43 INFO - Running setup.py (path:/tmp/pip-0m5kmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:44 INFO - Running setup.py (path:/tmp/pip-5vVpat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:44 INFO - Running setup.py (path:/tmp/pip-0Zu1vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:44 INFO - Running setup.py (path:/tmp/pip-0uY6xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:44 INFO - Running setup.py (path:/tmp/pip-45zWUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:44 INFO - Running setup.py (path:/tmp/pip-H6md6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:44 INFO - Running setup.py install for manifestparser 18:50:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:50:44 INFO - Running setup.py install for mozcrash 18:50:44 INFO - Running setup.py install for mozdebug 18:50:44 INFO - Running setup.py install for mozdevice 18:50:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:50:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:50:44 INFO - Running setup.py install for mozfile 18:50:44 INFO - Running setup.py install for mozhttpd 18:50:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for mozinfo 18:50:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for mozInstall 18:50:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for mozleak 18:50:45 INFO - Running setup.py install for mozlog 18:50:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for moznetwork 18:50:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for mozprocess 18:50:45 INFO - Running setup.py install for mozprofile 18:50:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for mozrunner 18:50:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:50:45 INFO - Running setup.py install for mozscreenshot 18:50:46 INFO - Running setup.py install for moztest 18:50:46 INFO - Running setup.py install for mozversion 18:50:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:50:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:50:46 INFO - Cleaning up... 18:50:46 INFO - Return code: 0 18:50:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:46 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:46 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 18:50:46 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 18:50:46 INFO - Using env: {'DISPLAY': ':0', 18:50:46 INFO - 'HOME': '/home/cltbld', 18:50:46 INFO - 'LANG': 'en_US.UTF-8', 18:50:46 INFO - 'LANGUAGE': 'en_US:en', 18:50:46 INFO - 'LOGNAME': 'cltbld', 18:50:46 INFO - 'MAIL': '/var/mail/cltbld', 18:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:46 INFO - 'MOZ_NO_REMOTE': '1', 18:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:46 INFO - 'NO_EM_RESTART': '1', 18:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:46 INFO - 'PWD': '/builds/slave/test', 18:50:46 INFO - 'SHELL': '/bin/bash', 18:50:46 INFO - 'SHLVL': '1', 18:50:46 INFO - 'TERM': 'linux', 18:50:46 INFO - 'TMOUT': '86400', 18:50:46 INFO - 'USER': 'cltbld', 18:50:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:46 INFO - '_': '/tools/buildbot/bin/python'} 18:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:46 INFO - Running setup.py (path:/tmp/pip-OQ__O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:46 INFO - Running setup.py (path:/tmp/pip-XU6eIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:46 INFO - Running setup.py (path:/tmp/pip-iDnavQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:46 INFO - Running setup.py (path:/tmp/pip-nQeAF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:46 INFO - Running setup.py (path:/tmp/pip-SGXiuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:46 INFO - Running setup.py (path:/tmp/pip-nyFoI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:46 INFO - Running setup.py (path:/tmp/pip-CrviYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:46 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)) 18:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:46 INFO - Running setup.py (path:/tmp/pip-5q1FTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:47 INFO - Running setup.py (path:/tmp/pip-kNLDxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:47 INFO - Running setup.py (path:/tmp/pip-sbcmMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:47 INFO - Running setup.py (path:/tmp/pip-xHqduc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:47 INFO - Running setup.py (path:/tmp/pip-7PBECF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:47 INFO - Running setup.py (path:/tmp/pip-5LghWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:47 INFO - Running setup.py (path:/tmp/pip-sb7FRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:47 INFO - Running setup.py (path:/tmp/pip-qxs7wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:47 INFO - Running setup.py (path:/tmp/pip-1oODOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:47 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)) 18:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:47 INFO - Running setup.py (path:/tmp/pip-9MQmXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:47 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)) 18:50:47 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)) 18:50:47 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)) 18:50:47 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)) 18:50:47 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)) 18:50:47 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)) 18:50:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:50:47 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 18:50:47 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 18:50:47 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 18:50:47 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 18:50:47 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 18:50:47 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 18:50:49 INFO - Downloading blessings-1.6.tar.gz 18:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:50:49 INFO - Installing collected packages: blessings 18:50:49 INFO - Running setup.py install for blessings 18:50:49 INFO - Successfully installed blessings 18:50:49 INFO - Cleaning up... 18:50:49 INFO - Return code: 0 18:50:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:50 INFO - Reading from file tmpfile_stdout 18:50:50 INFO - Current package versions: 18:50:50 INFO - argparse == 1.2.1 18:50:50 INFO - blessings == 1.6 18:50:50 INFO - blobuploader == 1.2.4 18:50:50 INFO - docopt == 0.6.1 18:50:50 INFO - functools32 == 3.2.3-2 18:50:50 INFO - jsonschema == 2.5.1 18:50:50 INFO - manifestparser == 1.1 18:50:50 INFO - mozInstall == 1.12 18:50:50 INFO - mozcrash == 0.17 18:50:50 INFO - mozdebug == 0.1 18:50:50 INFO - mozdevice == 0.48 18:50:50 INFO - mozfile == 1.2 18:50:50 INFO - mozhttpd == 0.7 18:50:50 INFO - mozinfo == 0.9 18:50:50 INFO - mozleak == 0.1 18:50:50 INFO - mozlog == 3.3 18:50:50 INFO - moznetwork == 0.27 18:50:50 INFO - mozprocess == 0.23 18:50:50 INFO - mozprofile == 0.28 18:50:50 INFO - mozrunner == 6.12 18:50:50 INFO - mozscreenshot == 0.1 18:50:50 INFO - mozsystemmonitor == 0.3 18:50:50 INFO - moztest == 0.7 18:50:50 INFO - mozversion == 1.4 18:50:50 INFO - psutil == 3.1.1 18:50:50 INFO - requests == 1.2.3 18:50:50 INFO - wsgiref == 0.1.2 18:50:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:50 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')]} 18:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:50 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')]} 18:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:50 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:50 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 18:50:50 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 18:50:50 INFO - Using env: {'DISPLAY': ':0', 18:50:50 INFO - 'HOME': '/home/cltbld', 18:50:50 INFO - 'LANG': 'en_US.UTF-8', 18:50:50 INFO - 'LANGUAGE': 'en_US:en', 18:50:50 INFO - 'LOGNAME': 'cltbld', 18:50:50 INFO - 'MAIL': '/var/mail/cltbld', 18:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:50 INFO - 'MOZ_NO_REMOTE': '1', 18:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:50 INFO - 'NO_EM_RESTART': '1', 18:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:50 INFO - 'PWD': '/builds/slave/test', 18:50:50 INFO - 'SHELL': '/bin/bash', 18:50:50 INFO - 'SHLVL': '1', 18:50:50 INFO - 'TERM': 'linux', 18:50:50 INFO - 'TMOUT': '86400', 18:50:50 INFO - 'USER': 'cltbld', 18:50:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:50 INFO - '_': '/tools/buildbot/bin/python'} 18:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 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)) 18:50:50 INFO - Cleaning up... 18:50:50 INFO - Return code: 0 18:50:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:50:50 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')]} 18:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:50 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')]} 18:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:50 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 0x7f658a0fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af1850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, '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': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', '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 18:50:50 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 18:50:50 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 18:50:50 INFO - Using env: {'DISPLAY': ':0', 18:50:50 INFO - 'HOME': '/home/cltbld', 18:50:50 INFO - 'LANG': 'en_US.UTF-8', 18:50:50 INFO - 'LANGUAGE': 'en_US:en', 18:50:50 INFO - 'LOGNAME': 'cltbld', 18:50:50 INFO - 'MAIL': '/var/mail/cltbld', 18:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:50 INFO - 'MOZ_NO_REMOTE': '1', 18:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:50 INFO - 'NO_EM_RESTART': '1', 18:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:50 INFO - 'PWD': '/builds/slave/test', 18:50:50 INFO - 'SHELL': '/bin/bash', 18:50:50 INFO - 'SHLVL': '1', 18:50:50 INFO - 'TERM': 'linux', 18:50:50 INFO - 'TMOUT': '86400', 18:50:50 INFO - 'USER': 'cltbld', 18:50:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:50 INFO - '_': '/tools/buildbot/bin/python'} 18:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:50:50 INFO - Cleaning up... 18:50:50 INFO - Return code: 0 18:50:50 INFO - Running post-action listener: _resource_record_post_action 18:50:50 INFO - Running post-action listener: _start_resource_monitoring 18:50:50 INFO - Starting resource monitoring. 18:50:50 INFO - [mozharness: 2016-08-16 01:50:50.565135Z] Finished create-virtualenv step (success) 18:50:50 INFO - [mozharness: 2016-08-16 01:50:50.565594Z] Running install step. 18:50:50 INFO - Running pre-action listener: _resource_record_pre_action 18:50:50 INFO - Running main action method: install 18:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:50 INFO - Reading from file tmpfile_stdout 18:50:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:50:50 INFO - Reading from file tmpfile_stdout 18:50:50 INFO - Output received: 18:50:50 INFO - Usage: mozinstall [options] installer 18:50:50 INFO - Options: 18:50:50 INFO - -h, --help show this help message and exit 18:50:50 INFO - -d DEST, --destination=DEST 18:50:50 INFO - Directory to install application into. [default: 18:50:50 INFO - "/builds/slave/test"] 18:50:50 INFO - --app=APP Application being installed. [default: firefox] 18:50:50 INFO - mkdir: /builds/slave/test/build/application 18:50:50 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'] 18:50:50 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 18:51:07 INFO - Reading from file tmpfile_stdout 18:51:07 INFO - Output received: 18:51:07 INFO - /builds/slave/test/build/application/firefox/firefox 18:51:07 INFO - Running post-action listener: _resource_record_post_action 18:51:07 INFO - [mozharness: 2016-08-16 01:51:07.798971Z] Finished install step (success) 18:51:07 INFO - [mozharness: 2016-08-16 01:51:07.799217Z] Running run-tests step. 18:51:07 INFO - Running pre-action listener: _resource_record_pre_action 18:51:07 INFO - Running main action method: run_tests 18:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:51:07 INFO - Python 2.7.3 18:51:07 INFO - Return code: 0 18:51:07 INFO - grabbing minidump binary from tooltool 18:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:07 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 0x2aec370>, '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 0x2aef8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aefd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:51:07 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 18:51:07 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 18:51:07 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 18:51:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:51:07 INFO - Return code: 0 18:51:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:51:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:51:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:51:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:51:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:51:07 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/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 18:51:07 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/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 18:51:07 INFO - Using env: {'DISPLAY': ':0', 18:51:07 INFO - 'HOME': '/home/cltbld', 18:51:07 INFO - 'LANG': 'en_US.UTF-8', 18:51:07 INFO - 'LANGUAGE': 'en_US:en', 18:51:07 INFO - 'LOGNAME': 'cltbld', 18:51:07 INFO - 'MAIL': '/var/mail/cltbld', 18:51:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:51:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:07 INFO - 'MOZ_NO_REMOTE': '1', 18:51:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:07 INFO - 'NO_EM_RESTART': '1', 18:51:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:07 INFO - 'PWD': '/builds/slave/test', 18:51:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:51:07 INFO - 'SHELL': '/bin/bash', 18:51:07 INFO - 'SHLVL': '1', 18:51:07 INFO - 'TERM': 'linux', 18:51:07 INFO - 'TMOUT': '86400', 18:51:07 INFO - 'USER': 'cltbld', 18:51:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1471312211.475059-582163460', 18:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:07 INFO - '_': '/tools/buildbot/bin/python'} 18:51:07 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/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 18:51:08 INFO - mozversion application_buildid: 20160815143002 18:51:08 INFO - mozversion application_changeset: dbb9da97e0e1c021314baf7de44f82fd4a74058d 18:51:08 INFO - mozversion application_display_name: Nightly 18:51:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:51:08 INFO - mozversion application_name: Firefox 18:51:08 INFO - mozversion application_remotingname: firefox 18:51:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:51:08 INFO - mozversion application_vendor: Mozilla 18:51:08 INFO - mozversion application_version: 51.0a1 18:51:08 INFO - mozversion platform_buildid: 20160815143002 18:51:08 INFO - mozversion platform_changeset: dbb9da97e0e1c021314baf7de44f82fd4a74058d 18:51:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:51:08 INFO - mozversion platform_version: 51.0a1 18:51:08 INFO - using testdate: 1471312268 18:51:08 INFO - actual date: 1471312268 18:51:08 INFO - starting webserver on 'localhost:52096' 18:51:08 INFO - SUITE-START | Running 2 tests 18:51:08 INFO - TEST-START | dromaeo_css 18:51:08 INFO - operating with platform_type : linux_ 18:51:08 INFO - Initialising browser for dromaeo_css test... 18:51:08 INFO - TEST-INFO | started process 29694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQOYy2/profile http://localhost:52096/getInfo.html) 18:51:12 INFO - PROCESS | 29694 | __metrics Screen width/height:1600/1200 18:51:12 INFO - PROCESS | 29694 | colorDepth:24 18:51:12 INFO - PROCESS | 29694 | Browser inner width/height: 1024/697 18:51:12 INFO - PROCESS | 29694 | __metrics 18:51:12 INFO - PROCESS | 29694 | 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" 18:51:12 INFO - PROCESS | 29694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:51:13 INFO - PROCESS | 29694 | console.error: PushService: 18:51:13 INFO - PROCESS | 29694 | stateChangeProcessEnqueue: Error transitioning state 18:51:13 INFO - PROCESS | 29694 | UnknownError 18:51:13 INFO - TEST-INFO | 29694: exit 0 18:51:13 INFO - Browser initialized. 18:51:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:51:13 INFO - TEST-INFO | started process 29776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQOYy2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:25 INFO - PROCESS | 29776 | RSS: Main: 161132544 18:51:25 INFO - PROCESS | 29776 | 18:52:16 INFO - PROCESS | 29776 | 1471312336659 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] 18:54:26 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52096/tests/dromaeo/cssquery-ext.html) 18:54:27 INFO - PROCESS | 29776 | RSS: Main: 278577152 18:54:27 INFO - PROCESS | 29776 | 18:57:30 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-ext.html (next: http://localhost:52096/tests/dromaeo/cssquery-jquery.html) 18:57:30 INFO - PROCESS | 29776 | RSS: Main: 246898688 18:57:30 INFO - PROCESS | 29776 | 19:00:32 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52096/tests/dromaeo/cssquery-mootools.html) 19:00:33 INFO - PROCESS | 29776 | RSS: Main: 228577280 19:00:33 INFO - PROCESS | 29776 | 19:03:35 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52096/tests/dromaeo/cssquery-prototype.html) 19:03:36 INFO - PROCESS | 29776 | RSS: Main: 183865344 19:03:36 INFO - PROCESS | 29776 | 19:06:38 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52096/tests/dromaeo/cssquery-yui.html) 19:06:39 INFO - PROCESS | 29776 | RSS: Main: 186572800 19:06:39 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-yui.html (next: http://localhost:52096/tests/dromaeo/cssquery-dojo.html) 19:09:42 INFO - PROCESS | 29776 | RSS: Main: 271695872 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | __start_tp_report 19:09:42 INFO - PROCESS | 29776 | _x_x_mozilla_page_load 19:09:42 INFO - PROCESS | 29776 | _x_x_mozilla_page_load_details 19:09:42 INFO - PROCESS | 29776 | |i|pagename|runs| 19:09:42 INFO - PROCESS | 29776 | |0;dojo.html;2967.9851600741995;2996.235959830243;3012.6987301269874;3018.607581014468;3029.1064136079867;5048.116579598564;5150.3047088643025;5164.741762911854;5226.137687281599;5328.04095262853;5144.845654630358;5162.974185129078;5170.9224361634515;5271.841844744654;5318.2554442378005;4719.339292499053;4757.524247575249;4787.736674482902;4797.688150270221;4914.508549145093;4820.445648750404;4852.660313778037;4860.878478038059;4867.537583929521;4918.385201849769;4664.5335466453425;4685.2972054191805;4705.1530724469585;4745.976270118645;4772.42730872294;4742.668013239075;4772.451168115676;4773.64197685175;4777.474477807438;4784.258439941815;4663.044075964453;4711.387519622462;4725.740084295362;4745.240761478181;4747.786349614275;5123.077845987721;5164;5167.689938603658;5176.534111929945;5181.715005674687;5629.57778166635;5629.746661400206;5630.183623374629;5634.521065709419;5637.295338082739;5449.291592093003;5453.045716999509;5467.316585426822;5497.47773961477;5650;5198.792048318101;5202.401723801773;5213.791448342062;5218.895622087575;5220.034293655686;5674.0637794764225;5687.51656109227;5699.686517241508;5701.0308247598;5711.228984087178;5349.919751203735;5350.036993341236;5375.086235340002;5400.135978243462;5416.2688037114485;5497.422770609109;5525.475079867406;5568.164775283659;5568.888622227532;5585.888282234332;5561.6663000220115;5572.888542229132;5573.164025396223;5576.358718747396;5581.2186293918885;5408.729563521808;5471.835844924659;5507.449255074541;5509.504144626922;5607.607467477319;4281.828726850891;4300.3549467580115;4302.698811083257;4304.655627549789;4337.436133302651;3836.8081595920094;3850.9229815403537;3866.304065268279;3874.2832575973534;3887.9028024299055;5171.612129090333;5217.660852044605;5223.634345595848;5292.100342941709;5297.337832770903;5638.013347664142;5642;5643.153526970905;5646.520045796071;5651.26533550644;5301.443348448434;5307.442718514578;5314.867128321823;5316.76074576645;5320.17537281722;4707.552782485658;4770.0936822004405;4788.664793464493;4797.592204662573;4837.927431088537;5803.390643982406;5806.941930580809;5825.94174058254;5832.854178645568;5838.795642152504;5604.103343465026;5618.269624948731;5619.269494965628;5623;5635.549156067423;5620.662760234399;5729.4843464088435;5736.397678243724;5748.856278593069;5775.162601422686;5457.808976685797;5476.205950137128;5486.094794358886;5488.753006114654;5511.559075274049;5580.35825880029;5590.692511911721;5594.188842617717;5602.327720673546;5613.186088017296;5354.143337066051;5356.892862142658;5389.757460914347;5400.2439658447065;5475.5072043516275;5425.864353391197;5434.3207099112615;5436.646617969819;5438.184272359178;5458.072127738374;5344.25180474726;5348.866278343073;5359.276497672764;5361.415989329067;5373.382061062872;4908.582770464551;5304.124819404755;5325.440828713085;5351.785928562969;5507.531859791962;5347.465253474621;5355.4376790438;5365.195220716768;5376.489233522809;5390.27231323782 19:09:42 INFO - PROCESS | 29776 | |1;ext.html;566.2497191221632;592.283337162034;599.206051981125;602.3765402808094;617.5029101573233;42258.36612450812;43382;43713.12573748527;47086.764566177204;47376.28935565969;45686;46105.53894461055;46175.76912115443;46214.07571848561;46216;8879.51162686052;8990.68532601359;9019.09809019096;9031.367804253705;9032.68385606504;8801.987771406306;8886.688965886195;8896;8905.643774249054;8920.197182253596;8914.55427228636;8922.553872306391;8924.55377231139;8930.151635594608;8943.865842012376;8764.1674040966;8770.035296117421;8840.071792461764;8840.911590884074;8847.823043539125;8912.821743565093;8988.460692358414;8992.46045237288;8992.910070899272;8994.460332380013;42509.78745106285;42728.35907461391;42873.35689964653;42932.78533607343;42957.57042429567;3560.072479321926;3754.9812250938844;3896.532416110085;4043.8971734697793;4143.1713657268665;32546.83726581352;32811.50782738261;33044.83477582621;33117.33765324704;34879.651203488145;4338.327559228324;4400.911981760347;4535.659825513099;4598.011427543094;4631.490536041033;374793;375439;375812;376846;377626.99999999726;58898.70550647305;58958.41041589529;58995.70502147548;59225.703871480364;59359;62717.37282627207;62718.68640656859;62754.37245627576;62822;62889.4532656075;17054.74417883733;17296.3568460996;17297.91351043237;17320.393786217675;17327.91336043312;13206.669833254053;13241;13247.470101196037;13269.137506062076;13296.933515332361;16781.783544155118;18562.907185464257;18637.254509819457;18675.906620466812;18914.621707566046;6869.553479023847;6919.7232110715;6936.167659880846;7105.182903966007;7151.3563779259075;710.193335613196;976.0629795396499;1019.4036488654073;1033.3593172233113;1071.5445935477546;33139;33330.333393331995;33768.1557961053;33873.66126338754;33938.49092263618;1121.383239218443;1128.7460321427777;1143.2968724234536;1166.7199872030822;1169.4620474581789;16798.748018779726;16943.068131252654;17520.912395437943;17562.841856711744;17672.646547068987;583783.3784128312;860585;876634;876972;877582;58929;59570.70214648986;59665.70167149136;59718;59763.701181493816;1240.4170040081146;1321.8545959944206;1354.8170996915487;1368.6509939965244;1383.9238841863594;29971;33801.15497112493;34112.82943585266;34328.885967140406;34531;50590.2411463821;51166.74416628042;51364.22953655773;51396.48603514067;51406.48593514017;443718;444780;446686;447059;447753;28621.570676440286;29445.26386840346;29535.409291814474;29594.408111838075;29662.703372965992;47462;48280.43845950487;48597.43934568788;48784;49395.7892736971;39201.607983920934;41110.794446027576;41187.794061029505;41811;42161;40334.39498407467;40950.59049409587;41321.79339103285;41422.58577414308;41994.58005419907;40440;41247;42516.5748342525;42704.57295427006;42829.78585107055;33079.33841323112;36483.27033459369;36699.60169664356;36910.63089369072;36974.445383318736;28063;28117.43765124727;28209.71790282071;28365.71634283713;28465 19:09:42 INFO - PROCESS | 29776 | |2;jquery.html;368.19365589359285;390.84756944791536;404.4721638262068;409.2367734175762;420.8442876135828;16576.751348729762;19640.705389419152;19708.802911970877;19956;20844.583108337825;19502.804971950278;19963.301284455047;20207.797922020774;20247.797522024775;20345.186192552315;5118.9488105119035;5572.4706152915405;5751;5786.942130578683;5807.767689292445;5703.458171473724;5717.828465146053;5728.283964504437;5743.13852922063;5750.683712395817;5499.285092937913;5596.0206963781175;5646.943530564703;5666.065099258638;5714.51426628737;5583.106702927533;5625.156226566007;5632.930672006605;5655.745491452894;5697.943020569783;4989.875253118665;5087.389513258433;5116.232565115262;5118.232265160219;5119.56483698886;24053.917573709226;24711.5057698845;24781;24847.25458236256;24913.377165571004;2300.7814257645496;2425.7938075263623;2518.3704073981503;2722.074494671821;3146.2134466383404;14805.407783688639;15908.443204487903;16055.438059667855;16232.83767162325;16461.917690411592;2027.9695804562944;2044.366246463601;2059.8970051497513;2104.4002459299027;2170.4031391367344;89083;95915;97141;98432.50783746107;99054;17678.823211767718;17739.911300443415;17995.820041799678;18159.182836772376;18517;31919;31992.840035800138;32053.679463205535;32075.990501187352;32121.51817722736;9960.551775170135;10206.234532410099;10336.725920297673;10398.636047738293;10665.466726663635;8659.350548708871;8702.564871756387;8719.956400217958;8992.955035224782;9009.414388064886;8711.738647840575;9067.91185057784;9114.726558203265;9160.496172710431;9261.120193581599;3239.9838000809846;3312.4700047992205;3337.632860385356;3429.811360375203;3470.16715988161;933.8365785987424;991.940483570988;1046.9057784799252;1089.9182561307775;1095.9671209863716;18280.360187393377;18973.335933242546;20035.198592056448;20381.18475260973;20826.895865520877;968.7820240445843;993.8409854423257;1035.5443604813859;1035.9792804143874;1061.2465149743614;10399.968018549223;11367.431628418546;11381.772364552662;11503.827442588368;11543.134264930164;505323;512567;513453;518862;529539;93146.53426732958;94407.52796235975;95556;97490;98082;979.7060881735451;995.5669283861398;1048.905598496139;1051.8369652703843;1056.12869382758;17900.820991790435;18212.18045187943;18910.810891890906;18992.62014759725;19081.713774293676;43744.78127609342;44422.55577444184;44977;45460;45574;60311.396886030576;60410;60505;62701.372986269555;62752.68623656852;8693.695720649746;8707.521086340312;8750.781230469289;8797.956010219908;8906.376553641183;12223.572174973833;12797.552085676956;13303.334833258104;13509.054366194272;13867.375968081258;10449.68650940473;10866.619668311887;11204.943975280072;11330.773384532427;11376;11064.944675276573;11485.540578376771;11498.712532186428;11631.243969141979;11951.22317049389;11063.668089957315;11189.944050279697;11205.159613028893;11285.266457680225;11777;8682.218600326001;9024.81950360976;9032.23226025769;9068.047854975133;9352.719418417186;9628.614855405986;10784.352938823695;10798.352098874093;10854.620088296871;11317.264377815745 19:09:42 INFO - PROCESS | 29776 | |3;mootools.html;1328.1433475408369;1480.3338497676045;1502.9473968411107;1618.198991499208;1766.6643337765831;7590.544567325957;7831.569263690495;7946.801329966754;8114.39142064346;8119.837603247946;7973;8042.075161356446;8048.396370272224;8066.878996815052;8073.4348595598185;1963.1362200631677;2216.4791274050585;2285.1544928376484;2298.3449716830705;2303.6199027160496;2291.873946932918;2312.502811895442;2312.6877871487386;2315.409570559505;2316.3282648032136;2190.3647942096773;2248.2243625949022;2255.4023183856293;2259.344790010903;2283.406314358262;2112.6514125169483;2192.78072192781;2197.7692342304067;2199.296225207934;2214.081156320125;2239.6528538076623;2256.4697296135396;2257.097161135559;2259.2770313499686;2260.9095636174534;8380.413371064027;8427.494350338999;8460.407771456;8460.407771456;8465.153484651548;4973.104841128596;5131.589472842164;5139.897202055975;5143.408508021588;5148.6910785353;3109.5646609474693;3129;3271.492918597621;3284.293876816472;3286.1784553861535;1147.994260028703;1156.6876943225366;1174.2308787744041;1192.9701757456046;1195.7010747313172;10793.136549076133;10824.512896919658;10849.837252441219;10950.561977520889;10989.175811814146;4221.472315960505;4261.765602891871;4429.778511074498;4439.955600443955;4459.509453960061;8769.38614296993;8790.296776257885;8798.384113112148;8812.250958668457;8815;5022.773975171126;5083.313752643346;5083.644144909821;5087.211482220262;5089.389273287229;4077.082656402345;4635.351050852883;4713.858584242478;4806.687565308243;4818.759062046884;3610.29599228148;3681.392570225936;3771.7925514096987;3793.4878791363367;3823.330917089498;1149.3046706742468;1149.3105135450874;1155.2375432214699;1155.5031336525374;1171.4904016752569;881.7971866470748;896.4128495835238;914.9935071421384;916.2120576304372;951.1297163095828;5447.645903016291;5469.206964990134;5499.48588941134;5619.522340601013;5784.50831679312;481.7398604753464;482.4765129834099;484.04642853578395;487.16208122030054;497.4826180772029;4011.157656892027;4019.8593049243723;4037.6366127048705;4056.79716014204;4088.1823635273063;9483.620655173716;9720.125188733047;9756.756081098029;9777.511124443892;9778.902210977942;9664.420134791935;9681.177099946442;9685.612575496902;9697.224222062217;9723.513824308757;7418.109826820816;7460.962695186598;7489.063867016623;7493.175750667422;7523.66766302448;5671.971640141773;5809.331926828469;5917.372722501174;5982.641041537521;6299.401556852092;9129.863052054092;9268.629254829732;9395.06049395055;9411.952940235255;9454.196393306645;9440.386374885611;9606.615735370508;9626.807463850824;9652.27607929422;9661.082197191256;6447.806565803034;7097.112860892388;7206.4595155364605;7285.162206346338;7413.369863561657;7929.048514178336;8010;8073.7577872663915;8097.595120244082;8101.35189184852;7092.716291348288;7193.172785129777;7211.819704507429;7263.564186148848;7350.448716346403;7128.108986376703;7238.855222895618;7267.491275610868;7272.527285726411;7299.890501642586;6265.874682506415;6404.135441715309;6470.935290647221;6550.279469258282;6558.934410656023;4893.951060489349;5026.095302845523;5061.9493805061475;5111.3355263815465;5148.2020286855595;5032.698038117578;5108.131617625087;5166.184429485864;5254.579633629224;5265.921011184759 19:09:42 INFO - PROCESS | 29776 | |4;prototype.html;330.52239513902407;333.4548013997114;340.14792943676093;345.5766685809883;346.23309369746005;5179.378474583051;5182.352205974254;5200.505951934565;5205.401378841425;5243.737813109348;5149.948500514994;5183.455737147602;5192.182736042383;5258.526732594066;5260.868478288045;3685.926281474369;3886.689064874817;3925.509311336083;4034.5158580970324;4050.088730035733;4055.797210139481;4104.733192342503;4112.342025275956;4122;4142.772147531885;4059.817308221137;4072.409500622423;4084.7344922579937;4084.7957602119923;4091.6293041831022;3880.3985382265796;3988.700847436454;4077.2660921034203;4090.4886889138857;4102.2410853992105;3617.439296908983;3622.474741162543;3634.8909532713797;3635.6909662678704;3654.4701018352457;5072.2391641253735;5088.643794934356;5120.436751957282;5124.871878203037;5146.459621739701;4640.396748422717;4681.555252251031;4684.250519916797;4684.320773487825;4725.527447255281;5404.4595540446035;5443.292371991655;5461.453854614507;5467.617266791326;5479.589030822704;3833.50164478616;3852.768833869977;3891.5330160380654;3955.6835453163676;4031.9193616127513;5574.832755017356;5589.65848196434;5593.216949627055;5621.184928185431;5622.943770562283;4111.753294802322;4120.896977575525;4147.875563733093;4150.252954468165;4154.439150714615;3914.3149948758855;4086.978255436141;4106.527749308868;4130.834766609302;4207.789610519523;4638.582527572467;4656.394668693116;4657.930131048037;4665.570805457985;4676.111538807616;5450.591205659592;5471.37079235885;5484.2596249506605;5486.286782718221;5538.833834984957;1368.945242190321;1395.448797724893;1397.5046700030869;1402.4039783092146;1403.7824137258742;871.6600525794945;909.2226146644656;915.5468043318467;918.0956757593765;926.8053708721109;4639.466461356919;4666;4694.3427920090535;4703.670743048022;4711.717296962193;4972.8508144755715;4989.63614114828;5007.9499205008215;5018.874528136826;5020.59835213182;4512.887177820581;4733.715977041388;4735.810567577328;4745.7423782697615;4769.809207631725;2602.5445547029194;2609.908653197129;2612.908548200804;2622.7508386703234;2628.6451329070715;5041.395032596112;5063.696178229318;5073.543381095719;5128.948710512847;5130.178786530802;4844.781984810692;5014.84955451337;5027.899442011139;5031;5072.21028434367;5009.872778624853;5015.673981191211;5062.797877761449;5080.237964305384;5089.389273287229;4890.657653964188;4930.408350997904;4969.850904472872;5347.839564813062;5360.3299587551555;5499.560035197094;5525.557955363481;5551.084071128219;5554.222408862682;5576.944230557642;5766.250387449605;5782.2194003808945;5788.392218816964;5793.739281732416;5800.216970708901;3903.9159064339988;3917.5103112110987;3940.960590394059;3944.84220631183;3949.466821978996;5553.666779993213;5583.2462617547735;5588.848293407149;5609.158626206102;5623.718814059199;5515.917261241165;5516.255305533701;5521.365043019943;5530.695811730394;5532.75923251084;5161.896762064813;5411.512963833274;5466.207399927068;5467.480589344006;5490.890182196254;5404.702741349263;5422.674639521641;5434;5437.722135298122;5483.024807014882;5384;5506.504414602545;5556.277683901067;5567.610267281251;5574.609777315712;5288.8413347599635;5304.32131773452;5306.389765176899;5334.893302133858;5341.225522299167 19:09:42 INFO - PROCESS | 29776 | |5;yui.html;783.4711569690458;813.8819871118687;819.2544784246329;823.9134890836463;836;13665.385057672403;14233.857661423383;14245.786313205284;14326.641833954143;14330.355134018968;14399.78400323996;14421.927890360534;14471.78292325616;14493.202873841961;14537.200453975027;807.390420232725;814.775936617429;815.4903185509057;815.7919730468723;816.7590560784553;664.717495064598;785.2226295967008;815.1033862750986;815.7552734179752;820.9302209312216;858.2790456016944;859.7162936231028;860.9655613775442;863.8704194370863;865.3466632692308;854.2695994924344;855.0295414704324;857.5069335132292;857.5969294431669;858.9055203927563;507.41647105828224;608.5770389579244;623.0716232813121;623.9251289845203;630.4515071887441;13989.160650361011;14024.509142179975;14051.718965620732;14076.2961851907;14083.788743168861;13854.653633659138;14742.631434214123;14769.187694676788;14839;14955.775663365059;13057.673558161026;13162.341882905912;13278;13666.52167174144;13935.930320348434;4350.8042138103865;4383.978080109579;4436.290193569046;4482.036362182114;4612.077584483083;81871.590642047;82682;82703.5864820672;83164.58417707933;89531.99999999935;11176.217664763552;11312.830307545393;11317.83023254652;11419.543218271343;11596.76806463866;21319.573608527742;21529.13883444676;21578.244761433274;21611.243606473698;21620.45948851291;8441.620127094173;8638.265747411415;8860.291176705849;8937.865932011026;8938.553072346356;4683.601893838993;4717.8112875485285;4730;4933.45731969483;5059.316992206079;3307.966920330814;3349.8777909400624;3373.139849338403;3386.3227354529195;3386.762926595164;579.2469789273927;592.4283066840519;599.6551982610017;609.1471939285036;611.3122736920964;663.4460225711584;683.9110915580943;685.7771224352106;695.1831597872581;709.6203531110934;8978.191962723386;9047.276217902552;9060.275177985744;9278.164965153033;9352.018038106036;529.3277537527396;578.23672751967;665.9134312539339;667.1993607670718;674.9257581666013;4322.740635561876;4355.368471571668;4548.363229147922;4581.702189357748;4632.907341853144;73371.26628733751;95677.52161239149;105705;127238;133016.68883178083;109473.45263273633;110054.44972775085;110825;111933.44033279782;112161.1959701014;94684.52657736804;95496.10802541568;97031.51484242534;99499;102850;8426.536540490331;8472.534010629475;8582;8750.956245218733;8930.330225233003;56275.71862140663;56385;57177.71411142917;57476;57794.42205578059;50165;61261.38738612735;75674;76675.61662191653;77455;10889.455527223448;11747.554881001535;11755;11807.82288265694;11971.940140299592;13332.733345333232;13420.328983550979;13477.326133693472;13690.110142841082;13955.790663139858;12607.243565386107;12910.741785164431;13123.934380328037;13196.802047969097;13275.800862987257;11255.549778008788;14070.929645351707;14309.284535773379;14615.926920365755;15071.4724984625;14019.719605607626;14037.649058773612;14149.575512734635;14221.928890355483;14233.217173055167;10817.955112219452;11128.888711112786;11633.941830290794;11886.108541859223;12046.819297710366;11196.66410007701;11995.460204290654;12202.407712672819;12360.44378002974;12471.688207794878 19:09:42 INFO - PROCESS | 29776 | __end_tp_report 19:09:42 INFO - PROCESS | 29776 | __start_cc_report 19:09:42 INFO - PROCESS | 29776 | _x_x_mozilla_cycle_collect,1109 19:09:42 INFO - PROCESS | 29776 | __end_cc_report 19:09:42 INFO - PROCESS | 29776 | __startTimestamp1471313382726__endTimestamp 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | ------- Summary: start ------- 19:09:42 INFO - PROCESS | 29776 | Number of tests: 6 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | [#0] dojo.html Cycles:165 Average:5172.66 Median:5350.04 stddev:576.94 (10.8%) stddev-sans-first:552.17 19:09:42 INFO - PROCESS | 29776 | Values: 2968.0 2996.2 3012.7 3018.6 3029.1 5048.1 5150.3 5164.7 5226.1 5328.0 5144.8 5163.0 5170.9 5271.8 5318.3 4719.3 4757.5 4787.7 4797.7 4914.5 4820.4 4852.7 4860.9 4867.5 4918.4 4664.5 4685.3 4705.2 4746.0 4772.4 4742.7 4772.5 4773.6 4777.5 4784.3 4663.0 4711.4 4725.7 4745.2 4747.8 5123.1 5164.0 5167.7 5176.5 5181.7 5629.6 5629.7 5630.2 5634.5 5637.3 5449.3 5453.0 5467.3 5497.5 5650.0 5198.8 5202.4 5213.8 5218.9 5220.0 5674.1 5687.5 5699.7 5701.0 5711.2 5349.9 5350.0 5375.1 5400.1 5416.3 5497.4 5525.5 5568.2 5568.9 5585.9 5561.7 5572.9 5573.2 5576.4 5581.2 5408.7 5471.8 5507.4 5509.5 5607.6 4281.8 4300.4 4302.7 4304.7 4337.4 3836.8 3850.9 3866.3 3874.3 3887.9 5171.6 5217.7 5223.6 5292.1 5297.3 5638.0 5642.0 5643.2 5646.5 5651.3 5301.4 5307.4 5314.9 5316.8 5320.2 4707.6 4770.1 4788.7 4797.6 4837.9 5803.4 5806.9 5825.9 5832.9 5838.8 5604.1 5618.3 5619.3 5623.0 5635.5 5620.7 5729.5 5736.4 5748.9 5775.2 5457.8 5476.2 5486.1 5488.8 5511.6 5580.4 5590.7 5594.2 5602.3 5613.2 5354.1 5356.9 5389.8 5400.2 5475.5 5425.9 5434.3 5436.6 5438.2 5458.1 5344.3 5348.9 5359.3 5361.4 5373.4 4908.6 5304.1 5325.4 5351.8 5507.5 5347.5 5355.4 5365.2 5376.5 5390.3 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | [#1] ext.html Cycles:180 Average:69450.10 Median:42851.57 stddev:156741.34 (365.8%) stddev-sans-first:157095.72 19:09:42 INFO - PROCESS | 29776 | Values: 566.2 592.3 599.2 602.4 617.5 42258.4 43382.0 43713.1 47086.8 47376.3 45686.0 46105.5 46175.8 46214.1 46216.0 8879.5 8990.7 9019.1 9031.4 9032.7 8802.0 8886.7 8896.0 8905.6 8920.2 8914.6 8922.6 8924.6 8930.2 8943.9 8764.2 8770.0 8840.1 8840.9 8847.8 8912.8 8988.5 8992.5 8992.9 8994.5 42509.8 42728.4 42873.4 42932.8 42957.6 3560.1 3755.0 3896.5 4043.9 4143.2 32546.8 32811.5 33044.8 33117.3 34879.7 4338.3 4400.9 4535.7 4598.0 4631.5 374793.0 375439.0 375812.0 376846.0 377627.0 58898.7 58958.4 58995.7 59225.7 59359.0 62717.4 62718.7 62754.4 62822.0 62889.5 17054.7 17296.4 17297.9 17320.4 17327.9 13206.7 13241.0 13247.5 13269.1 13296.9 16781.8 18562.9 18637.3 18675.9 18914.6 6869.6 6919.7 6936.2 7105.2 7151.4 710.2 976.1 1019.4 1033.4 1071.5 33139.0 33330.3 33768.2 33873.7 33938.5 1121.4 1128.7 1143.3 1166.7 1169.5 16798.7 16943.1 17520.9 17562.8 17672.6 583783.4 860585.0 876634.0 876972.0 877582.0 58929.0 59570.7 59665.7 59718.0 59763.7 1240.4 1321.9 1354.8 1368.7 1383.9 29971.0 33801.2 34112.8 34328.9 34531.0 50590.2 51166.7 51364.2 51396.5 51406.5 443718.0 444780.0 446686.0 447059.0 447753.0 28621.6 29445.3 29535.4 29594.4 29662.7 47462.0 48280.4 48597.4 48784.0 49395.8 39201.6 41110.8 41187.8 41811.0 42161.0 40334.4 40950.6 41321.8 41422.6 41994.6 40440.0 41247.0 42516.6 42704.6 42829.8 33079.3 36483.3 36699.6 36910.6 36974.4 28063.0 28117.4 28209.7 28365.7 28465.0 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | [#2] jquery.html Cycles:180 Average:31562.72 Median:32098.75 stddev:85169.84 (265.3%) stddev-sans-first:85376.55 19:09:42 INFO - PROCESS | 29776 | Values: 368.2 390.8 404.5 409.2 420.8 16576.8 19640.7 19708.8 19956.0 20844.6 19502.8 19963.3 20207.8 20247.8 20345.2 5118.9 5572.5 5751.0 5786.9 5807.8 5703.5 5717.8 5728.3 5743.1 5750.7 5499.3 5596.0 5646.9 5666.1 5714.5 5583.1 5625.2 5632.9 5655.7 5697.9 4989.9 5087.4 5116.2 5118.2 5119.6 24053.9 24711.5 24781.0 24847.3 24913.4 2300.8 2425.8 2518.4 2722.1 3146.2 14805.4 15908.4 16055.4 16232.8 16461.9 2028.0 2044.4 2059.9 2104.4 2170.4 89083.0 95915.0 97141.0 98432.5 99054.0 17678.8 17739.9 17995.8 18159.2 18517.0 31919.0 31992.8 32053.7 32076.0 32121.5 9960.6 10206.2 10336.7 10398.6 10665.5 8659.4 8702.6 8720.0 8993.0 9009.4 8711.7 9067.9 9114.7 9160.5 9261.1 3240.0 3312.5 3337.6 3429.8 3470.2 933.8 991.9 1046.9 1089.9 1096.0 18280.4 18973.3 20035.2 20381.2 20826.9 968.8 993.8 1035.5 1036.0 1061.2 10400.0 11367.4 11381.8 11503.8 11543.1 505323.0 512567.0 513453.0 518862.0 529539.0 93146.5 94407.5 95556.0 97490.0 98082.0 979.7 995.6 1048.9 1051.8 1056.1 17900.8 18212.2 18910.8 18992.6 19081.7 43744.8 44422.6 44977.0 45460.0 45574.0 60311.4 60410.0 60505.0 62701.4 62752.7 8693.7 8707.5 8750.8 8798.0 8906.4 12223.6 12797.6 13303.3 13509.1 13867.4 10449.7 10866.6 11204.9 11330.8 11376.0 11064.9 11485.5 11498.7 11631.2 11951.2 11063.7 11189.9 11205.2 11285.3 11777.0 8682.2 9024.8 9032.2 9068.0 9352.7 9628.6 10784.4 10798.4 10854.6 11317.3 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | [#3] mootools.html Cycles:180 Average:5396.20 Median:5148.45 stddev:2958.15 (57.5%) stddev-sans-first:2950.64 19:09:42 INFO - PROCESS | 29776 | Values: 1328.1 1480.3 1502.9 1618.2 1766.7 7590.5 7831.6 7946.8 8114.4 8119.8 7973.0 8042.1 8048.4 8066.9 8073.4 1963.1 2216.5 2285.2 2298.3 2303.6 2291.9 2312.5 2312.7 2315.4 2316.3 2190.4 2248.2 2255.4 2259.3 2283.4 2112.7 2192.8 2197.8 2199.3 2214.1 2239.7 2256.5 2257.1 2259.3 2260.9 8380.4 8427.5 8460.4 8460.4 8465.2 4973.1 5131.6 5139.9 5143.4 5148.7 3109.6 3129.0 3271.5 3284.3 3286.2 1148.0 1156.7 1174.2 1193.0 1195.7 10793.1 10824.5 10849.8 10950.6 10989.2 4221.5 4261.8 4429.8 4440.0 4459.5 8769.4 8790.3 8798.4 8812.3 8815.0 5022.8 5083.3 5083.6 5087.2 5089.4 4077.1 4635.4 4713.9 4806.7 4818.8 3610.3 3681.4 3771.8 3793.5 3823.3 1149.3 1149.3 1155.2 1155.5 1171.5 881.8 896.4 915.0 916.2 951.1 5447.6 5469.2 5499.5 5619.5 5784.5 481.7 482.5 484.0 487.2 497.5 4011.2 4019.9 4037.6 4056.8 4088.2 9483.6 9720.1 9756.8 9777.5 9778.9 9664.4 9681.2 9685.6 9697.2 9723.5 7418.1 7461.0 7489.1 7493.2 7523.7 5672.0 5809.3 5917.4 5982.6 6299.4 9129.9 9268.6 9395.1 9412.0 9454.2 9440.4 9606.6 9626.8 9652.3 9661.1 6447.8 7097.1 7206.5 7285.2 7413.4 7929.0 8010.0 8073.8 8097.6 8101.4 7092.7 7193.2 7211.8 7263.6 7350.4 7128.1 7238.9 7267.5 7272.5 7299.9 6265.9 6404.1 6470.9 6550.3 6558.9 4894.0 5026.1 5061.9 5111.3 5148.2 5032.7 5108.1 5166.2 5254.6 5265.9 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | [#4] prototype.html Cycles:180 Average:4478.50 Median:5019.74 stddev:1301.14 (25.9%) stddev-sans-first:1266.99 19:09:42 INFO - PROCESS | 29776 | Values: 330.5 333.5 340.1 345.6 346.2 5179.4 5182.4 5200.5 5205.4 5243.7 5149.9 5183.5 5192.2 5258.5 5260.9 3685.9 3886.7 3925.5 4034.5 4050.1 4055.8 4104.7 4112.3 4122.0 4142.8 4059.8 4072.4 4084.7 4084.8 4091.6 3880.4 3988.7 4077.3 4090.5 4102.2 3617.4 3622.5 3634.9 3635.7 3654.5 5072.2 5088.6 5120.4 5124.9 5146.5 4640.4 4681.6 4684.3 4684.3 4725.5 5404.5 5443.3 5461.5 5467.6 5479.6 3833.5 3852.8 3891.5 3955.7 4031.9 5574.8 5589.7 5593.2 5621.2 5622.9 4111.8 4120.9 4147.9 4150.3 4154.4 3914.3 4087.0 4106.5 4130.8 4207.8 4638.6 4656.4 4657.9 4665.6 4676.1 5450.6 5471.4 5484.3 5486.3 5538.8 1368.9 1395.4 1397.5 1402.4 1403.8 871.7 909.2 915.5 918.1 926.8 4639.5 4666.0 4694.3 4703.7 4711.7 4972.9 4989.6 5007.9 5018.9 5020.6 4512.9 4733.7 4735.8 4745.7 4769.8 2602.5 2609.9 2612.9 2622.8 2628.6 5041.4 5063.7 5073.5 5128.9 5130.2 4844.8 5014.8 5027.9 5031.0 5072.2 5009.9 5015.7 5062.8 5080.2 5089.4 4890.7 4930.4 4969.9 5347.8 5360.3 5499.6 5525.6 5551.1 5554.2 5576.9 5766.3 5782.2 5788.4 5793.7 5800.2 3903.9 3917.5 3941.0 3944.8 3949.5 5553.7 5583.2 5588.8 5609.2 5623.7 5515.9 5516.3 5521.4 5530.7 5532.8 5161.9 5411.5 5466.2 5467.5 5490.9 5404.7 5422.7 5434.0 5437.7 5483.0 5384.0 5506.5 5556.3 5567.6 5574.6 5288.8 5304.3 5306.4 5334.9 5341.2 19:09:42 INFO - PROCESS | 29776 | 19:09:42 INFO - PROCESS | 29776 | [#5] yui.html Cycles:180 Average:21354.46 Median:4565.03 stddev:31514.19 (690.3%) stddev-sans-first:31564.75 19:09:42 INFO - PROCESS | 29776 | Values: 783.5 813.9 819.3 823.9 836.0 13665.4 14233.9 14245.8 14326.6 14330.4 14399.8 14421.9 14471.8 14493.2 14537.2 807.4 814.8 815.5 815.8 816.8 664.7 785.2 815.1 815.8 820.9 858.3 859.7 861.0 863.9 865.3 854.3 855.0 857.5 857.6 858.9 507.4 608.6 623.1 623.9 630.5 13989.2 14024.5 14051.7 14076.3 14083.8 13854.7 14742.6 14769.2 14839.0 14955.8 13057.7 13162.3 13278.0 13666.5 13935.9 4350.8 4384.0 4436.3 4482.0 4612.1 81871.6 82682.0 82703.6 83164.6 89532.0 11176.2 11312.8 11317.8 11419.5 11596.8 21319.6 21529.1 21578.2 21611.2 21620.5 8441.6 8638.3 8860.3 8937.9 8938.6 4683.6 4717.8 4730.0 4933.5 5059.3 3308.0 3349.9 3373.1 3386.3 3386.8 579.2 592.4 599.7 609.1 611.3 663.4 683.9 685.8 695.2 709.6 8978.2 9047.3 9060.3 9278.2 9352.0 529.3 578.2 665.9 667.2 674.9 4322.7 4355.4 4548.4 4581.7 4632.9 73371.3 95677.5 105705.0 127238.0 133016.7 109473.5 110054.4 110825.0 111933.4 112161.2 94684.5 95496.1 97031.5 99499.0 102850.0 8426.5 8472.5 8582.0 8751.0 8930.3 56275.7 56385.0 57177.7 57476.0 57794.4 50165.0 61261.4 75674.0 76675.6 77455.0 10889.5 11747.6 11755.0 11807.8 11971.9 13332.7 13420.3 13477.3 13690.1 13955.8 12607.2 12910.7 13123.9 13196.8 13275.8 11255.5 14070.9 14309.3 14615.9 15071.5 14019.7 14037.6 14149.6 14221.9 14233.2 10818.0 11128.9 11633.9 11886.1 12046.8 11196.7 11995.5 12202.4 12360.4 12471.7 19:09:42 INFO - PROCESS | 29776 | -------- Summary: end -------- 19:09:42 INFO - PROCESS | 29776 | 19:09:43 INFO - TEST-INFO | 29776: exit 0 19:09:43 INFO - TEST-OK | dromaeo_css | took 1115437ms 19:09:43 INFO - TEST-START | kraken 19:09:43 INFO - operating with platform_type : linux_ 19:09:43 INFO - Initialising browser for kraken test... 19:09:43 INFO - TEST-INFO | started process 30083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1IHcOC/profile http://localhost:52096/getInfo.html) 19:09:47 INFO - PROCESS | 30083 | __metrics Screen width/height:1600/1200 19:09:47 INFO - PROCESS | 30083 | colorDepth:24 19:09:47 INFO - PROCESS | 30083 | Browser inner width/height: 1024/697 19:09:47 INFO - PROCESS | 30083 | __metrics 19:09:48 INFO - PROCESS | 30083 | 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" 19:09:48 INFO - PROCESS | 30083 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:09:48 INFO - PROCESS | 30083 | console.error: PushService: 19:09:48 INFO - PROCESS | 30083 | stateChangeProcessEnqueue: Error transitioning state 19:09:48 INFO - PROCESS | 30083 | UnknownError 19:09:49 INFO - TEST-INFO | 30083: exit 0 19:09:49 INFO - Browser initialized. 19:09:49 INFO - Running cycle 1/1 for kraken test... 19:09:49 INFO - TEST-INFO | started process 30165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1IHcOC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:01 INFO - PROCESS | 30165 | RSS: Main: 156479488 19:10:01 INFO - PROCESS | 30165 | 19:10:03 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-beat-detection) 19:10:04 INFO - PROCESS | 30165 | RSS: Main: 204251136 19:10:04 INFO - PROCESS | 30165 | 19:10:07 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-dft) 19:10:07 INFO - PROCESS | 30165 | RSS: Main: 191967232 19:10:07 INFO - PROCESS | 30165 | 19:10:10 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-fft) 19:10:11 INFO - PROCESS | 30165 | RSS: Main: 275984384 19:10:11 INFO - PROCESS | 30165 | 19:10:13 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-oscillator) 19:10:14 INFO - PROCESS | 30165 | RSS: Main: 186306560 19:10:14 INFO - PROCESS | 30165 | 19:10:16 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:10:16 INFO - PROCESS | 30165 | RSS: Main: 190390272 19:10:16 INFO - PROCESS | 30165 | 19:10:19 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52096/tests/kraken/driver.html?testName=imaging-darkroom) 19:10:20 INFO - PROCESS | 30165 | RSS: Main: 225492992 19:10:20 INFO - PROCESS | 30165 | 19:10:23 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52096/tests/kraken/driver.html?testName=imaging-desaturate) 19:10:24 INFO - PROCESS | 30165 | RSS: Main: 227196928 19:10:24 INFO - PROCESS | 30165 | 19:10:27 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52096/tests/kraken/driver.html?testName=json-parse-financial) 19:10:27 INFO - PROCESS | 30165 | RSS: Main: 226537472 19:10:27 INFO - PROCESS | 30165 | 19:10:29 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:10:30 INFO - PROCESS | 30165 | RSS: Main: 188940288 19:10:30 INFO - PROCESS | 30165 | 19:10:31 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:32 INFO - PROCESS | 30165 | RSS: Main: 196493312 19:10:32 INFO - PROCESS | 30165 | 19:10:34 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:35 INFO - PROCESS | 30165 | RSS: Main: 193409024 19:10:35 INFO - PROCESS | 30165 | 19:10:37 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:38 INFO - PROCESS | 30165 | RSS: Main: 187666432 19:10:38 INFO - PROCESS | 30165 | 19:10:40 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:41 INFO - PROCESS | 30165 | RSS: Main: 192413696 19:10:41 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52096/tests/kraken/driver.html?testName=ai-astar) 19:10:43 INFO - PROCESS | 30165 | RSS: Main: 243613696 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | __start_tp_report 19:10:43 INFO - PROCESS | 30165 | _x_x_mozilla_page_load 19:10:43 INFO - PROCESS | 30165 | _x_x_mozilla_page_load_details 19:10:43 INFO - PROCESS | 30165 | |i|pagename|runs| 19:10:43 INFO - PROCESS | 30165 | |0;ai-astar;105;111;113;113;108;114;110;111;112;111 19:10:43 INFO - PROCESS | 30165 | |1;audio-beat-detection;141;121;121;200;120;120;154;118;165;116 19:10:43 INFO - PROCESS | 30165 | |2;audio-dft;162;161;161;161;161;160;161;165;162;163 19:10:43 INFO - PROCESS | 30165 | |3;audio-fft;74;75;76;114;77;77;76;74;100;78 19:10:43 INFO - PROCESS | 30165 | |4;audio-oscillator;85;84;125;85;84;86;127;85;86;128 19:10:43 INFO - PROCESS | 30165 | |5;imaging-gaussian-blur;117;117;117;119;120;117;119;118;118;118 19:10:43 INFO - PROCESS | 30165 | |6;imaging-darkroom;148;148;148;145;147;147;146;147;146;146 19:10:43 INFO - PROCESS | 30165 | |7;imaging-desaturate;96;95;95;96;96;95;95;95;95;95 19:10:43 INFO - PROCESS | 30165 | |8;json-parse-financial;51;49;51;51;51;53;52;50;52;51 19:10:43 INFO - PROCESS | 30165 | |9;json-stringify-tinderbox;61;62;61;63;63;62;63;62;63;62 19:10:43 INFO - PROCESS | 30165 | |10;stanford-crypto-aes;81;79;78;79;79;78;84;78;80;78 19:10:43 INFO - PROCESS | 30165 | |11;stanford-crypto-ccm;125;123;123;124;123;122;124;126;141;124 19:10:43 INFO - PROCESS | 30165 | |12;stanford-crypto-pbkdf2;161;167;162;164;164;164;168;163;165;163 19:10:43 INFO - PROCESS | 30165 | |13;stanford-crypto-sha256-iterative;68;64;65;63;65;65;64;70;63;62 19:10:43 INFO - PROCESS | 30165 | __end_tp_report 19:10:43 INFO - PROCESS | 30165 | __start_cc_report 19:10:43 INFO - PROCESS | 30165 | _x_x_mozilla_cycle_collect,1673 19:10:43 INFO - PROCESS | 30165 | __end_cc_report 19:10:43 INFO - PROCESS | 30165 | __startTimestamp1471313443524__endTimestamp 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | ------- Summary: start ------- 19:10:43 INFO - PROCESS | 30165 | Number of tests: 14 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.66 (2.4%) stddev-sans-first:1.81 19:10:43 INFO - PROCESS | 30165 | Values: 105.0 111.0 113.0 113.0 108.0 114.0 110.0 111.0 112.0 111.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:131.00 stddev:27.78 (21.2%) stddev-sans-first:29.44 19:10:43 INFO - PROCESS | 30165 | Values: 141.0 121.0 121.0 200.0 120.0 120.0 154.0 118.0 165.0 116.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.42 (0.9%) stddev-sans-first:1.50 19:10:43 INFO - PROCESS | 30165 | Values: 162.0 161.0 161.0 161.0 161.0 160.0 161.0 165.0 162.0 163.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.59 (17.9%) stddev-sans-first:14.10 19:10:43 INFO - PROCESS | 30165 | Values: 74.0 75.0 76.0 114.0 77.0 77.0 76.0 74.0 100.0 78.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:20.15 (23.7%) stddev-sans-first:20.86 19:10:43 INFO - PROCESS | 30165 | Values: 85.0 84.0 125.0 85.0 84.0 86.0 127.0 85.0 86.0 128.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 19:10:43 INFO - PROCESS | 30165 | Values: 117.0 117.0 117.0 119.0 120.0 117.0 119.0 118.0 118.0 118.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 19:10:43 INFO - PROCESS | 30165 | Values: 148.0 148.0 148.0 145.0 147.0 147.0 146.0 147.0 146.0 146.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:10:43 INFO - PROCESS | 30165 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:1.10 (2.2%) stddev-sans-first:1.17 19:10:43 INFO - PROCESS | 30165 | Values: 51.0 49.0 51.0 51.0 51.0 53.0 52.0 50.0 52.0 51.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 19:10:43 INFO - PROCESS | 30165 | Values: 61.0 62.0 61.0 63.0 63.0 62.0 63.0 62.0 63.0 62.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.90 (2.4%) stddev-sans-first:1.92 19:10:43 INFO - PROCESS | 30165 | Values: 81.0 79.0 78.0 79.0 79.0 78.0 84.0 78.0 80.0 78.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:124.00 stddev:5.56 (4.5%) stddev-sans-first:5.90 19:10:43 INFO - PROCESS | 30165 | Values: 125.0 123.0 123.0 124.0 123.0 122.0 124.0 126.0 141.0 124.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:2.13 (1.3%) stddev-sans-first:1.94 19:10:43 INFO - PROCESS | 30165 | Values: 161.0 167.0 162.0 164.0 164.0 164.0 168.0 163.0 165.0 163.0 19:10:43 INFO - PROCESS | 30165 | 19:10:43 INFO - PROCESS | 30165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.42 (3.7%) stddev-sans-first:2.30 19:10:43 INFO - PROCESS | 30165 | Values: 68.0 64.0 65.0 63.0 65.0 65.0 64.0 70.0 63.0 62.0 19:10:43 INFO - PROCESS | 30165 | -------- Summary: end -------- 19:10:43 INFO - PROCESS | 30165 | 19:10:44 INFO - TEST-INFO | 30165: exit 0 19:10:44 INFO - TEST-OK | kraken | took 61067ms 19:10:44 INFO - SUITE-END | took 1176s 19:10:44 INFO - Completed test suite (00:19:36) 19:10:44 INFO - javascript benchmark 19:10:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2967.9851600741995, 2996.235959830243, 3012.6987301269874, 3018.607581014468, 3029.1064136079867, 5048.116579598564, 5150.3047088643025, 5164.741762911854, 5226.137687281599, 5328.04095262853, 5144.845654630358, 5162.974185129078, 5170.9224361634515, 5271.841844744654, 5318.2554442378005, 4719.339292499053, 4757.524247575249, 4787.736674482902, 4797.688150270221, 4914.508549145093, 4820.445648750404, 4852.660313778037, 4860.878478038059, 4867.537583929521, 4918.385201849769, 4664.5335466453425, 4685.2972054191805, 4705.1530724469585, 4745.976270118645, 4772.42730872294, 4742.668013239075, 4772.451168115676, 4773.64197685175, 4777.474477807438, 4784.258439941815, 4663.044075964453, 4711.387519622462, 4725.740084295362, 4745.240761478181, 4747.786349614275, 5123.077845987721, 5164.0, 5167.689938603658, 5176.534111929945, 5181.715005674687, 5629.57778166635, 5629.746661400206, 5630.183623374629, 5634.521065709419, 5637.295338082739, 5449.291592093003, 5453.045716999509, 5467.316585426822, 5497.47773961477, 5650.0, 5198.792048318101, 5202.401723801773, 5213.791448342062, 5218.895622087575, 5220.034293655686, 5674.0637794764225, 5687.51656109227, 5699.686517241508, 5701.0308247598, 5711.228984087178, 5349.919751203735, 5350.036993341236, 5375.086235340002, 5400.135978243462, 5416.2688037114485, 5497.422770609109, 5525.475079867406, 5568.164775283659, 5568.888622227532, 5585.888282234332, 5561.6663000220115, 5572.888542229132, 5573.164025396223, 5576.358718747396, 5581.2186293918885, 5408.729563521808, 5471.835844924659, 5507.449255074541, 5509.504144626922, 5607.607467477319, 4281.828726850891, 4300.3549467580115, 4302.698811083257, 4304.655627549789, 4337.436133302651, 3836.8081595920094, 3850.9229815403537, 3866.304065268279, 3874.2832575973534, 3887.9028024299055, 5171.612129090333, 5217.660852044605, 5223.634345595848, 5292.100342941709, 5297.337832770903, 5638.013347664142, 5642.0, 5643.153526970905, 5646.520045796071, 5651.26533550644, 5301.443348448434, 5307.442718514578, 5314.867128321823, 5316.76074576645, 5320.17537281722, 4707.552782485658, 4770.0936822004405, 4788.664793464493, 4797.592204662573, 4837.927431088537, 5803.390643982406, 5806.941930580809, 5825.94174058254, 5832.854178645568, 5838.795642152504, 5604.103343465026, 5618.269624948731, 5619.269494965628, 5623.0, 5635.549156067423, 5620.662760234399, 5729.4843464088435, 5736.397678243724, 5748.856278593069, 5775.162601422686, 5457.808976685797, 5476.205950137128, 5486.094794358886, 5488.753006114654, 5511.559075274049, 5580.35825880029, 5590.692511911721, 5594.188842617717, 5602.327720673546, 5613.186088017296, 5354.143337066051, 5356.892862142658, 5389.757460914347, 5400.2439658447065, 5475.5072043516275, 5425.864353391197, 5434.3207099112615, 5436.646617969819, 5438.184272359178, 5458.072127738374, 5344.25180474726, 5348.866278343073, 5359.276497672764, 5361.415989329067, 5373.382061062872, 4908.582770464551, 5304.124819404755, 5325.440828713085, 5351.785928562969, 5507.531859791962, 5347.465253474621, 5355.4376790438, 5365.195220716768, 5376.489233522809, 5390.27231323782], "value": 5134.339504388074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.2497191221632, 592.283337162034, 599.206051981125, 602.3765402808094, 617.5029101573233, 42258.36612450812, 43382.0, 43713.12573748527, 47086.764566177204, 47376.28935565969, 45686.0, 46105.53894461055, 46175.76912115443, 46214.07571848561, 46216.0, 8879.51162686052, 8990.68532601359, 9019.09809019096, 9031.367804253705, 9032.68385606504, 8801.987771406306, 8886.688965886195, 8896.0, 8905.643774249054, 8920.197182253596, 8914.55427228636, 8922.553872306391, 8924.55377231139, 8930.151635594608, 8943.865842012376, 8764.1674040966, 8770.035296117421, 8840.071792461764, 8840.911590884074, 8847.823043539125, 8912.821743565093, 8988.460692358414, 8992.46045237288, 8992.910070899272, 8994.460332380013, 42509.78745106285, 42728.35907461391, 42873.35689964653, 42932.78533607343, 42957.57042429567, 3560.072479321926, 3754.9812250938844, 3896.532416110085, 4043.8971734697793, 4143.1713657268665, 32546.83726581352, 32811.50782738261, 33044.83477582621, 33117.33765324704, 34879.651203488145, 4338.327559228324, 4400.911981760347, 4535.659825513099, 4598.011427543094, 4631.490536041033, 374793.0, 375439.0, 375812.0, 376846.0, 377626.99999999726, 58898.70550647305, 58958.41041589529, 58995.70502147548, 59225.703871480364, 59359.0, 62717.37282627207, 62718.68640656859, 62754.37245627576, 62822.0, 62889.4532656075, 17054.74417883733, 17296.3568460996, 17297.91351043237, 17320.393786217675, 17327.91336043312, 13206.669833254053, 13241.0, 13247.470101196037, 13269.137506062076, 13296.933515332361, 16781.783544155118, 18562.907185464257, 18637.254509819457, 18675.906620466812, 18914.621707566046, 6869.553479023847, 6919.7232110715, 6936.167659880846, 7105.182903966007, 7151.3563779259075, 710.193335613196, 976.0629795396499, 1019.4036488654073, 1033.3593172233113, 1071.5445935477546, 33139.0, 33330.333393331995, 33768.1557961053, 33873.66126338754, 33938.49092263618, 1121.383239218443, 1128.7460321427777, 1143.2968724234536, 1166.7199872030822, 1169.4620474581789, 16798.748018779726, 16943.068131252654, 17520.912395437943, 17562.841856711744, 17672.646547068987, 583783.3784128312, 860585.0, 876634.0, 876972.0, 877582.0, 58929.0, 59570.70214648986, 59665.70167149136, 59718.0, 59763.701181493816, 1240.4170040081146, 1321.8545959944206, 1354.8170996915487, 1368.6509939965244, 1383.9238841863594, 29971.0, 33801.15497112493, 34112.82943585266, 34328.885967140406, 34531.0, 50590.2411463821, 51166.74416628042, 51364.22953655773, 51396.48603514067, 51406.48593514017, 443718.0, 444780.0, 446686.0, 447059.0, 447753.0, 28621.570676440286, 29445.26386840346, 29535.409291814474, 29594.408111838075, 29662.703372965992, 47462.0, 48280.43845950487, 48597.43934568788, 48784.0, 49395.7892736971, 39201.607983920934, 41110.794446027576, 41187.794061029505, 41811.0, 42161.0, 40334.39498407467, 40950.59049409587, 41321.79339103285, 41422.58577414308, 41994.58005419907, 40440.0, 41247.0, 42516.5748342525, 42704.57295427006, 42829.78585107055, 33079.33841323112, 36483.27033459369, 36699.60169664356, 36910.63089369072, 36974.445383318736, 28063.0, 28117.43765124727, 28209.71790282071, 28365.71634283713, 28465.0], "value": 20682.992174898223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.19365589359285, 390.84756944791536, 404.4721638262068, 409.2367734175762, 420.8442876135828, 16576.751348729762, 19640.705389419152, 19708.802911970877, 19956.0, 20844.583108337825, 19502.804971950278, 19963.301284455047, 20207.797922020774, 20247.797522024775, 20345.186192552315, 5118.9488105119035, 5572.4706152915405, 5751.0, 5786.942130578683, 5807.767689292445, 5703.458171473724, 5717.828465146053, 5728.283964504437, 5743.13852922063, 5750.683712395817, 5499.285092937913, 5596.0206963781175, 5646.943530564703, 5666.065099258638, 5714.51426628737, 5583.106702927533, 5625.156226566007, 5632.930672006605, 5655.745491452894, 5697.943020569783, 4989.875253118665, 5087.389513258433, 5116.232565115262, 5118.232265160219, 5119.56483698886, 24053.917573709226, 24711.5057698845, 24781.0, 24847.25458236256, 24913.377165571004, 2300.7814257645496, 2425.7938075263623, 2518.3704073981503, 2722.074494671821, 3146.2134466383404, 14805.407783688639, 15908.443204487903, 16055.438059667855, 16232.83767162325, 16461.917690411592, 2027.9695804562944, 2044.366246463601, 2059.8970051497513, 2104.4002459299027, 2170.4031391367344, 89083.0, 95915.0, 97141.0, 98432.50783746107, 99054.0, 17678.823211767718, 17739.911300443415, 17995.820041799678, 18159.182836772376, 18517.0, 31919.0, 31992.840035800138, 32053.679463205535, 32075.990501187352, 32121.51817722736, 9960.551775170135, 10206.234532410099, 10336.725920297673, 10398.636047738293, 10665.466726663635, 8659.350548708871, 8702.564871756387, 8719.956400217958, 8992.955035224782, 9009.414388064886, 8711.738647840575, 9067.91185057784, 9114.726558203265, 9160.496172710431, 9261.120193581599, 3239.9838000809846, 3312.4700047992205, 3337.632860385356, 3429.811360375203, 3470.16715988161, 933.8365785987424, 991.940483570988, 1046.9057784799252, 1089.9182561307775, 1095.9671209863716, 18280.360187393377, 18973.335933242546, 20035.198592056448, 20381.18475260973, 20826.895865520877, 968.7820240445843, 993.8409854423257, 1035.5443604813859, 1035.9792804143874, 1061.2465149743614, 10399.968018549223, 11367.431628418546, 11381.772364552662, 11503.827442588368, 11543.134264930164, 505323.0, 512567.0, 513453.0, 518862.0, 529539.0, 93146.53426732958, 94407.52796235975, 95556.0, 97490.0, 98082.0, 979.7060881735451, 995.5669283861398, 1048.905598496139, 1051.8369652703843, 1056.12869382758, 17900.820991790435, 18212.18045187943, 18910.810891890906, 18992.62014759725, 19081.713774293676, 43744.78127609342, 44422.55577444184, 44977.0, 45460.0, 45574.0, 60311.396886030576, 60410.0, 60505.0, 62701.372986269555, 62752.68623656852, 8693.695720649746, 8707.521086340312, 8750.781230469289, 8797.956010219908, 8906.376553641183, 12223.572174973833, 12797.552085676956, 13303.334833258104, 13509.054366194272, 13867.375968081258, 10449.68650940473, 10866.619668311887, 11204.943975280072, 11330.773384532427, 11376.0, 11064.944675276573, 11485.540578376771, 11498.712532186428, 11631.243969141979, 11951.22317049389, 11063.668089957315, 11189.944050279697, 11205.159613028893, 11285.266457680225, 11777.0, 8682.218600326001, 9024.81950360976, 9032.23226025769, 9068.047854975133, 9352.719418417186, 9628.614855405986, 10784.352938823695, 10798.352098874093, 10854.620088296871, 11317.264377815745], "value": 10263.900939456807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.1433475408369, 1480.3338497676045, 1502.9473968411107, 1618.198991499208, 1766.6643337765831, 7590.544567325957, 7831.569263690495, 7946.801329966754, 8114.39142064346, 8119.837603247946, 7973.0, 8042.075161356446, 8048.396370272224, 8066.878996815052, 8073.4348595598185, 1963.1362200631677, 2216.4791274050585, 2285.1544928376484, 2298.3449716830705, 2303.6199027160496, 2291.873946932918, 2312.502811895442, 2312.6877871487386, 2315.409570559505, 2316.3282648032136, 2190.3647942096773, 2248.2243625949022, 2255.4023183856293, 2259.344790010903, 2283.406314358262, 2112.6514125169483, 2192.78072192781, 2197.7692342304067, 2199.296225207934, 2214.081156320125, 2239.6528538076623, 2256.4697296135396, 2257.097161135559, 2259.2770313499686, 2260.9095636174534, 8380.413371064027, 8427.494350338999, 8460.407771456, 8460.407771456, 8465.153484651548, 4973.104841128596, 5131.589472842164, 5139.897202055975, 5143.408508021588, 5148.6910785353, 3109.5646609474693, 3129.0, 3271.492918597621, 3284.293876816472, 3286.1784553861535, 1147.994260028703, 1156.6876943225366, 1174.2308787744041, 1192.9701757456046, 1195.7010747313172, 10793.136549076133, 10824.512896919658, 10849.837252441219, 10950.561977520889, 10989.175811814146, 4221.472315960505, 4261.765602891871, 4429.778511074498, 4439.955600443955, 4459.509453960061, 8769.38614296993, 8790.296776257885, 8798.384113112148, 8812.250958668457, 8815.0, 5022.773975171126, 5083.313752643346, 5083.644144909821, 5087.211482220262, 5089.389273287229, 4077.082656402345, 4635.351050852883, 4713.858584242478, 4806.687565308243, 4818.759062046884, 3610.29599228148, 3681.392570225936, 3771.7925514096987, 3793.4878791363367, 3823.330917089498, 1149.3046706742468, 1149.3105135450874, 1155.2375432214699, 1155.5031336525374, 1171.4904016752569, 881.7971866470748, 896.4128495835238, 914.9935071421384, 916.2120576304372, 951.1297163095828, 5447.645903016291, 5469.206964990134, 5499.48588941134, 5619.522340601013, 5784.50831679312, 481.7398604753464, 482.4765129834099, 484.04642853578395, 487.16208122030054, 497.4826180772029, 4011.157656892027, 4019.8593049243723, 4037.6366127048705, 4056.79716014204, 4088.1823635273063, 9483.620655173716, 9720.125188733047, 9756.756081098029, 9777.511124443892, 9778.902210977942, 9664.420134791935, 9681.177099946442, 9685.612575496902, 9697.224222062217, 9723.513824308757, 7418.109826820816, 7460.962695186598, 7489.063867016623, 7493.175750667422, 7523.66766302448, 5671.971640141773, 5809.331926828469, 5917.372722501174, 5982.641041537521, 6299.401556852092, 9129.863052054092, 9268.629254829732, 9395.06049395055, 9411.952940235255, 9454.196393306645, 9440.386374885611, 9606.615735370508, 9626.807463850824, 9652.27607929422, 9661.082197191256, 6447.806565803034, 7097.112860892388, 7206.4595155364605, 7285.162206346338, 7413.369863561657, 7929.048514178336, 8010.0, 8073.7577872663915, 8097.595120244082, 8101.35189184852, 7092.716291348288, 7193.172785129777, 7211.819704507429, 7263.564186148848, 7350.448716346403, 7128.108986376703, 7238.855222895618, 7267.491275610868, 7272.527285726411, 7299.890501642586, 6265.874682506415, 6404.135441715309, 6470.935290647221, 6550.279469258282, 6558.934410656023, 4893.951060489349, 5026.095302845523, 5061.9493805061475, 5111.3355263815465, 5148.2020286855595, 5032.698038117578, 5108.131617625087, 5166.184429485864, 5254.579633629224, 5265.921011184759], "value": 4313.58530286376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.52239513902407, 333.4548013997114, 340.14792943676093, 345.5766685809883, 346.23309369746005, 5179.378474583051, 5182.352205974254, 5200.505951934565, 5205.401378841425, 5243.737813109348, 5149.948500514994, 5183.455737147602, 5192.182736042383, 5258.526732594066, 5260.868478288045, 3685.926281474369, 3886.689064874817, 3925.509311336083, 4034.5158580970324, 4050.088730035733, 4055.797210139481, 4104.733192342503, 4112.342025275956, 4122.0, 4142.772147531885, 4059.817308221137, 4072.409500622423, 4084.7344922579937, 4084.7957602119923, 4091.6293041831022, 3880.3985382265796, 3988.700847436454, 4077.2660921034203, 4090.4886889138857, 4102.2410853992105, 3617.439296908983, 3622.474741162543, 3634.8909532713797, 3635.6909662678704, 3654.4701018352457, 5072.2391641253735, 5088.643794934356, 5120.436751957282, 5124.871878203037, 5146.459621739701, 4640.396748422717, 4681.555252251031, 4684.250519916797, 4684.320773487825, 4725.527447255281, 5404.4595540446035, 5443.292371991655, 5461.453854614507, 5467.617266791326, 5479.589030822704, 3833.50164478616, 3852.768833869977, 3891.5330160380654, 3955.6835453163676, 4031.9193616127513, 5574.832755017356, 5589.65848196434, 5593.216949627055, 5621.184928185431, 5622.943770562283, 4111.753294802322, 4120.896977575525, 4147.875563733093, 4150.252954468165, 4154.439150714615, 3914.3149948758855, 4086.978255436141, 4106.527749308868, 4130.834766609302, 4207.789610519523, 4638.582527572467, 4656.394668693116, 4657.930131048037, 4665.570805457985, 4676.111538807616, 5450.591205659592, 5471.37079235885, 5484.2596249506605, 5486.286782718221, 5538.833834984957, 1368.945242190321, 1395.448797724893, 1397.5046700030869, 1402.4039783092146, 1403.7824137258742, 871.6600525794945, 909.2226146644656, 915.5468043318467, 918.0956757593765, 926.8053708721109, 4639.466461356919, 4666.0, 4694.3427920090535, 4703.670743048022, 4711.717296962193, 4972.8508144755715, 4989.63614114828, 5007.9499205008215, 5018.874528136826, 5020.59835213182, 4512.887177820581, 4733.715977041388, 4735.810567577328, 4745.7423782697615, 4769.809207631725, 2602.5445547029194, 2609.908653197129, 2612.908548200804, 2622.7508386703234, 2628.6451329070715, 5041.395032596112, 5063.696178229318, 5073.543381095719, 5128.948710512847, 5130.178786530802, 4844.781984810692, 5014.84955451337, 5027.899442011139, 5031.0, 5072.21028434367, 5009.872778624853, 5015.673981191211, 5062.797877761449, 5080.237964305384, 5089.389273287229, 4890.657653964188, 4930.408350997904, 4969.850904472872, 5347.839564813062, 5360.3299587551555, 5499.560035197094, 5525.557955363481, 5551.084071128219, 5554.222408862682, 5576.944230557642, 5766.250387449605, 5782.2194003808945, 5788.392218816964, 5793.739281732416, 5800.216970708901, 3903.9159064339988, 3917.5103112110987, 3940.960590394059, 3944.84220631183, 3949.466821978996, 5553.666779993213, 5583.2462617547735, 5588.848293407149, 5609.158626206102, 5623.718814059199, 5515.917261241165, 5516.255305533701, 5521.365043019943, 5530.695811730394, 5532.75923251084, 5161.896762064813, 5411.512963833274, 5466.207399927068, 5467.480589344006, 5490.890182196254, 5404.702741349263, 5422.674639521641, 5434.0, 5437.722135298122, 5483.024807014882, 5384.0, 5506.504414602545, 5556.277683901067, 5567.610267281251, 5574.609777315712, 5288.8413347599635, 5304.32131773452, 5306.389765176899, 5334.893302133858, 5341.225522299167], "value": 4069.2050891953027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.4711569690458, 813.8819871118687, 819.2544784246329, 823.9134890836463, 836.0, 13665.385057672403, 14233.857661423383, 14245.786313205284, 14326.641833954143, 14330.355134018968, 14399.78400323996, 14421.927890360534, 14471.78292325616, 14493.202873841961, 14537.200453975027, 807.390420232725, 814.775936617429, 815.4903185509057, 815.7919730468723, 816.7590560784553, 664.717495064598, 785.2226295967008, 815.1033862750986, 815.7552734179752, 820.9302209312216, 858.2790456016944, 859.7162936231028, 860.9655613775442, 863.8704194370863, 865.3466632692308, 854.2695994924344, 855.0295414704324, 857.5069335132292, 857.5969294431669, 858.9055203927563, 507.41647105828224, 608.5770389579244, 623.0716232813121, 623.9251289845203, 630.4515071887441, 13989.160650361011, 14024.509142179975, 14051.718965620732, 14076.2961851907, 14083.788743168861, 13854.653633659138, 14742.631434214123, 14769.187694676788, 14839.0, 14955.775663365059, 13057.673558161026, 13162.341882905912, 13278.0, 13666.52167174144, 13935.930320348434, 4350.8042138103865, 4383.978080109579, 4436.290193569046, 4482.036362182114, 4612.077584483083, 81871.590642047, 82682.0, 82703.5864820672, 83164.58417707933, 89531.99999999935, 11176.217664763552, 11312.830307545393, 11317.83023254652, 11419.543218271343, 11596.76806463866, 21319.573608527742, 21529.13883444676, 21578.244761433274, 21611.243606473698, 21620.45948851291, 8441.620127094173, 8638.265747411415, 8860.291176705849, 8937.865932011026, 8938.553072346356, 4683.601893838993, 4717.8112875485285, 4730.0, 4933.45731969483, 5059.316992206079, 3307.966920330814, 3349.8777909400624, 3373.139849338403, 3386.3227354529195, 3386.762926595164, 579.2469789273927, 592.4283066840519, 599.6551982610017, 609.1471939285036, 611.3122736920964, 663.4460225711584, 683.9110915580943, 685.7771224352106, 695.1831597872581, 709.6203531110934, 8978.191962723386, 9047.276217902552, 9060.275177985744, 9278.164965153033, 9352.018038106036, 529.3277537527396, 578.23672751967, 665.9134312539339, 667.1993607670718, 674.9257581666013, 4322.740635561876, 4355.368471571668, 4548.363229147922, 4581.702189357748, 4632.907341853144, 73371.26628733751, 95677.52161239149, 105705.0, 127238.0, 133016.68883178083, 109473.45263273633, 110054.44972775085, 110825.0, 111933.44033279782, 112161.1959701014, 94684.52657736804, 95496.10802541568, 97031.51484242534, 99499.0, 102850.0, 8426.536540490331, 8472.534010629475, 8582.0, 8750.956245218733, 8930.330225233003, 56275.71862140663, 56385.0, 57177.71411142917, 57476.0, 57794.42205578059, 50165.0, 61261.38738612735, 75674.0, 76675.61662191653, 77455.0, 10889.455527223448, 11747.554881001535, 11755.0, 11807.82288265694, 11971.940140299592, 13332.733345333232, 13420.328983550979, 13477.326133693472, 13690.110142841082, 13955.790663139858, 12607.243565386107, 12910.741785164431, 13123.934380328037, 13196.802047969097, 13275.800862987257, 11255.549778008788, 14070.929645351707, 14309.284535773379, 14615.926920365755, 15071.4724984625, 14019.719605607626, 14037.649058773612, 14149.575512734635, 14221.928890355483, 14233.217173055167, 10817.955112219452, 11128.888711112786, 11633.941830290794, 11886.108541859223, 12046.819297710366, 11196.66410007701, 11995.460204290654, 12202.407712672819, 12360.44378002974, 12471.688207794878], "value": 7542.432836998401, "unit": "score"}], "name": "dromaeo_css", "value": 7242.477433790179, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 113.0, 113.0, 108.0, 114.0, 110.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 121.0, 121.0, 200.0, 120.0, 120.0, 154.0, 118.0, 165.0, 116.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 165.0, 162.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 114.0, 77.0, 77.0, 76.0, 74.0, 100.0, 78.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 125.0, 85.0, 84.0, 86.0, 127.0, 85.0, 86.0, 128.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 120.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 145.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 51.0, 51.0, 51.0, 53.0, 52.0, 50.0, 52.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 79.0, 79.0, 78.0, 84.0, 78.0, 80.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 123.0, 124.0, 123.0, 122.0, 124.0, 126.0, 141.0, 124.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 167.0, 162.0, 164.0, 164.0, 164.0, 168.0, 163.0, 165.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 65.0, 63.0, 65.0, 65.0, 64.0, 70.0, 63.0, 62.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1497.0, "alertThreshold": 2.0}]} 19:10:44 INFO - Return code: 0 19:10:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:10:44 INFO - # TBPL SUCCESS # 19:10:44 INFO - Running post-action listener: _resource_record_post_action 19:10:44 INFO - [mozharness: 2016-08-16 02:10:44.800923Z] Finished run-tests step (success) 19:10:44 INFO - Running post-run listener: _resource_record_post_run 19:10:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407924736; Read time: 16; Write time: 322192 19:10:44 INFO - TinderboxPrint: CPU usage
13.1% 19:10:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:10:44 INFO - TinderboxPrint: I/O write bytes / time
407,924,736 / 322,192 19:10:44 INFO - TinderboxPrint: CPU idle
8,281.4 (86.9%) 19:10:44 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 19:10:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:10:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117817344; Read time: 0; Write time: 119444 19:10:44 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289640448; Read time: 0; Write time: 202744 19:10:45 INFO - Running post-run listener: _upload_blobber_files 19:10:45 INFO - Blob upload gear active. 19:10:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:10:45 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 19:10:45 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'] 19:10:45 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 19:10:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:49 INFO - (blobuploader) - INFO - Done attempting. 19:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:10:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:50 INFO - (blobuploader) - INFO - Done attempting. 19:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:10:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:51 INFO - (blobuploader) - INFO - Done attempting. 19:10:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:10:51 INFO - Return code: 0 19:10:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:10:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:10:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5677e992de8d0bad8bb45bee474764b317862420482127634c4c6ea3bc43310690654362ea0e976c1ab39bbd295bfb4d1946c43ec66fcb3d3b32db3c7488ccf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c1b99e2549351478d8c83f584f66a08c538b5defb903d75fbdadbe75a79102cf1359d4f8ca0ab33c3e3dfd8002e1262860cb0c66acaf2b172952c93cf21ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dde5924829fab0ed3882f1b09023ea9b3a5af0f0883222ff048241c0d6ec6fbfcccd9bdf8396d6851973188ce40bf30cf23c4dce9e6019b867b17240d0a71ca"} 19:10:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:10:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:10:51 INFO - Contents: 19:10:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5677e992de8d0bad8bb45bee474764b317862420482127634c4c6ea3bc43310690654362ea0e976c1ab39bbd295bfb4d1946c43ec66fcb3d3b32db3c7488ccf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c1b99e2549351478d8c83f584f66a08c538b5defb903d75fbdadbe75a79102cf1359d4f8ca0ab33c3e3dfd8002e1262860cb0c66acaf2b172952c93cf21ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dde5924829fab0ed3882f1b09023ea9b3a5af0f0883222ff048241c0d6ec6fbfcccd9bdf8396d6851973188ce40bf30cf23c4dce9e6019b867b17240d0a71ca"} 19:10:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:10:51 INFO - Copying logs to upload dir... 19:10:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:10:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.297625 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-15 19:10:49.662629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 19:10:49.665906) ========= 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=52faae308a556c440401f8e5000001e8-1471312211.475059-582163460 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/b5677e992de8d0bad8bb45bee474764b317862420482127634c4c6ea3bc43310690654362ea0e976c1ab39bbd295bfb4d1946c43ec66fcb3d3b32db3c7488ccf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c1b99e2549351478d8c83f584f66a08c538b5defb903d75fbdadbe75a79102cf1359d4f8ca0ab33c3e3dfd8002e1262860cb0c66acaf2b172952c93cf21ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dde5924829fab0ed3882f1b09023ea9b3a5af0f0883222ff048241c0d6ec6fbfcccd9bdf8396d6851973188ce40bf30cf23c4dce9e6019b867b17240d0a71ca"} build_url:https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/Nc9LokGlSCWV5aqpDbo2DQ/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/b5677e992de8d0bad8bb45bee474764b317862420482127634c4c6ea3bc43310690654362ea0e976c1ab39bbd295bfb4d1946c43ec66fcb3d3b32db3c7488ccf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c1b99e2549351478d8c83f584f66a08c538b5defb903d75fbdadbe75a79102cf1359d4f8ca0ab33c3e3dfd8002e1262860cb0c66acaf2b172952c93cf21ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1dde5924829fab0ed3882f1b09023ea9b3a5af0f0883222ff048241c0d6ec6fbfcccd9bdf8396d6851973188ce40bf30cf23c4dce9e6019b867b17240d0a71ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 19:10:49.691740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 19:10:49.692112) ========= 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=52faae308a556c440401f8e5000001e8-1471312211.475059-582163460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 19:10:49.774182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 19:10:49.774513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 19:10:49.774825) ========= ========= Total master_lag: 0.16 =========