builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1471846584.63 results: success (0) buildid: 20160821203026 builduid: 89c629ce0b0741e0ad2b7eadb635b997 revision: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.629613) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.630103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.630386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.653230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.653499) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-21 23:16:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-08-21 23:16:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.813331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.813750) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.863754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.864099) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 --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 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-21 23:16:26,425 truncating revision to first 12 chars 2016-08-21 23:16:26,425 Setting DEBUG logging. 2016-08-21 23:16:26,425 attempt 1/10 2016-08-21 23:16:26,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/64f4ea57b6fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-21 23:16:26,781 unpacking tar archive at: fx-team-64f4ea57b6fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.608100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.608396) ========= script_repo_revision: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.608789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.609100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.622978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-21 23:16:25.623332) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:27 INFO - MultiFileLogger online at 20160821 23:16:27 in /builds/slave/test 23:16:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:16:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:27 INFO - {'append_to_log': False, 23:16:27 INFO - 'base_work_dir': '/builds/slave/test', 23:16:27 INFO - 'blob_upload_branch': 'Fx-Team', 23:16:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:27 INFO - 'branch': 'Fx-Team', 23:16:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:27 INFO - 'config_files': ('talos/linux_config.py',), 23:16:27 INFO - 'default_actions': ('clobber', 23:16:27 INFO - 'read-buildbot-config', 23:16:27 INFO - 'download-and-extract', 23:16:27 INFO - 'populate-webroot', 23:16:27 INFO - 'create-virtualenv', 23:16:27 INFO - 'install', 23:16:27 INFO - 'run-tests'), 23:16:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:27 INFO - 'download_minidump_stackwalk': True, 23:16:27 INFO - 'download_symbols': 'ondemand', 23:16:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:27 INFO - 'installer_path': 'installer.exe', 23:16:27 INFO - 'log_level': 'info', 23:16:27 INFO - 'log_name': 'talos', 23:16:27 INFO - 'log_to_console': True, 23:16:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:27 INFO - 'opt_config_files': (), 23:16:27 INFO - 'pip_index': False, 23:16:27 INFO - 'sps_profile': False, 23:16:27 INFO - 'sps_profile_interval': 0, 23:16:27 INFO - 'suite': 'dromaeojs', 23:16:27 INFO - 'system_bits': '32', 23:16:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:27 INFO - 'title': 'talos-linux64-ix-041', 23:16:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:27 INFO - 'use_talos_json': True, 23:16:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:27 INFO - 'work_dir': 'build'} 23:16:27 INFO - [mozharness: 2016-08-22 06:16:27.278940Z] Running clobber step. 23:16:27 INFO - Running pre-action listener: _resource_record_pre_action 23:16:27 INFO - Running main action method: clobber 23:16:27 INFO - rmtree: /builds/slave/test/build 23:16:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:28 INFO - Running post-action listener: _resource_record_post_action 23:16:28 INFO - [mozharness: 2016-08-22 06:16:28.251508Z] Finished clobber step (success) 23:16:28 INFO - [mozharness: 2016-08-22 06:16:28.251605Z] Running read-buildbot-config step. 23:16:28 INFO - Running pre-action listener: _resource_record_pre_action 23:16:28 INFO - Running main action method: read_buildbot_config 23:16:28 INFO - Using buildbot properties: 23:16:28 INFO - { 23:16:28 INFO - "project": "", 23:16:28 INFO - "product": "firefox", 23:16:28 INFO - "script_repo_revision": "production", 23:16:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:16:28 INFO - "repository": "", 23:16:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:16:28 INFO - "buildid": "20160821203026", 23:16:28 INFO - "pgo_build": "True", 23:16:28 INFO - "basedir": "/builds/slave/test", 23:16:28 INFO - "buildnumber": 379, 23:16:28 INFO - "slavename": "talos-linux64-ix-041", 23:16:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:16:28 INFO - "platform": "ubuntu64_hw", 23:16:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:16:28 INFO - "branch": "fx-team", 23:16:28 INFO - "repo_path": "integration/fx-team", 23:16:28 INFO - "revision": "64f4ea57b6fde8ed315f5bc8c9caefe389bb8923", 23:16:28 INFO - "stage_platform": "linux64-pgo", 23:16:28 INFO - "builduid": "89c629ce0b0741e0ad2b7eadb635b997", 23:16:28 INFO - "slavebuilddir": "test" 23:16:28 INFO - } 23:16:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:16:28 INFO - Running post-action listener: _resource_record_post_action 23:16:28 INFO - [mozharness: 2016-08-22 06:16:28.254014Z] Finished read-buildbot-config step (success) 23:16:28 INFO - [mozharness: 2016-08-22 06:16:28.254100Z] Running download-and-extract step. 23:16:28 INFO - Running pre-action listener: _resource_record_pre_action 23:16:28 INFO - Running main action method: download_and_extract 23:16:28 INFO - mkdir: /builds/slave/test/build/tests 23:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:28 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:28 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:16:28 INFO - Downloaded 1361 bytes. 23:16:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:28 INFO - Using the following test package requirements: 23:16:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'jsshell-linux-x86_64.zip'], 23:16:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:28 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:28 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:29 INFO - Downloaded 21920470 bytes. 23:16:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:16:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:33 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:33 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:16:34 INFO - Downloaded 21920470 bytes. 23:16:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:16: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')]} 23:16:39 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:39 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:16:40 INFO - Downloaded 14413981 bytes. 23:16:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 23:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:40 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:40 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:16:41 INFO - Downloaded 59704317 bytes. 23:16:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:41 INFO - mkdir: /builds/slave/test/properties 23:16:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:41 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:41 INFO - Contents: 23:16:41 INFO - build_url:https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:42 INFO - Running post-action listener: _resource_record_post_action 23:16:42 INFO - Running post-action listener: set_extra_try_arguments 23:16:42 INFO - [mozharness: 2016-08-22 06:16:42.278082Z] Finished download-and-extract step (success) 23:16:42 INFO - [mozharness: 2016-08-22 06:16:42.278306Z] Running populate-webroot step. 23:16:42 INFO - Running pre-action listener: _resource_record_pre_action 23:16:42 INFO - Running main action method: populate_webroot 23:16:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:42 INFO - '--tppagecycles', 23:16:42 INFO - '7'], 23:16:42 INFO - 'tests': ['tsvgm']}}, 23:16:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['damp', 'tps']}, 23:16:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'tests': ['damp', 'tps']}, 23:16:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['dromaeo_dom']}, 23:16:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['basic_compositor_video']}, 23:16:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['a11yr', 23:16:42 INFO - 'ts_paint', 23:16:42 INFO - 'tpaint', 23:16:42 INFO - 'sessionrestore', 23:16:42 INFO - 'sessionrestore_no_auto_restore', 23:16:42 INFO - 'tabpaint']}, 23:16:42 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:42 INFO - 'ts_paint', 23:16:42 INFO - 'tpaint', 23:16:42 INFO - 'sessionrestore', 23:16:42 INFO - 'sessionrestore_no_auto_restore', 23:16:42 INFO - 'tabpaint']}, 23:16:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:42 INFO - 'ts_paint', 23:16:42 INFO - 'tpaint', 23:16:42 INFO - 'sessionrestore', 23:16:42 INFO - 'sessionrestore_no_auto_restore', 23:16:42 INFO - 'tabpaint']}, 23:16:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:42 INFO - 'ts_paint', 23:16:42 INFO - 'tpaint', 23:16:42 INFO - 'sessionrestore', 23:16:42 INFO - 'sessionrestore_no_auto_restore', 23:16:42 INFO - 'tabpaint']}, 23:16:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['a11yr', 23:16:42 INFO - 'ts_paint', 23:16:42 INFO - 'tpaint', 23:16:42 INFO - 'sessionrestore', 23:16:42 INFO - 'sessionrestore_no_auto_restore', 23:16:42 INFO - 'tabpaint']}, 23:16:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['a11yr', 23:16:42 INFO - 'ts_paint', 23:16:42 INFO - 'tpaint', 23:16:42 INFO - 'sessionrestore', 23:16:42 INFO - 'sessionrestore_no_auto_restore', 23:16:42 INFO - 'tabpaint']}, 23:16:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['tsvgx', 23:16:42 INFO - 'tsvgr_opacity', 23:16:42 INFO - 'tart', 23:16:42 INFO - 'tscrollx', 23:16:42 INFO - 'cart']}, 23:16:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:42 INFO - 'tsvgr_opacity', 23:16:42 INFO - 'tart', 23:16:42 INFO - 'tscrollx', 23:16:42 INFO - 'cart']}, 23:16:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'talos_options': ['--disable-e10s'], 23:16:42 INFO - 'tests': ['tp5o']}, 23:16:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'tests': ['tp5o']}, 23:16:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'talos_options': ['--disable-e10s', 23:16:42 INFO - '--xperf_path', 23:16:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:42 INFO - 'tests': ['tp5n']}, 23:16:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:42 INFO - 'talos_options': ['--xperf_path', 23:16:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:42 INFO - 'tests': ['tp5n']}}, 23:16:42 INFO - 'talos.zip': {'path': '', 23:16:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:42 INFO - Running post-action listener: _resource_record_post_action 23:16:42 INFO - [mozharness: 2016-08-22 06:16:42.298233Z] Finished populate-webroot step (success) 23:16:42 INFO - [mozharness: 2016-08-22 06:16:42.298321Z] Running create-virtualenv step. 23:16:42 INFO - Running pre-action listener: _resource_record_pre_action 23:16:42 INFO - Running main action method: create_virtualenv 23:16:42 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:16:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:42 INFO - Using real prefix '/usr' 23:16:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:44 INFO - Installing pip.................done. 23:16:44 INFO - Return code: 0 23:16:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:16:44 INFO - Using env: {'DISPLAY': ':0', 23:16:44 INFO - 'HOME': '/home/cltbld', 23:16:44 INFO - 'LANG': 'en_US.UTF-8', 23:16:44 INFO - 'LANGUAGE': 'en_US:en', 23:16:44 INFO - 'LOGNAME': 'cltbld', 23:16:44 INFO - 'MAIL': '/var/mail/cltbld', 23:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:44 INFO - 'MOZ_NO_REMOTE': '1', 23:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:44 INFO - 'NO_EM_RESTART': '1', 23:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:44 INFO - 'PWD': '/builds/slave/test', 23:16:44 INFO - 'SHELL': '/bin/bash', 23:16:44 INFO - 'SHLVL': '1', 23:16:44 INFO - 'TERM': 'linux', 23:16:44 INFO - 'TMOUT': '86400', 23:16:44 INFO - 'USER': 'cltbld', 23:16:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:44 INFO - '_': '/tools/buildbot/bin/python'} 23:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:16:45 INFO - Cleaning up... 23:16:45 INFO - Return code: 0 23:16:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:16:45 INFO - Using env: {'DISPLAY': ':0', 23:16:45 INFO - 'HOME': '/home/cltbld', 23:16:45 INFO - 'LANG': 'en_US.UTF-8', 23:16:45 INFO - 'LANGUAGE': 'en_US:en', 23:16:45 INFO - 'LOGNAME': 'cltbld', 23:16:45 INFO - 'MAIL': '/var/mail/cltbld', 23:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:45 INFO - 'MOZ_NO_REMOTE': '1', 23:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:45 INFO - 'NO_EM_RESTART': '1', 23:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:45 INFO - 'PWD': '/builds/slave/test', 23:16:45 INFO - 'SHELL': '/bin/bash', 23:16:45 INFO - 'SHLVL': '1', 23:16:45 INFO - 'TERM': 'linux', 23:16:45 INFO - 'TMOUT': '86400', 23:16:45 INFO - 'USER': 'cltbld', 23:16:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:45 INFO - '_': '/tools/buildbot/bin/python'} 23:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:45 INFO - Downloading/unpacking psutil>=3.1.1 23:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:47 INFO - Installing collected packages: psutil 23:16:47 INFO - Running setup.py install for psutil 23:16:47 INFO - building 'psutil._psutil_linux' extension 23:16:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:16:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:16:47 INFO - building 'psutil._psutil_posix' extension 23:16:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:16:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:47 INFO - Successfully installed psutil 23:16:47 INFO - Cleaning up... 23:16:47 INFO - Return code: 0 23:16:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:47 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:16:47 INFO - Using env: {'DISPLAY': ':0', 23:16:47 INFO - 'HOME': '/home/cltbld', 23:16:47 INFO - 'LANG': 'en_US.UTF-8', 23:16:47 INFO - 'LANGUAGE': 'en_US:en', 23:16:47 INFO - 'LOGNAME': 'cltbld', 23:16:47 INFO - 'MAIL': '/var/mail/cltbld', 23:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:47 INFO - 'MOZ_NO_REMOTE': '1', 23:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:47 INFO - 'NO_EM_RESTART': '1', 23:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:47 INFO - 'PWD': '/builds/slave/test', 23:16:47 INFO - 'SHELL': '/bin/bash', 23:16:47 INFO - 'SHLVL': '1', 23:16:47 INFO - 'TERM': 'linux', 23:16:47 INFO - 'TMOUT': '86400', 23:16:47 INFO - 'USER': 'cltbld', 23:16:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:47 INFO - '_': '/tools/buildbot/bin/python'} 23:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:49 INFO - Installing collected packages: mozsystemmonitor 23:16:49 INFO - Running setup.py install for mozsystemmonitor 23:16:50 INFO - Successfully installed mozsystemmonitor 23:16:50 INFO - Cleaning up... 23:16:50 INFO - Return code: 0 23:16:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16: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==2.5.1'] in /builds/slave/test/build 23:16: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==2.5.1 23:16:50 INFO - Using env: {'DISPLAY': ':0', 23:16:50 INFO - 'HOME': '/home/cltbld', 23:16:50 INFO - 'LANG': 'en_US.UTF-8', 23:16:50 INFO - 'LANGUAGE': 'en_US:en', 23:16:50 INFO - 'LOGNAME': 'cltbld', 23:16:50 INFO - 'MAIL': '/var/mail/cltbld', 23:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:50 INFO - 'MOZ_NO_REMOTE': '1', 23:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:50 INFO - 'NO_EM_RESTART': '1', 23:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:50 INFO - 'PWD': '/builds/slave/test', 23:16:50 INFO - 'SHELL': '/bin/bash', 23:16:50 INFO - 'SHLVL': '1', 23:16:50 INFO - 'TERM': 'linux', 23:16:50 INFO - 'TMOUT': '86400', 23:16:50 INFO - 'USER': 'cltbld', 23:16:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:50 INFO - '_': '/tools/buildbot/bin/python'} 23:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:50 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:52 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:52 INFO - warning: no files found matching '*.txt' 23:16:52 INFO - no previously-included directories found matching 'build' 23:16:52 INFO - no previously-included directories found matching 'dist' 23:16:52 INFO - no previously-included directories found matching '.git*' 23:16:52 INFO - Installing collected packages: jsonschema, functools32 23:16:52 INFO - Running setup.py install for functools32 23:16:52 INFO - warning: no files found matching '*.txt' 23:16:52 INFO - no previously-included directories found matching 'build' 23:16:52 INFO - no previously-included directories found matching 'dist' 23:16:52 INFO - no previously-included directories found matching '.git*' 23:16:52 INFO - Successfully installed jsonschema functools32 23:16:52 INFO - Cleaning up... 23:16:52 INFO - Return code: 0 23:16:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:16:52 INFO - Using env: {'DISPLAY': ':0', 23:16:52 INFO - 'HOME': '/home/cltbld', 23:16:52 INFO - 'LANG': 'en_US.UTF-8', 23:16:52 INFO - 'LANGUAGE': 'en_US:en', 23:16:52 INFO - 'LOGNAME': 'cltbld', 23:16:52 INFO - 'MAIL': '/var/mail/cltbld', 23:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:52 INFO - 'MOZ_NO_REMOTE': '1', 23:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:52 INFO - 'NO_EM_RESTART': '1', 23:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:52 INFO - 'PWD': '/builds/slave/test', 23:16:52 INFO - 'SHELL': '/bin/bash', 23:16:52 INFO - 'SHLVL': '1', 23:16:52 INFO - 'TERM': 'linux', 23:16:52 INFO - 'TMOUT': '86400', 23:16:52 INFO - 'USER': 'cltbld', 23:16:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:52 INFO - '_': '/tools/buildbot/bin/python'} 23:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:52 INFO - Cleaning up... 23:16:52 INFO - Return code: 0 23:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:16:52 INFO - Using env: {'DISPLAY': ':0', 23:16:52 INFO - 'HOME': '/home/cltbld', 23:16:52 INFO - 'LANG': 'en_US.UTF-8', 23:16:52 INFO - 'LANGUAGE': 'en_US:en', 23:16:52 INFO - 'LOGNAME': 'cltbld', 23:16:52 INFO - 'MAIL': '/var/mail/cltbld', 23:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:52 INFO - 'MOZ_NO_REMOTE': '1', 23:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:52 INFO - 'NO_EM_RESTART': '1', 23:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:52 INFO - 'PWD': '/builds/slave/test', 23:16:52 INFO - 'SHELL': '/bin/bash', 23:16:52 INFO - 'SHLVL': '1', 23:16:52 INFO - 'TERM': 'linux', 23:16:52 INFO - 'TMOUT': '86400', 23:16:52 INFO - 'USER': 'cltbld', 23:16:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:52 INFO - '_': '/tools/buildbot/bin/python'} 23:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 23:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:55 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:55 INFO - Downloading docopt-0.6.1.tar.gz 23:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:55 INFO - Running setup.py install for blobuploader 23:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:55 INFO - Running setup.py install for requests 23:16:56 INFO - Running setup.py install for docopt 23:16:56 INFO - Successfully installed blobuploader requests docopt 23:16:56 INFO - Cleaning up... 23:16:56 INFO - Return code: 0 23:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:56 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:16:56 INFO - Using env: {'DISPLAY': ':0', 23:16:56 INFO - 'HOME': '/home/cltbld', 23:16:56 INFO - 'LANG': 'en_US.UTF-8', 23:16:56 INFO - 'LANGUAGE': 'en_US:en', 23:16:56 INFO - 'LOGNAME': 'cltbld', 23:16:56 INFO - 'MAIL': '/var/mail/cltbld', 23:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:56 INFO - 'MOZ_NO_REMOTE': '1', 23:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:56 INFO - 'NO_EM_RESTART': '1', 23:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:56 INFO - 'PWD': '/builds/slave/test', 23:16:56 INFO - 'SHELL': '/bin/bash', 23:16:56 INFO - 'SHLVL': '1', 23:16:56 INFO - 'TERM': 'linux', 23:16:56 INFO - 'TMOUT': '86400', 23:16:56 INFO - 'USER': 'cltbld', 23:16:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:56 INFO - '_': '/tools/buildbot/bin/python'} 23:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:56 INFO - Running setup.py (path:/tmp/pip-epOfcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:56 INFO - Running setup.py (path:/tmp/pip-bOVWME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:56 INFO - Running setup.py (path:/tmp/pip-_Zxh2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:56 INFO - Running setup.py (path:/tmp/pip-g4dvz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:56 INFO - Running setup.py (path:/tmp/pip-1pyBoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:56 INFO - Running setup.py (path:/tmp/pip-V3nCXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:57 INFO - Running setup.py (path:/tmp/pip-RuZLoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:57 INFO - Running setup.py (path:/tmp/pip-dlpMYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:57 INFO - Running setup.py (path:/tmp/pip-oaJgKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:57 INFO - Running setup.py (path:/tmp/pip-3bBJjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:57 INFO - Running setup.py (path:/tmp/pip-XTJih4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:57 INFO - Running setup.py (path:/tmp/pip-DEAENt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:57 INFO - Running setup.py (path:/tmp/pip-NeSvZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:57 INFO - Running setup.py (path:/tmp/pip-zVzgdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:57 INFO - Running setup.py (path:/tmp/pip-XBJaDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:57 INFO - Running setup.py (path:/tmp/pip-9te1yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:57 INFO - Running setup.py (path:/tmp/pip-BUUI4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:57 INFO - Running setup.py install for manifestparser 23:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozcrash 23:16:58 INFO - Running setup.py install for mozdebug 23:16:58 INFO - Running setup.py install for mozdevice 23:16:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozfile 23:16:58 INFO - Running setup.py install for mozhttpd 23:16:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozinfo 23:16:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozInstall 23:16:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozleak 23:16:58 INFO - Running setup.py install for mozlog 23:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for moznetwork 23:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozprocess 23:16:59 INFO - Running setup.py install for mozprofile 23:16:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:59 INFO - Running setup.py install for mozrunner 23:16:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:59 INFO - Running setup.py install for mozscreenshot 23:16:59 INFO - Running setup.py install for moztest 23:16:59 INFO - Running setup.py install for mozversion 23:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:59 INFO - Cleaning up... 23:16:59 INFO - Return code: 0 23:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:59 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:16:59 INFO - Using env: {'DISPLAY': ':0', 23:16:59 INFO - 'HOME': '/home/cltbld', 23:16:59 INFO - 'LANG': 'en_US.UTF-8', 23:16:59 INFO - 'LANGUAGE': 'en_US:en', 23:16:59 INFO - 'LOGNAME': 'cltbld', 23:16:59 INFO - 'MAIL': '/var/mail/cltbld', 23:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:59 INFO - 'MOZ_NO_REMOTE': '1', 23:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:59 INFO - 'NO_EM_RESTART': '1', 23:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:59 INFO - 'PWD': '/builds/slave/test', 23:16:59 INFO - 'SHELL': '/bin/bash', 23:16:59 INFO - 'SHLVL': '1', 23:16:59 INFO - 'TERM': 'linux', 23:16:59 INFO - 'TMOUT': '86400', 23:16:59 INFO - 'USER': 'cltbld', 23:16:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:59 INFO - '_': '/tools/buildbot/bin/python'} 23:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:59 INFO - Running setup.py (path:/tmp/pip-5QC2pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:59 INFO - Running setup.py (path:/tmp/pip-jLKMUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:17:00 INFO - Running setup.py (path:/tmp/pip-oec8kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:17:00 INFO - Running setup.py (path:/tmp/pip-6zNzoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:17:00 INFO - Running setup.py (path:/tmp/pip-ocm1jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:17:00 INFO - Running setup.py (path:/tmp/pip-dPT98w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:17:00 INFO - Running setup.py (path:/tmp/pip-bewtSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:17:00 INFO - Running setup.py (path:/tmp/pip-0trfZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:17:00 INFO - Running setup.py (path:/tmp/pip-nApWTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:17:00 INFO - Running setup.py (path:/tmp/pip-qJU7Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:17:00 INFO - Running setup.py (path:/tmp/pip-EM_U50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:17:00 INFO - Running setup.py (path:/tmp/pip-T2IIhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:00 INFO - Running setup.py (path:/tmp/pip-rjqbUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:00 INFO - Running setup.py (path:/tmp/pip-D89wG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:00 INFO - Running setup.py (path:/tmp/pip-dQjq06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:00 INFO - Running setup.py (path:/tmp/pip-aFI6V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:01 INFO - Running setup.py (path:/tmp/pip-tBKFiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:17:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:17:03 INFO - Downloading blessings-1.6.tar.gz 23:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:03 INFO - Installing collected packages: blessings 23:17:03 INFO - Running setup.py install for blessings 23:17:03 INFO - Successfully installed blessings 23:17:03 INFO - Cleaning up... 23:17:03 INFO - Return code: 0 23:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:03 INFO - Reading from file tmpfile_stdout 23:17:03 INFO - Current package versions: 23:17:03 INFO - argparse == 1.2.1 23:17:03 INFO - blessings == 1.6 23:17:03 INFO - blobuploader == 1.2.4 23:17:03 INFO - docopt == 0.6.1 23:17:03 INFO - functools32 == 3.2.3-2 23:17:03 INFO - jsonschema == 2.5.1 23:17:03 INFO - manifestparser == 1.1 23:17:03 INFO - mozInstall == 1.12 23:17:03 INFO - mozcrash == 0.17 23:17:03 INFO - mozdebug == 0.1 23:17:03 INFO - mozdevice == 0.48 23:17:03 INFO - mozfile == 1.2 23:17:03 INFO - mozhttpd == 0.7 23:17:03 INFO - mozinfo == 0.9 23:17:03 INFO - mozleak == 0.1 23:17:03 INFO - mozlog == 3.3 23:17:03 INFO - moznetwork == 0.27 23:17:03 INFO - mozprocess == 0.23 23:17:03 INFO - mozprofile == 0.28 23:17:03 INFO - mozrunner == 6.12 23:17:03 INFO - mozscreenshot == 0.1 23:17:03 INFO - mozsystemmonitor == 0.3 23:17:03 INFO - moztest == 0.7 23:17:03 INFO - mozversion == 1.4 23:17:03 INFO - psutil == 3.1.1 23:17:03 INFO - requests == 1.2.3 23:17:03 INFO - wsgiref == 0.1.2 23:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:17:03 INFO - Using env: {'DISPLAY': ':0', 23:17:03 INFO - 'HOME': '/home/cltbld', 23:17:03 INFO - 'LANG': 'en_US.UTF-8', 23:17:03 INFO - 'LANGUAGE': 'en_US:en', 23:17:03 INFO - 'LOGNAME': 'cltbld', 23:17:03 INFO - 'MAIL': '/var/mail/cltbld', 23:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:03 INFO - 'MOZ_NO_REMOTE': '1', 23:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:03 INFO - 'NO_EM_RESTART': '1', 23:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:03 INFO - 'PWD': '/builds/slave/test', 23:17:03 INFO - 'SHELL': '/bin/bash', 23:17:03 INFO - 'SHLVL': '1', 23:17:03 INFO - 'TERM': 'linux', 23:17:03 INFO - 'TMOUT': '86400', 23:17:03 INFO - 'USER': 'cltbld', 23:17:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:03 INFO - '_': '/tools/buildbot/bin/python'} 23:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:17:03 INFO - Cleaning up... 23:17:03 INFO - Return code: 0 23:17:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:03 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 0x7ff2f01bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:17:03 INFO - Using env: {'DISPLAY': ':0', 23:17:03 INFO - 'HOME': '/home/cltbld', 23:17:03 INFO - 'LANG': 'en_US.UTF-8', 23:17:03 INFO - 'LANGUAGE': 'en_US:en', 23:17:03 INFO - 'LOGNAME': 'cltbld', 23:17:03 INFO - 'MAIL': '/var/mail/cltbld', 23:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:03 INFO - 'MOZ_NO_REMOTE': '1', 23:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:03 INFO - 'NO_EM_RESTART': '1', 23:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:03 INFO - 'PWD': '/builds/slave/test', 23:17:03 INFO - 'SHELL': '/bin/bash', 23:17:03 INFO - 'SHLVL': '1', 23:17:03 INFO - 'TERM': 'linux', 23:17:03 INFO - 'TMOUT': '86400', 23:17:03 INFO - 'USER': 'cltbld', 23:17:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:03 INFO - '_': '/tools/buildbot/bin/python'} 23:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:17:03 INFO - Cleaning up... 23:17:03 INFO - Return code: 0 23:17:03 INFO - Running post-action listener: _resource_record_post_action 23:17:03 INFO - Running post-action listener: _start_resource_monitoring 23:17:03 INFO - Starting resource monitoring. 23:17:03 INFO - [mozharness: 2016-08-22 06:17:03.927728Z] Finished create-virtualenv step (success) 23:17:03 INFO - [mozharness: 2016-08-22 06:17:03.928168Z] Running install step. 23:17:03 INFO - Running pre-action listener: _resource_record_pre_action 23:17:03 INFO - Running main action method: install 23:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:04 INFO - Reading from file tmpfile_stdout 23:17:04 INFO - Detecting whether we're running mozinstall >=1.0... 23:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:17:04 INFO - Reading from file tmpfile_stdout 23:17:04 INFO - Output received: 23:17:04 INFO - Usage: mozinstall [options] installer 23:17:04 INFO - Options: 23:17:04 INFO - -h, --help show this help message and exit 23:17:04 INFO - -d DEST, --destination=DEST 23:17:04 INFO - Directory to install application into. [default: 23:17:04 INFO - "/builds/slave/test"] 23:17:04 INFO - --app=APP Application being installed. [default: firefox] 23:17:04 INFO - mkdir: /builds/slave/test/build/application 23:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:17:21 INFO - Reading from file tmpfile_stdout 23:17:21 INFO - Output received: 23:17:21 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:21 INFO - Running post-action listener: _resource_record_post_action 23:17:21 INFO - [mozharness: 2016-08-22 06:17:21.237188Z] Finished install step (success) 23:17:21 INFO - [mozharness: 2016-08-22 06:17:21.237431Z] Running run-tests step. 23:17:21 INFO - Running pre-action listener: _resource_record_pre_action 23:17:21 INFO - Running main action method: run_tests 23:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:21 INFO - Python 2.7.3 23:17:21 INFO - Return code: 0 23:17:21 INFO - grabbing minidump binary from tooltool 23:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:21 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 0x2156370>, '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 0x21598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2159d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:17:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:17:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:17:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:21 INFO - Return code: 0 23:17:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:21 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/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:17:21 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/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:17:21 INFO - Using env: {'DISPLAY': ':0', 23:17:21 INFO - 'HOME': '/home/cltbld', 23:17:21 INFO - 'LANG': 'en_US.UTF-8', 23:17:21 INFO - 'LANGUAGE': 'en_US:en', 23:17:21 INFO - 'LOGNAME': 'cltbld', 23:17:21 INFO - 'MAIL': '/var/mail/cltbld', 23:17:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:21 INFO - 'MOZ_NO_REMOTE': '1', 23:17:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:21 INFO - 'NO_EM_RESTART': '1', 23:17:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:21 INFO - 'PWD': '/builds/slave/test', 23:17:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:21 INFO - 'SHELL': '/bin/bash', 23:17:21 INFO - 'SHLVL': '1', 23:17:21 INFO - 'TERM': 'linux', 23:17:21 INFO - 'TMOUT': '86400', 23:17:21 INFO - 'USER': 'cltbld', 23:17:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667', 23:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:21 INFO - '_': '/tools/buildbot/bin/python'} 23:17:21 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/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:17:21 INFO - mozversion application_buildid: 20160821203026 23:17:21 INFO - mozversion application_changeset: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 23:17:21 INFO - mozversion application_display_name: Nightly 23:17:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:21 INFO - mozversion application_name: Firefox 23:17:21 INFO - mozversion application_remotingname: firefox 23:17:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:17:21 INFO - mozversion application_vendor: Mozilla 23:17:21 INFO - mozversion application_version: 51.0a1 23:17:21 INFO - mozversion platform_buildid: 20160821203026 23:17:21 INFO - mozversion platform_changeset: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 23:17:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:17:21 INFO - mozversion platform_version: 51.0a1 23:17:21 INFO - using testdate: 1471846641 23:17:21 INFO - actual date: 1471846641 23:17:21 INFO - starting webserver on 'localhost:59312' 23:17:21 INFO - SUITE-START | Running 2 tests 23:17:21 INFO - TEST-START | dromaeo_css 23:17:21 INFO - operating with platform_type : linux_ 23:17:21 INFO - Initialising browser for dromaeo_css test... 23:17:21 INFO - TEST-INFO | started process 31716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgg6bRc/profile http://localhost:59312/getInfo.html) 23:17:25 INFO - PROCESS | 31716 | __metrics Screen width/height:1600/1200 23:17:25 INFO - PROCESS | 31716 | colorDepth:24 23:17:25 INFO - PROCESS | 31716 | Browser inner width/height: 1024/697 23:17:25 INFO - PROCESS | 31716 | __metrics 23:17:26 INFO - PROCESS | 31716 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:17:26 INFO - PROCESS | 31716 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:26 INFO - PROCESS | 31716 | console.error: PushService: 23:17:26 INFO - PROCESS | 31716 | stateChangeProcessEnqueue: Error transitioning state 23:17:26 INFO - PROCESS | 31716 | UnknownError 23:17:27 INFO - TEST-INFO | 31716: exit 0 23:17:27 INFO - Browser initialized. 23:17:27 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:27 INFO - TEST-INFO | started process 31799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgg6bRc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:39 INFO - PROCESS | 31799 | RSS: Main: 174792704 23:17:39 INFO - PROCESS | 31799 | 23:18:31 INFO - PROCESS | 31799 | 1471846711187 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:20:40 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:59312/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59312/tests/dromaeo/cssquery-ext.html) 23:20:41 INFO - PROCESS | 31799 | RSS: Main: 285335552 23:20:41 INFO - PROCESS | 31799 | 23:23:43 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:59312/tests/dromaeo/cssquery-ext.html (next: http://localhost:59312/tests/dromaeo/cssquery-jquery.html) 23:23:44 INFO - PROCESS | 31799 | RSS: Main: 273829888 23:23:44 INFO - PROCESS | 31799 | 23:26:46 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:59312/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59312/tests/dromaeo/cssquery-mootools.html) 23:26:47 INFO - PROCESS | 31799 | RSS: Main: 216002560 23:26:47 INFO - PROCESS | 31799 | 23:29:49 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:59312/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59312/tests/dromaeo/cssquery-prototype.html) 23:29:49 INFO - PROCESS | 31799 | RSS: Main: 263311360 23:29:49 INFO - PROCESS | 31799 | 23:32:52 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:59312/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59312/tests/dromaeo/cssquery-yui.html) 23:32:53 INFO - PROCESS | 31799 | RSS: Main: 217468928 23:32:53 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | Cycle 1(1): loaded http://localhost:59312/tests/dromaeo/cssquery-yui.html (next: http://localhost:59312/tests/dromaeo/cssquery-dojo.html) 23:35:56 INFO - PROCESS | 31799 | RSS: Main: 306065408 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | __start_tp_report 23:35:56 INFO - PROCESS | 31799 | _x_x_mozilla_page_load 23:35:56 INFO - PROCESS | 31799 | _x_x_mozilla_page_load_details 23:35:56 INFO - PROCESS | 31799 | |i|pagename|runs| 23:35:56 INFO - PROCESS | 31799 | |0;dojo.html;3032.393521295741;3074.8308843013633;3080.2453398917255;3084.984575077124;3096.721295083442;5217.321748172732;5265.86835329117;5275.551578115865;5359.249705041292;5386.838394848151;5277.12927366985;5299.655522391042;5307;5336.092864213083;5457.290552228214;4786.880327991811;4825.855224343267;4892.315075889378;4917.45907950127;4970.776315065831;4921.2618107284015;4922.753862306889;4948.925766113512;4970.577500912409;4981.9252711209365;4664.207084795576;4788.401449818773;4822.855314340575;4840.370751802261;4849.878753031167;4720.929186062178;4763.76181190939;4765.642576806718;4773.355596994396;4846.103470857903;4842.903141937177;4846.830360937351;4849.054434385296;4871.561559459666;4872.829450969199;5094.61790365724;5135.229715542699;5168.5606723428555;5193.143131383317;5329;5583.330000399978;5620.381758006616;5620.718964051822;5623.240862483553;5627.212190293362;5660.688662123582;5664.2070110184195;5665.2351932489;5681.460261275213;5682.346530149003;5146.871328216787;5170.784865556591;5258.553022993088;5264.42091369949;5334.653247538898;5898.941010589925;5911.556633252438;5919.3192782829665;5920.79277225295;5921.644701317849;5659.6321239119325;5660.801871934545;5662.094064949588;5663.773449061991;5665.971670141623;5429;5550.222968784374;5587.580931430159;5590.301212348457;5690.77236910519;5659.547236221092;5682.659040457585;5688.914666280009;5692.516136128393;5692.829215123553;5673.971630141823;5709.457601527848;5725.312962444534;5727.198192253088;5735.397783232784;4182.414461975326;4309.762963037063;4342.5874541918465;4351.238533256731;4394.582514661102;3886.7667939923695;3904.277708623857;3905;3910.100676844285;3913.491246137984;5392.703401312965;5401.0016293971485;5404.405515393303;5409.540189083972;5410.567154627621;5521.779128834882;5606.103023516218;5622.409646987089;5629.211910332557;5728.054870946247;5370.946290537045;5399.082156033483;5400.675959442446;5401.837944861661;5410.377806552218;4948.703077815343;4958.8760280993265;4962.33008543842;4964.826231081967;4969.403671559364;5631.802886898939;5741.052726300114;5750.712464376765;5777.988851950808;5888.823335299948;5671.943280567307;5691.573132015033;5702.657840529581;5703.62926409782;5704.1443783432815;5890.52875769946;5922.437368449991;5922.763089476372;5925.7925972592475;5940.287165540163;5381.515663590139;5504.366997795145;5518.365387980433;5552.7778888843995;5581.972090139523;5717.285339332583;5743.4543718346695;5750.338711048283;5755.53955683536;5759;5531.1426728857095;5535.335759708861;5538.6399884007415;5543.113101903676;5571.637843540157;5354.303940487712;5359.866003349947;5376.784928602812;5378.865528361822;5550.500454959073;5470.972645136908;5472.042392581362;5477.315335583052;5481.835544933659;5487.396386397573;5493.890122197614;5511.134210210588;5547.140193270049;5547.389787123332;5554;5301.973490132525;5319.734013299242;5324.334458192726;5329.1206950852675;5358.678479291255 23:35:56 INFO - PROCESS | 31799 | |1;ext.html;571.8513186571492;598.488292509904;608.1334098909053;610.6061590274272;627.2128478759157;42825;43675.56324436755;43698;43758.124837503274;43765;45773.31340029894;46178.769106154505;46272.06687431572;46289.537104628944;46303.76848115763;8067.354611631055;8924.375293729425;9057.184853363196;10753.472933860536;11015.228933974626;10877.347359158437;10983.560657573687;10987.285826421297;11011.944940275327;11015.063719583844;11048.834267485994;11070.667879963614;11087.445627718622;11094.1124710023;11102.55589776412;11057.723556911062;11059.059979901638;11101.278416902875;11108.16688748339;11113.777724445546;10828.40443775592;10897.455127243606;10900.454977251105;10905.618303359344;10906.5092070857;41930;41954.580454195675;42235.36646950298;42323.788381058206;42395.364069538984;3615.258871931248;3627.72792040598;3654.177809992757;3749.8687545936036;3976.4234186042863;33338.833305833556;33355.666443335496;33942.660573394445;34130;34898.127546811535;4351.630111440531;4380.8685739427865;4421.977890110561;4424.602582096532;4448.866534003985;367132;368453;369675;369701;370366;60404.39595604075;60705.69647151824;61157;61175.38824611697;61248.38751612427;64080;64159;64195.358046419875;64290.357096429376;64351.35648643454;17593.648127037388;17892.642147157243;17913.641727165385;17915.910420447814;17919;13709.725805483835;13834.723305533833;13836.654083647789;13841.100328478617;13844.723105537832;17299.56751081233;18179.545511362056;18216.36242731498;18261;18272.817271827378;5912.438318359749;6059.21230240066;6075.27096748393;6195.783147589903;6248.500119990481;926.092429419173;979.9265055120894;984.4733067808831;1031.185363562792;1079.1852151625471;32353.35293294168;32632.83683581567;32714.34571308608;32714.781394934478;33473.83263083669;832.2385017708729;1087.5377964365114;1105.2649987758211;1151.7581307925261;1197.1380605963693;17038.74441883373;17360.82639173592;17458.47624571265;17458.738118928228;17591.73612395815;554452;557382;557407;557897;558659;58924.41075589275;59008;59099.113513297336;59149.112763308585;59258.40741592615;1317.6244770240628;1343.8320209973754;1352.4776292215145;1353.7157196988546;1355.986440135586;30454.39091218119;31932.36135277235;32619;32758.508622370206;33579.83210083934;52186.73906630443;52615.473845261055;52713.20930186127;52719.20921186109;52796.04029697865;440852;443655;443705;444787;447281;31825;42004;42144;42311.576884231996;42757.35863962105;49617.28635779595;49668.50331496639;49811.50188498069;49960.50039499704;50098.749506252236;41009.17981640291;41194.58805412027;41708.620594837106;42349.15301693887;43830.780846095564;41508.792456037525;41861.79069104635;42124;43535.346969794846;44336.77831610951;37270.813645931594;39738.60261397465;41756.373654395815;42109;43562.12875742404;35122.82438587791;35958.38187281526;37295.81352093222;37310.81344593368;37337.43993840149;28998.56502152427;29026.27434314159;29399;29622.259443514085;29777.85111074431 23:35:56 INFO - PROCESS | 31799 | |2;jquery.html;373.382052702777;385.9093113118415;407.1734379210203;407.25065878783033;415.7900260368514;14150.50473233437;18007.639847203063;19997.300094496695;20001.899990500046;20567.485812854648;16831.74752378715;17007.48977530673;19651.213951441925;19760;19778.505537361572;5488.807891723781;5571.470710282517;5646.774129034834;5666.405027472118;5683.460071293221;5707.315122185343;5882.970585147068;5888.882222355551;5903.35063143054;5905.527557795387;5677.148427735852;5896.351401345849;5905.261842269716;5948.732307046172;5948.851278718023;6019.247594050744;6046.395360463963;6049.122877182828;6060;6061;5177.197534382177;5383.865403364908;5417.052015897202;5458.181272809071;5868.589198756089;14144.929275353661;14408.639784005483;14794.410978078793;23531;23793.762062379326;2234.318532847481;2255.5263394687136;2374.5725769361507;2739.411026629264;2922.4593450211564;10932.672019839338;12034.759304813942;12184.329861857594;14041.859581404158;14439.205843678594;1823.525883270346;1910.5414700471927;1943.2227109156308;1947.9026048697651;1959.9412017639493;67128;68140.6592967037;76707.61646191789;83023.01861888246;87584.5620771892;10908.34549927007;11022.338659680445;11068.723281918017;11443.25618834773;11547.86364522566;15835.920820395824;15836.416358364071;15847;15866.127362994916;15890.76163857543;8119.837603247902;8304.418690691715;8306.127856575093;8426.115257897955;8501.702440414556;7642.197569255148;7723.575203363869;7848.84302313962;8140.633671484798;8148.837023259502;4800.615950723934;4807.206810876166;4857.052874689472;4886.218205087169;4984.22744474607;1964.479412955568;2025.7163997040427;2044.877307361563;2050.374635736085;2070.109852763296;969.2246203037541;985.522021819417;1015.9789411641401;1028.5217373921162;1040.2406243442329;19802.60394792096;20432;20441.182352705724;20668.896655516626;20993.16027358919;980.8430651095933;992.1417973452911;993.2600212841479;1003.9698809035741;1012.8531362952331;10320.638777642747;10797.131594065144;12333.93833030847;12382.504699812087;12417.379131043592;518754;525375;527104;533284;534735;86656;95603.52198238965;97302.51348743352;98031.50984245034;98145;1017.577705252312;1018.8217062014118;1043.0820877627639;1045.383223897904;1061.1298735037349;16744.24650890737;18014.5496362592;18146.18342174579;19106;19398.41129391067;38968.2206355877;42578.148437031705;43090.19913705599;43785.343219852366;44292.33561496645;54867.725661371434;59022;59402;59430.405695942485;60364;8508.446950948168;8558.743237702878;8943.37396382247;9086.772830679285;9142.131497507726;9874.703758887244;13078.738425231633;13179.868201318248;13448.991325650812;13467.3939672713;11682.182247242612;11700.590479333183;11815.40922953866;11844.881551184379;12224.938875305566;9777.951110244403;11513.17927107864;11580.478878450322;11922.463489143183;11973.820392693942;11844.940775296069;11867.58463453775;12170.75658486843;12443.37783110859;12612.432440540015;8731.170538798804;8844.646214151362;8891.19979201875;9040.276777857624;9150.496722680316;8999.280057595508;11871.525138994344;12128.151029428209;12142.028637708785;12229.7770222977 23:35:56 INFO - PROCESS | 31799 | |3;mootools.html;1335.4724883670956;1491.7091167222393;1506.3522685245343;1631.6002579368048;1725.8619310455165;8108.878366824495;8453.027901791296;8554.95722521388;8702.17329353712;8702.695405660803;8450.070492245863;8575.828483430327;8599.355048371366;8604.05355410906;8606.61270242839;2317.362725250561;2344.6483027545833;2344.648302754592;2345.7536958619357;2349.9647505287435;2310.364649721323;2337.532493501298;2352.9411764705933;2353.3528279723128;2355.49356888269;2330.5571941331177;2344.8827558622;2354.682117914077;2370.0756704885107;2370.6444033394955;2311.248844125666;2336.7663233676667;2342.3558521406662;2344.976550234493;2349.835511514195;2274.4882401459704;2275.3174047785596;2283.4633861042644;2284.1776960294283;2288.4507718147693;8531.488110713377;8666.306695464347;8676.392652514327;8680.826383472295;8696.78258043554;4908.410990681105;5088.465711100318;5107.029664363796;5128.410232823198;5134.0758663440565;3340.7494437917253;3453.9654603453896;3514.6309637487952;3520.190356218084;3525;1185.887340702632;1217.908656850731;1241.509603706531;1254.7741406546818;1254.974900501994;11744.882551174464;11862;11884.10869184806;11887.346195959219;11893.167478276524;4311.805968731414;4438.423005009393;4565.931511027337;4575;4586.8074300682065;9405.529723513797;9406.153446189739;9411.152996230372;9411.294152938557;9418.434893906388;4993.550580447777;5010.323606313174;5029.321041659402;5032.295478632995;5036.219385995177;4014.8193331300163;4199.202151591188;4327.1345730853955;4660.953390466052;4694.600958918462;3638.3632864248652;3671.173985853215;3734.141147536082;3746.83139258734;3775.86784462548;1104.1442881766534;1125.5104029747085;1127.672974837288;1136.244397475686;1143.8112711402525;986.161762501882;995.1242906242605;996.4121168510613;1010.0757806606872;1012.6253286283975;5921.585489015813;5944.167816505693;5968.253968253968;5969.880602387928;6131.294901086343;456.776179671965;460.1854717150625;464.6886585987329;470.3062982101373;478.81326282749757;4149.128682976549;4237.957620423818;4318.460192475941;4358.237308471005;4445.688801783844;10366.792664146675;10664.893351066545;10709.036186743231;10741.19441041925;10755.139588832875;10628.681139565826;10630.893691063146;10635.0960168385;10652.201084918663;10657.25399222047;7690.15408305086;7839.725609603636;7889.408294377945;7900.644470998704;7901.288884000468;6005.309389420273;6051.425114614105;6181.227346581677;6215.223097112861;6270.811875643738;10007.449590272605;10036.247281453774;10073.445960472245;10168.745781355525;10201.132903703268;8890.73327800167;9518.714438566854;9946.45294508809;9950.154236889946;10087.142592879687;7827.373810095292;8009.599520024092;8080.676772929252;8080.717174899086;8222.876656850272;8200.0979892213;8293.83412331762;8321.791955201168;8385.28725058377;8389.496630202208;7412.258774122544;7555.206703296295;7589.279018493235;7602.201768814195;7611.695532178873;7527.698892044257;7541.170471248049;7554;7574;7672.539647621161;6788.2193547742645;6984.895226571707;7087.50387472872;7142.785716428515;7154.821129471805;5135.3324067870935;5179.45615710345;5227.294315267391;5243.947560524346;5379.65032272901;5273.89452210946;5285.28648632445;5297.364316281916;5383.380911195262;5423.511883930308 23:35:56 INFO - PROCESS | 31799 | |4;prototype.html;331.69448778716605;339.7927264368735;345.5939271356157;350.78426767537974;352.32705532433044;5333.91999120013;5340.439253878345;5353.223782551528;5370.650907690997;5381.48875856793;5000.149974504343;5014.272930425086;5182.714950677711;5195.948040519594;5296.629235953485;4150.879262599112;4152.256052457975;4154.878182890625;4159.878461984395;4163.16820598937;4164;4178.665706743468;4183.226103170908;4184.3305071188615;4204.768737719424;3866.961330386688;3911.9413208801748;4049.5343035550845;4066.9796651016704;4139.1100913303635;4077.245709543744;4080.10237747695;4099.61053699898;4107.486564179478;4114.567970363114;3640.672339489432;3649.4525821127045;3652.981735091334;3665.321915445651;3710.9257814843822;5022;5040.395152581714;5068.26510156029;5175.456577059392;5184.351956005499;4661.137689527448;4673.415823022122;4683.437987441529;4701.764911754432;4747.053707979711;5418.322709661293;5421.891562168774;5423.891522169574;5436.374816896068;5443.292371991616;3918.921621567553;4016.116454380032;4021.2158629067344;4052.331365324718;4060.2894493463527;5614.971925140389;5618.494335509824;5623.550115990711;5635.408282130358;5637;4096.549379568245;4101;4109.671226301948;4132.91734165315;4134.049168691218;4044.292248856438;4161.542230354658;4186.434831297796;4194.224068547329;4197.895052623648;4666.416697912761;4669.089527542164;4672.649551283599;4707.129181101507;4711.764411779397;5428.4842939920645;5443.265159203457;5458.781648734085;5472.425395333512;5479.698526618829;1412.8799052080687;1433.6344232220927;1444.2129039673403;1460.6494441334216;1465.7215129125432;937.4703292639773;945.9952700236455;947.9194268487117;949.7720547068653;972.8394814855611;4636.374089497942;4644.535546445329;4685.595540192208;4711.693739906895;4742.407199100113;4604.493505714368;4868.9269660955115;4887;4905.435874874363;4941.876453088702;4600.332951722048;4618.976905115453;4649.279361698942;4663.463701674283;4668.439787225487;2586.237060067285;2595.9480810384066;2600.7139214686367;2611.5581930894673;2625.6061590761537;4686.976565117153;4925.532074452921;5029.547340739351;5050.797968081309;5105.004524117836;4876.4642385959105;5060.468650791688;5063.746812659352;5069.797208111634;5110.49240474061;4936.259561065797;5012.649114561946;5034.1625306762035;5036.370453693362;5058.3929928408825;5192.675867653724;5609.579281553818;5669.31968163823;5683.374828768915;5690.459406356389;5590;5607.271054762855;5626.578006649435;5675.404082571271;5696.515796157373;5766.221560089502;5851.941480585139;5874.236349274567;5908.172855800105;5909.674967876808;4083.3670781028986;4108.732932359387;4113.136241389342;4114.773687447099;4132.359484279941;5478.260434841245;5538.224648549126;5684.943150568607;5727.854429114111;5739.311282646109;5524.674078221278;5528.834134975958;5530.225768392348;5530.972345138249;5555.666660000251;5375.220593014069;5448.83653490396;5485.75314110858;5540.307461567304;5566.860828479321;5431.185322201702;5477.233187353694;5483.204935284281;5509.807156749494;5519.957615682063;5545.112781954868;5545.722713864371;5548.278723765885;5634.492650770531;5635.577331700057;5310.415854256106;5356.410794812489;5407.378151512627;5438.320209973754;5511.22842802016 23:35:56 INFO - PROCESS | 31799 | |5;yui.html;734.8677238097147;744.9031625888633;781.7342103684746;786.2491320788646;808.6684459371655;15354.232288385578;16275.104869232187;16382.7542586861;16495;16511.917440412795;14947;15301;15464.922675386608;15495.690086198269;15515.767263491029;802.1777677880176;825.995870020649;829.4691397505601;830.0620299062082;830.3979614779267;662.0598749775306;792.3898598079476;813.3371302388564;823.2261674026425;826.5784449930519;859.2438653984485;864.4251572704176;864.6757465950269;864.8400045991481;864.8400045991481;861.5950503263488;862.8360611483798;864.0409145848104;868.5570359116833;868.6785889220965;505.27997603414985;513.599392473871;517.1467079319116;633.7560039384824;635.4503354598286;14465.132092074404;14853.405863765436;14860.62848428787;15583.844161558352;15615.609609759733;15075.170865602387;15332.693346133126;15606.141662208574;15785;15793.210339483096;12782.366404617356;12798.872011279862;12971.67570810728;12993;13198.076134670577;3859.9228015439817;3866.2875799481076;3966.147278335143;4031.113155105872;4093.5087789465156;84858;85261.31062791545;85471.5726421364;86906;86981;11111.666650000512;11512.76974460506;11746.29522228669;11865.466054027589;11929.940350298193;22500;22705.20531781413;22767;22884.31347059591;22927.656085158735;8789.252913502296;8855.512946787989;8994.145556172152;9001.864972025425;9064.048274931169;4747.121782470254;4802.351682522884;5011.84964451067;5069.239614057921;5203.765830537635;3607.8737244196327;3740.7942563159286;3746.5316835395574;3746.644068813513;3748.6438788315068;612.8100288910452;616.5154427656552;638.3042483692797;646.0567571345794;660.3000819131639;610.6946526736632;656.3731636287334;669.3072669786748;716.5127713155;795.9761207163795;10183.867082118017;10736.463176841127;10851.131909447226;11116.777664446667;11267.718307042225;622.2968046107869;662.7779693802534;710.6553321639001;749.9887501687479;760.4486747108413;4617.676762626584;4863;4864.513548645107;4869.318295438641;4918.0901533216465;70601;73600;124191;129107;130313;105100;109069.45465272781;109147;110012;111232;95239.18516822979;95376.52311738397;95392;97181;100255;9262.045211607605;9431.764205894908;9563.09150630689;9570.760730981781;9732.854007189757;48976.51023489719;51354.74322628363;52394.476055240484;53267.60295786621;53541.19688204758;73953.63023185065;77169;78261;81670;82071.5896420514;12550.246985180918;12588.622341329774;12704.6823829405;12797.168184068007;12799.808002879778;14216.573502794932;14234.359453824396;14340.713185736435;14418.206998615176;14676.77984830207;12556.560520381743;12968.641114982578;12979.610611681665;13799.103058301178;14148.858511414754;12406.565770198;12578.371081446074;12652.620421387373;12716.109872308849;12893.41979610901;12089.75820483603;12115.333656648969;12488;13050.738985220432;13570.660733481742;11910.880891190976;11975.449329254827;12229.510819567118;12365.814512782496;13190.142640728322;11858.466369013242;12297.200681955645;12487.625371238877;12632.873671263538;12741.299228542519 23:35:56 INFO - PROCESS | 31799 | __end_tp_report 23:35:56 INFO - PROCESS | 31799 | __start_cc_report 23:35:56 INFO - PROCESS | 31799 | _x_x_mozilla_cycle_collect,988 23:35:56 INFO - PROCESS | 31799 | __end_cc_report 23:35:56 INFO - PROCESS | 31799 | __startTimestamp1471847756290__endTimestamp 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | ------- Summary: start ------- 23:35:56 INFO - PROCESS | 31799 | Number of tests: 6 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | [#0] dojo.html Cycles:165 Average:5264.33 Median:5410.38 stddev:591.38 (10.9%) stddev-sans-first:566.68 23:35:56 INFO - PROCESS | 31799 | Values: 3032.4 3074.8 3080.2 3085.0 3096.7 5217.3 5265.9 5275.6 5359.2 5386.8 5277.1 5299.7 5307.0 5336.1 5457.3 4786.9 4825.9 4892.3 4917.5 4970.8 4921.3 4922.8 4948.9 4970.6 4981.9 4664.2 4788.4 4822.9 4840.4 4849.9 4720.9 4763.8 4765.6 4773.4 4846.1 4842.9 4846.8 4849.1 4871.6 4872.8 5094.6 5135.2 5168.6 5193.1 5329.0 5583.3 5620.4 5620.7 5623.2 5627.2 5660.7 5664.2 5665.2 5681.5 5682.3 5146.9 5170.8 5258.6 5264.4 5334.7 5898.9 5911.6 5919.3 5920.8 5921.6 5659.6 5660.8 5662.1 5663.8 5666.0 5429.0 5550.2 5587.6 5590.3 5690.8 5659.5 5682.7 5688.9 5692.5 5692.8 5674.0 5709.5 5725.3 5727.2 5735.4 4182.4 4309.8 4342.6 4351.2 4394.6 3886.8 3904.3 3905.0 3910.1 3913.5 5392.7 5401.0 5404.4 5409.5 5410.6 5521.8 5606.1 5622.4 5629.2 5728.1 5370.9 5399.1 5400.7 5401.8 5410.4 4948.7 4958.9 4962.3 4964.8 4969.4 5631.8 5741.1 5750.7 5778.0 5888.8 5671.9 5691.6 5702.7 5703.6 5704.1 5890.5 5922.4 5922.8 5925.8 5940.3 5381.5 5504.4 5518.4 5552.8 5582.0 5717.3 5743.5 5750.3 5755.5 5759.0 5531.1 5535.3 5538.6 5543.1 5571.6 5354.3 5359.9 5376.8 5378.9 5550.5 5471.0 5472.0 5477.3 5481.8 5487.4 5493.9 5511.1 5547.1 5547.4 5554.0 5302.0 5319.7 5324.3 5329.1 5358.7 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | [#1] ext.html Cycles:180 Average:62736.29 Median:22492.80 stddev:122666.46 (545.4%) stddev-sans-first:122921.77 23:35:56 INFO - PROCESS | 31799 | Values: 571.9 598.5 608.1 610.6 627.2 42825.0 43675.6 43698.0 43758.1 43765.0 45773.3 46178.8 46272.1 46289.5 46303.8 8067.4 8924.4 9057.2 10753.5 11015.2 10877.3 10983.6 10987.3 11011.9 11015.1 11048.8 11070.7 11087.4 11094.1 11102.6 11057.7 11059.1 11101.3 11108.2 11113.8 10828.4 10897.5 10900.5 10905.6 10906.5 41930.0 41954.6 42235.4 42323.8 42395.4 3615.3 3627.7 3654.2 3749.9 3976.4 33338.8 33355.7 33942.7 34130.0 34898.1 4351.6 4380.9 4422.0 4424.6 4448.9 367132.0 368453.0 369675.0 369701.0 370366.0 60404.4 60705.7 61157.0 61175.4 61248.4 64080.0 64159.0 64195.4 64290.4 64351.4 17593.6 17892.6 17913.6 17915.9 17919.0 13709.7 13834.7 13836.7 13841.1 13844.7 17299.6 18179.5 18216.4 18261.0 18272.8 5912.4 6059.2 6075.3 6195.8 6248.5 926.1 979.9 984.5 1031.2 1079.2 32353.4 32632.8 32714.3 32714.8 33473.8 832.2 1087.5 1105.3 1151.8 1197.1 17038.7 17360.8 17458.5 17458.7 17591.7 554452.0 557382.0 557407.0 557897.0 558659.0 58924.4 59008.0 59099.1 59149.1 59258.4 1317.6 1343.8 1352.5 1353.7 1356.0 30454.4 31932.4 32619.0 32758.5 33579.8 52186.7 52615.5 52713.2 52719.2 52796.0 440852.0 443655.0 443705.0 444787.0 447281.0 31825.0 42004.0 42144.0 42311.6 42757.4 49617.3 49668.5 49811.5 49960.5 50098.7 41009.2 41194.6 41708.6 42349.2 43830.8 41508.8 41861.8 42124.0 43535.3 44336.8 37270.8 39738.6 41756.4 42109.0 43562.1 35122.8 35958.4 37295.8 37310.8 37337.4 28998.6 29026.3 29399.0 29622.3 29777.9 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | [#2] jquery.html Cycles:180 Average:30090.09 Median:2830.94 stddev:86843.76 (3067.7%) stddev-sans-first:87058.71 23:35:56 INFO - PROCESS | 31799 | Values: 373.4 385.9 407.2 407.3 415.8 14150.5 18007.6 19997.3 20001.9 20567.5 16831.7 17007.5 19651.2 19760.0 19778.5 5488.8 5571.5 5646.8 5666.4 5683.5 5707.3 5883.0 5888.9 5903.4 5905.5 5677.1 5896.4 5905.3 5948.7 5948.9 6019.2 6046.4 6049.1 6060.0 6061.0 5177.2 5383.9 5417.1 5458.2 5868.6 14144.9 14408.6 14794.4 23531.0 23793.8 2234.3 2255.5 2374.6 2739.4 2922.5 10932.7 12034.8 12184.3 14041.9 14439.2 1823.5 1910.5 1943.2 1947.9 1959.9 67128.0 68140.7 76707.6 83023.0 87584.6 10908.3 11022.3 11068.7 11443.3 11547.9 15835.9 15836.4 15847.0 15866.1 15890.8 8119.8 8304.4 8306.1 8426.1 8501.7 7642.2 7723.6 7848.8 8140.6 8148.8 4800.6 4807.2 4857.1 4886.2 4984.2 1964.5 2025.7 2044.9 2050.4 2070.1 969.2 985.5 1016.0 1028.5 1040.2 19802.6 20432.0 20441.2 20668.9 20993.2 980.8 992.1 993.3 1004.0 1012.9 10320.6 10797.1 12333.9 12382.5 12417.4 518754.0 525375.0 527104.0 533284.0 534735.0 86656.0 95603.5 97302.5 98031.5 98145.0 1017.6 1018.8 1043.1 1045.4 1061.1 16744.2 18014.5 18146.2 19106.0 19398.4 38968.2 42578.1 43090.2 43785.3 44292.3 54867.7 59022.0 59402.0 59430.4 60364.0 8508.4 8558.7 8943.4 9086.8 9142.1 9874.7 13078.7 13179.9 13449.0 13467.4 11682.2 11700.6 11815.4 11844.9 12224.9 9778.0 11513.2 11580.5 11922.5 11973.8 11844.9 11867.6 12170.8 12443.4 12612.4 8731.2 8844.6 8891.2 9040.3 9150.5 8999.3 11871.5 12128.2 12142.0 12229.8 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | [#3] mootools.html Cycles:180 Average:5682.98 Median:2582.45 stddev:3200.13 (123.9%) stddev-sans-first:3192.43 23:35:56 INFO - PROCESS | 31799 | Values: 1335.5 1491.7 1506.4 1631.6 1725.9 8108.9 8453.0 8555.0 8702.2 8702.7 8450.1 8575.8 8599.4 8604.1 8606.6 2317.4 2344.6 2344.6 2345.8 2350.0 2310.4 2337.5 2352.9 2353.4 2355.5 2330.6 2344.9 2354.7 2370.1 2370.6 2311.2 2336.8 2342.4 2345.0 2349.8 2274.5 2275.3 2283.5 2284.2 2288.5 8531.5 8666.3 8676.4 8680.8 8696.8 4908.4 5088.5 5107.0 5128.4 5134.1 3340.7 3454.0 3514.6 3520.2 3525.0 1185.9 1217.9 1241.5 1254.8 1255.0 11744.9 11862.0 11884.1 11887.3 11893.2 4311.8 4438.4 4565.9 4575.0 4586.8 9405.5 9406.2 9411.2 9411.3 9418.4 4993.6 5010.3 5029.3 5032.3 5036.2 4014.8 4199.2 4327.1 4661.0 4694.6 3638.4 3671.2 3734.1 3746.8 3775.9 1104.1 1125.5 1127.7 1136.2 1143.8 986.2 995.1 996.4 1010.1 1012.6 5921.6 5944.2 5968.3 5969.9 6131.3 456.8 460.2 464.7 470.3 478.8 4149.1 4238.0 4318.5 4358.2 4445.7 10366.8 10664.9 10709.0 10741.2 10755.1 10628.7 10630.9 10635.1 10652.2 10657.3 7690.2 7839.7 7889.4 7900.6 7901.3 6005.3 6051.4 6181.2 6215.2 6270.8 10007.4 10036.2 10073.4 10168.7 10201.1 8890.7 9518.7 9946.5 9950.2 10087.1 7827.4 8009.6 8080.7 8080.7 8222.9 8200.1 8293.8 8321.8 8385.3 8389.5 7412.3 7555.2 7589.3 7602.2 7611.7 7527.7 7541.2 7554.0 7574.0 7672.5 6788.2 6984.9 7087.5 7142.8 7154.8 5135.3 5179.5 5227.3 5243.9 5379.7 5273.9 5285.3 5297.4 5383.4 5423.5 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | [#4] prototype.html Cycles:180 Average:4519.32 Median:5013.46 stddev:1305.82 (26.0%) stddev-sans-first:1271.10 23:35:56 INFO - PROCESS | 31799 | Values: 331.7 339.8 345.6 350.8 352.3 5333.9 5340.4 5353.2 5370.7 5381.5 5000.1 5014.3 5182.7 5195.9 5296.6 4150.9 4152.3 4154.9 4159.9 4163.2 4164.0 4178.7 4183.2 4184.3 4204.8 3867.0 3911.9 4049.5 4067.0 4139.1 4077.2 4080.1 4099.6 4107.5 4114.6 3640.7 3649.5 3653.0 3665.3 3710.9 5022.0 5040.4 5068.3 5175.5 5184.4 4661.1 4673.4 4683.4 4701.8 4747.1 5418.3 5421.9 5423.9 5436.4 5443.3 3918.9 4016.1 4021.2 4052.3 4060.3 5615.0 5618.5 5623.6 5635.4 5637.0 4096.5 4101.0 4109.7 4132.9 4134.0 4044.3 4161.5 4186.4 4194.2 4197.9 4666.4 4669.1 4672.6 4707.1 4711.8 5428.5 5443.3 5458.8 5472.4 5479.7 1412.9 1433.6 1444.2 1460.6 1465.7 937.5 946.0 947.9 949.8 972.8 4636.4 4644.5 4685.6 4711.7 4742.4 4604.5 4868.9 4887.0 4905.4 4941.9 4600.3 4619.0 4649.3 4663.5 4668.4 2586.2 2595.9 2600.7 2611.6 2625.6 4687.0 4925.5 5029.5 5050.8 5105.0 4876.5 5060.5 5063.7 5069.8 5110.5 4936.3 5012.6 5034.2 5036.4 5058.4 5192.7 5609.6 5669.3 5683.4 5690.5 5590.0 5607.3 5626.6 5675.4 5696.5 5766.2 5851.9 5874.2 5908.2 5909.7 4083.4 4108.7 4113.1 4114.8 4132.4 5478.3 5538.2 5684.9 5727.9 5739.3 5524.7 5528.8 5530.2 5531.0 5555.7 5375.2 5448.8 5485.8 5540.3 5566.9 5431.2 5477.2 5483.2 5509.8 5520.0 5545.1 5545.7 5548.3 5634.5 5635.6 5310.4 5356.4 5407.4 5438.3 5511.2 23:35:56 INFO - PROCESS | 31799 | 23:35:56 INFO - PROCESS | 31799 | [#5] yui.html Cycles:180 Average:21692.55 Median:3916.22 stddev:31609.44 (807.1%) stddev-sans-first:31658.94 23:35:56 INFO - PROCESS | 31799 | Values: 734.9 744.9 781.7 786.2 808.7 15354.2 16275.1 16382.8 16495.0 16511.9 14947.0 15301.0 15464.9 15495.7 15515.8 802.2 826.0 829.5 830.1 830.4 662.1 792.4 813.3 823.2 826.6 859.2 864.4 864.7 864.8 864.8 861.6 862.8 864.0 868.6 868.7 505.3 513.6 517.1 633.8 635.5 14465.1 14853.4 14860.6 15583.8 15615.6 15075.2 15332.7 15606.1 15785.0 15793.2 12782.4 12798.9 12971.7 12993.0 13198.1 3859.9 3866.3 3966.1 4031.1 4093.5 84858.0 85261.3 85471.6 86906.0 86981.0 11111.7 11512.8 11746.3 11865.5 11929.9 22500.0 22705.2 22767.0 22884.3 22927.7 8789.3 8855.5 8994.1 9001.9 9064.0 4747.1 4802.4 5011.8 5069.2 5203.8 3607.9 3740.8 3746.5 3746.6 3748.6 612.8 616.5 638.3 646.1 660.3 610.7 656.4 669.3 716.5 796.0 10183.9 10736.5 10851.1 11116.8 11267.7 622.3 662.8 710.7 750.0 760.4 4617.7 4863.0 4864.5 4869.3 4918.1 70601.0 73600.0 124191.0 129107.0 130313.0 105100.0 109069.5 109147.0 110012.0 111232.0 95239.2 95376.5 95392.0 97181.0 100255.0 9262.0 9431.8 9563.1 9570.8 9732.9 48976.5 51354.7 52394.5 53267.6 53541.2 73953.6 77169.0 78261.0 81670.0 82071.6 12550.2 12588.6 12704.7 12797.2 12799.8 14216.6 14234.4 14340.7 14418.2 14676.8 12556.6 12968.6 12979.6 13799.1 14148.9 12406.6 12578.4 12652.6 12716.1 12893.4 12089.8 12115.3 12488.0 13050.7 13570.7 11910.9 11975.4 12229.5 12365.8 13190.1 11858.5 12297.2 12487.6 12632.9 12741.3 23:35:56 INFO - PROCESS | 31799 | -------- Summary: end -------- 23:35:56 INFO - PROCESS | 31799 | 23:35:57 INFO - TEST-INFO | 31799: exit 0 23:35:57 INFO - TEST-OK | dromaeo_css | took 1115721ms 23:35:57 INFO - TEST-START | kraken 23:35:57 INFO - operating with platform_type : linux_ 23:35:57 INFO - Initialising browser for kraken test... 23:35:57 INFO - TEST-INFO | started process 32110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdtv8E/profile http://localhost:59312/getInfo.html) 23:36:01 INFO - PROCESS | 32110 | __metrics Screen width/height:1600/1200 23:36:01 INFO - PROCESS | 32110 | colorDepth:24 23:36:01 INFO - PROCESS | 32110 | Browser inner width/height: 1024/697 23:36:01 INFO - PROCESS | 32110 | __metrics 23:36:02 INFO - PROCESS | 32110 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:36:02 INFO - PROCESS | 32110 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:36:02 INFO - PROCESS | 32110 | console.error: PushService: 23:36:02 INFO - PROCESS | 32110 | stateChangeProcessEnqueue: Error transitioning state 23:36:02 INFO - PROCESS | 32110 | UnknownError 23:36:03 INFO - TEST-INFO | 32110: exit 0 23:36:03 INFO - Browser initialized. 23:36:03 INFO - Running cycle 1/1 for kraken test... 23:36:03 INFO - TEST-INFO | started process 32190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdtv8E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:15 INFO - PROCESS | 32190 | RSS: Main: 174067712 23:36:15 INFO - PROCESS | 32190 | 23:36:17 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59312/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:18 INFO - PROCESS | 32190 | RSS: Main: 235225088 23:36:18 INFO - PROCESS | 32190 | 23:36:21 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59312/tests/kraken/driver.html?testName=audio-dft) 23:36:22 INFO - PROCESS | 32190 | RSS: Main: 225828864 23:36:22 INFO - PROCESS | 32190 | 23:36:25 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59312/tests/kraken/driver.html?testName=audio-fft) 23:36:25 INFO - PROCESS | 32190 | RSS: Main: 302272512 23:36:25 INFO - PROCESS | 32190 | 23:36:28 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59312/tests/kraken/driver.html?testName=audio-oscillator) 23:36:28 INFO - PROCESS | 32190 | RSS: Main: 209915904 23:36:28 INFO - PROCESS | 32190 | 23:36:30 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59312/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:31 INFO - PROCESS | 32190 | RSS: Main: 213438464 23:36:31 INFO - PROCESS | 32190 | 23:36:34 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59312/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:35 INFO - PROCESS | 32190 | RSS: Main: 249622528 23:36:35 INFO - PROCESS | 32190 | 23:36:38 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59312/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:39 INFO - PROCESS | 32190 | RSS: Main: 248868864 23:36:39 INFO - PROCESS | 32190 | 23:36:41 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59312/tests/kraken/driver.html?testName=json-parse-financial) 23:36:42 INFO - PROCESS | 32190 | RSS: Main: 248426496 23:36:42 INFO - PROCESS | 32190 | 23:36:44 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59312/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:44 INFO - PROCESS | 32190 | RSS: Main: 211447808 23:36:44 INFO - PROCESS | 32190 | 23:36:46 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:47 INFO - PROCESS | 32190 | RSS: Main: 220024832 23:36:47 INFO - PROCESS | 32190 | 23:36:49 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:49 INFO - PROCESS | 32190 | RSS: Main: 223817728 23:36:49 INFO - PROCESS | 32190 | 23:36:52 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:53 INFO - PROCESS | 32190 | RSS: Main: 218439680 23:36:53 INFO - PROCESS | 32190 | 23:36:55 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:56 INFO - PROCESS | 32190 | RSS: Main: 222089216 23:36:56 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | Cycle 1(1): loaded http://localhost:59312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59312/tests/kraken/driver.html?testName=ai-astar) 23:36:58 INFO - PROCESS | 32190 | RSS: Main: 273076224 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | __start_tp_report 23:36:58 INFO - PROCESS | 32190 | _x_x_mozilla_page_load 23:36:58 INFO - PROCESS | 32190 | _x_x_mozilla_page_load_details 23:36:58 INFO - PROCESS | 32190 | |i|pagename|runs| 23:36:58 INFO - PROCESS | 32190 | |0;ai-astar;100;112;107;110;112;111;118;110;111;111 23:36:58 INFO - PROCESS | 32190 | |1;audio-beat-detection;148;131;146;178;123;156;146;122;180;119 23:36:58 INFO - PROCESS | 32190 | |2;audio-dft;160;160;160;160;161;161;160;161;161;160 23:36:58 INFO - PROCESS | 32190 | |3;audio-fft;76;76;77;188;77;75;74;76;177;76 23:36:58 INFO - PROCESS | 32190 | |4;audio-oscillator;86;86;160;86;87;86;142;86;86;139 23:36:58 INFO - PROCESS | 32190 | |5;imaging-gaussian-blur;118;117;117;116;116;117;117;117;116;117 23:36:58 INFO - PROCESS | 32190 | |6;imaging-darkroom;147;146;146;146;146;146;146;147;146;147 23:36:58 INFO - PROCESS | 32190 | |7;imaging-desaturate;94;96;96;96;95;96;96;95;95;94 23:36:58 INFO - PROCESS | 32190 | |8;json-parse-financial;51;50;52;50;51;62;51;53;51;52 23:36:58 INFO - PROCESS | 32190 | |9;json-stringify-tinderbox;61;62;62;61;62;61;62;62;62;62 23:36:58 INFO - PROCESS | 32190 | |10;stanford-crypto-aes;88;79;87;80;81;78;79;79;78;79 23:36:58 INFO - PROCESS | 32190 | |11;stanford-crypto-ccm;123;130;122;122;123;122;124;121;138;124 23:36:58 INFO - PROCESS | 32190 | |12;stanford-crypto-pbkdf2;166;166;163;167;163;166;165;162;164;163 23:36:58 INFO - PROCESS | 32190 | |13;stanford-crypto-sha256-iterative;67;66;66;65;67;66;64;63;64;64 23:36:58 INFO - PROCESS | 32190 | __end_tp_report 23:36:58 INFO - PROCESS | 32190 | __start_cc_report 23:36:58 INFO - PROCESS | 32190 | _x_x_mozilla_cycle_collect,1688 23:36:58 INFO - PROCESS | 32190 | __end_cc_report 23:36:58 INFO - PROCESS | 32190 | __startTimestamp1471847818519__endTimestamp 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | ------- Summary: start ------- 23:36:58 INFO - PROCESS | 32190 | Number of tests: 14 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:4.52 (4.1%) stddev-sans-first:2.92 23:36:58 INFO - PROCESS | 32190 | Values: 100.0 112.0 107.0 110.0 112.0 111.0 118.0 110.0 111.0 111.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:147.00 stddev:21.94 (14.9%) stddev-sans-first:23.24 23:36:58 INFO - PROCESS | 32190 | Values: 148.0 131.0 146.0 178.0 123.0 156.0 146.0 122.0 180.0 119.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 23:36:58 INFO - PROCESS | 32190 | Values: 160.0 160.0 160.0 160.0 161.0 161.0 160.0 161.0 161.0 160.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#3] audio-fft Cycles:10 Average:97.20 Median:76.00 stddev:45.04 (59.3%) stddev-sans-first:47.11 23:36:58 INFO - PROCESS | 32190 | Values: 76.0 76.0 77.0 188.0 77.0 75.0 74.0 76.0 177.0 76.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:86.00 stddev:29.88 (34.7%) stddev-sans-first:30.94 23:36:58 INFO - PROCESS | 32190 | Values: 86.0 86.0 160.0 86.0 87.0 86.0 142.0 86.0 86.0 139.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 23:36:58 INFO - PROCESS | 32190 | Values: 118.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 23:36:58 INFO - PROCESS | 32190 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 23:36:58 INFO - PROCESS | 32190 | Values: 94.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 94.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:51.50 stddev:3.53 (6.9%) stddev-sans-first:3.71 23:36:58 INFO - PROCESS | 32190 | Values: 51.0 50.0 52.0 50.0 51.0 62.0 51.0 53.0 51.0 52.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 23:36:58 INFO - PROCESS | 32190 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 62.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:79.50 stddev:3.65 (4.6%) stddev-sans-first:2.78 23:36:58 INFO - PROCESS | 32190 | Values: 88.0 79.0 87.0 80.0 81.0 78.0 79.0 79.0 78.0 79.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:123.50 stddev:5.24 (4.2%) stddev-sans-first:5.51 23:36:58 INFO - PROCESS | 32190 | Values: 123.0 130.0 122.0 122.0 123.0 122.0 124.0 121.0 138.0 124.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.50 stddev:1.72 (1.0%) stddev-sans-first:1.73 23:36:58 INFO - PROCESS | 32190 | Values: 166.0 166.0 163.0 167.0 163.0 166.0 165.0 162.0 164.0 163.0 23:36:58 INFO - PROCESS | 32190 | 23:36:58 INFO - PROCESS | 32190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.32 23:36:58 INFO - PROCESS | 32190 | Values: 67.0 66.0 66.0 65.0 67.0 66.0 64.0 63.0 64.0 64.0 23:36:58 INFO - PROCESS | 32190 | -------- Summary: end -------- 23:36:58 INFO - PROCESS | 32190 | 23:36:59 INFO - TEST-INFO | 32190: exit 0 23:36:59 INFO - TEST-OK | kraken | took 62471ms 23:36:59 INFO - SUITE-END | took 1178s 23:37:00 INFO - Completed test suite (00:19:38) 23:37:00 INFO - javascript benchmark 23:37:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.393521295741, 3074.8308843013633, 3080.2453398917255, 3084.984575077124, 3096.721295083442, 5217.321748172732, 5265.86835329117, 5275.551578115865, 5359.249705041292, 5386.838394848151, 5277.12927366985, 5299.655522391042, 5307.0, 5336.092864213083, 5457.290552228214, 4786.880327991811, 4825.855224343267, 4892.315075889378, 4917.45907950127, 4970.776315065831, 4921.2618107284015, 4922.753862306889, 4948.925766113512, 4970.577500912409, 4981.9252711209365, 4664.207084795576, 4788.401449818773, 4822.855314340575, 4840.370751802261, 4849.878753031167, 4720.929186062178, 4763.76181190939, 4765.642576806718, 4773.355596994396, 4846.103470857903, 4842.903141937177, 4846.830360937351, 4849.054434385296, 4871.561559459666, 4872.829450969199, 5094.61790365724, 5135.229715542699, 5168.5606723428555, 5193.143131383317, 5329.0, 5583.330000399978, 5620.381758006616, 5620.718964051822, 5623.240862483553, 5627.212190293362, 5660.688662123582, 5664.2070110184195, 5665.2351932489, 5681.460261275213, 5682.346530149003, 5146.871328216787, 5170.784865556591, 5258.553022993088, 5264.42091369949, 5334.653247538898, 5898.941010589925, 5911.556633252438, 5919.3192782829665, 5920.79277225295, 5921.644701317849, 5659.6321239119325, 5660.801871934545, 5662.094064949588, 5663.773449061991, 5665.971670141623, 5429.0, 5550.222968784374, 5587.580931430159, 5590.301212348457, 5690.77236910519, 5659.547236221092, 5682.659040457585, 5688.914666280009, 5692.516136128393, 5692.829215123553, 5673.971630141823, 5709.457601527848, 5725.312962444534, 5727.198192253088, 5735.397783232784, 4182.414461975326, 4309.762963037063, 4342.5874541918465, 4351.238533256731, 4394.582514661102, 3886.7667939923695, 3904.277708623857, 3905.0, 3910.100676844285, 3913.491246137984, 5392.703401312965, 5401.0016293971485, 5404.405515393303, 5409.540189083972, 5410.567154627621, 5521.779128834882, 5606.103023516218, 5622.409646987089, 5629.211910332557, 5728.054870946247, 5370.946290537045, 5399.082156033483, 5400.675959442446, 5401.837944861661, 5410.377806552218, 4948.703077815343, 4958.8760280993265, 4962.33008543842, 4964.826231081967, 4969.403671559364, 5631.802886898939, 5741.052726300114, 5750.712464376765, 5777.988851950808, 5888.823335299948, 5671.943280567307, 5691.573132015033, 5702.657840529581, 5703.62926409782, 5704.1443783432815, 5890.52875769946, 5922.437368449991, 5922.763089476372, 5925.7925972592475, 5940.287165540163, 5381.515663590139, 5504.366997795145, 5518.365387980433, 5552.7778888843995, 5581.972090139523, 5717.285339332583, 5743.4543718346695, 5750.338711048283, 5755.53955683536, 5759.0, 5531.1426728857095, 5535.335759708861, 5538.6399884007415, 5543.113101903676, 5571.637843540157, 5354.303940487712, 5359.866003349947, 5376.784928602812, 5378.865528361822, 5550.500454959073, 5470.972645136908, 5472.042392581362, 5477.315335583052, 5481.835544933659, 5487.396386397573, 5493.890122197614, 5511.134210210588, 5547.140193270049, 5547.389787123332, 5554.0, 5301.973490132525, 5319.734013299242, 5324.334458192726, 5329.1206950852675, 5358.678479291255], "value": 5224.8258557110685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.8513186571492, 598.488292509904, 608.1334098909053, 610.6061590274272, 627.2128478759157, 42825.0, 43675.56324436755, 43698.0, 43758.124837503274, 43765.0, 45773.31340029894, 46178.769106154505, 46272.06687431572, 46289.537104628944, 46303.76848115763, 8067.354611631055, 8924.375293729425, 9057.184853363196, 10753.472933860536, 11015.228933974626, 10877.347359158437, 10983.560657573687, 10987.285826421297, 11011.944940275327, 11015.063719583844, 11048.834267485994, 11070.667879963614, 11087.445627718622, 11094.1124710023, 11102.55589776412, 11057.723556911062, 11059.059979901638, 11101.278416902875, 11108.16688748339, 11113.777724445546, 10828.40443775592, 10897.455127243606, 10900.454977251105, 10905.618303359344, 10906.5092070857, 41930.0, 41954.580454195675, 42235.36646950298, 42323.788381058206, 42395.364069538984, 3615.258871931248, 3627.72792040598, 3654.177809992757, 3749.8687545936036, 3976.4234186042863, 33338.833305833556, 33355.666443335496, 33942.660573394445, 34130.0, 34898.127546811535, 4351.630111440531, 4380.8685739427865, 4421.977890110561, 4424.602582096532, 4448.866534003985, 367132.0, 368453.0, 369675.0, 369701.0, 370366.0, 60404.39595604075, 60705.69647151824, 61157.0, 61175.38824611697, 61248.38751612427, 64080.0, 64159.0, 64195.358046419875, 64290.357096429376, 64351.35648643454, 17593.648127037388, 17892.642147157243, 17913.641727165385, 17915.910420447814, 17919.0, 13709.725805483835, 13834.723305533833, 13836.654083647789, 13841.100328478617, 13844.723105537832, 17299.56751081233, 18179.545511362056, 18216.36242731498, 18261.0, 18272.817271827378, 5912.438318359749, 6059.21230240066, 6075.27096748393, 6195.783147589903, 6248.500119990481, 926.092429419173, 979.9265055120894, 984.4733067808831, 1031.185363562792, 1079.1852151625471, 32353.35293294168, 32632.83683581567, 32714.34571308608, 32714.781394934478, 33473.83263083669, 832.2385017708729, 1087.5377964365114, 1105.2649987758211, 1151.7581307925261, 1197.1380605963693, 17038.74441883373, 17360.82639173592, 17458.47624571265, 17458.738118928228, 17591.73612395815, 554452.0, 557382.0, 557407.0, 557897.0, 558659.0, 58924.41075589275, 59008.0, 59099.113513297336, 59149.112763308585, 59258.40741592615, 1317.6244770240628, 1343.8320209973754, 1352.4776292215145, 1353.7157196988546, 1355.986440135586, 30454.39091218119, 31932.36135277235, 32619.0, 32758.508622370206, 33579.83210083934, 52186.73906630443, 52615.473845261055, 52713.20930186127, 52719.20921186109, 52796.04029697865, 440852.0, 443655.0, 443705.0, 444787.0, 447281.0, 31825.0, 42004.0, 42144.0, 42311.576884231996, 42757.35863962105, 49617.28635779595, 49668.50331496639, 49811.50188498069, 49960.50039499704, 50098.749506252236, 41009.17981640291, 41194.58805412027, 41708.620594837106, 42349.15301693887, 43830.780846095564, 41508.792456037525, 41861.79069104635, 42124.0, 43535.346969794846, 44336.77831610951, 37270.813645931594, 39738.60261397465, 41756.373654395815, 42109.0, 43562.12875742404, 35122.82438587791, 35958.38187281526, 37295.81352093222, 37310.81344593368, 37337.43993840149, 28998.56502152427, 29026.27434314159, 29399.0, 29622.259443514085, 29777.85111074431], "value": 21142.48412998282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.382052702777, 385.9093113118415, 407.1734379210203, 407.25065878783033, 415.7900260368514, 14150.50473233437, 18007.639847203063, 19997.300094496695, 20001.899990500046, 20567.485812854648, 16831.74752378715, 17007.48977530673, 19651.213951441925, 19760.0, 19778.505537361572, 5488.807891723781, 5571.470710282517, 5646.774129034834, 5666.405027472118, 5683.460071293221, 5707.315122185343, 5882.970585147068, 5888.882222355551, 5903.35063143054, 5905.527557795387, 5677.148427735852, 5896.351401345849, 5905.261842269716, 5948.732307046172, 5948.851278718023, 6019.247594050744, 6046.395360463963, 6049.122877182828, 6060.0, 6061.0, 5177.197534382177, 5383.865403364908, 5417.052015897202, 5458.181272809071, 5868.589198756089, 14144.929275353661, 14408.639784005483, 14794.410978078793, 23531.0, 23793.762062379326, 2234.318532847481, 2255.5263394687136, 2374.5725769361507, 2739.411026629264, 2922.4593450211564, 10932.672019839338, 12034.759304813942, 12184.329861857594, 14041.859581404158, 14439.205843678594, 1823.525883270346, 1910.5414700471927, 1943.2227109156308, 1947.9026048697651, 1959.9412017639493, 67128.0, 68140.6592967037, 76707.61646191789, 83023.01861888246, 87584.5620771892, 10908.34549927007, 11022.338659680445, 11068.723281918017, 11443.25618834773, 11547.86364522566, 15835.920820395824, 15836.416358364071, 15847.0, 15866.127362994916, 15890.76163857543, 8119.837603247902, 8304.418690691715, 8306.127856575093, 8426.115257897955, 8501.702440414556, 7642.197569255148, 7723.575203363869, 7848.84302313962, 8140.633671484798, 8148.837023259502, 4800.615950723934, 4807.206810876166, 4857.052874689472, 4886.218205087169, 4984.22744474607, 1964.479412955568, 2025.7163997040427, 2044.877307361563, 2050.374635736085, 2070.109852763296, 969.2246203037541, 985.522021819417, 1015.9789411641401, 1028.5217373921162, 1040.2406243442329, 19802.60394792096, 20432.0, 20441.182352705724, 20668.896655516626, 20993.16027358919, 980.8430651095933, 992.1417973452911, 993.2600212841479, 1003.9698809035741, 1012.8531362952331, 10320.638777642747, 10797.131594065144, 12333.93833030847, 12382.504699812087, 12417.379131043592, 518754.0, 525375.0, 527104.0, 533284.0, 534735.0, 86656.0, 95603.52198238965, 97302.51348743352, 98031.50984245034, 98145.0, 1017.577705252312, 1018.8217062014118, 1043.0820877627639, 1045.383223897904, 1061.1298735037349, 16744.24650890737, 18014.5496362592, 18146.18342174579, 19106.0, 19398.41129391067, 38968.2206355877, 42578.148437031705, 43090.19913705599, 43785.343219852366, 44292.33561496645, 54867.725661371434, 59022.0, 59402.0, 59430.405695942485, 60364.0, 8508.446950948168, 8558.743237702878, 8943.37396382247, 9086.772830679285, 9142.131497507726, 9874.703758887244, 13078.738425231633, 13179.868201318248, 13448.991325650812, 13467.3939672713, 11682.182247242612, 11700.590479333183, 11815.40922953866, 11844.881551184379, 12224.938875305566, 9777.951110244403, 11513.17927107864, 11580.478878450322, 11922.463489143183, 11973.820392693942, 11844.940775296069, 11867.58463453775, 12170.75658486843, 12443.37783110859, 12612.432440540015, 8731.170538798804, 8844.646214151362, 8891.19979201875, 9040.276777857624, 9150.496722680316, 8999.280057595508, 11871.525138994344, 12128.151029428209, 12142.028637708785, 12229.7770222977], "value": 9358.855785678137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.4724883670956, 1491.7091167222393, 1506.3522685245343, 1631.6002579368048, 1725.8619310455165, 8108.878366824495, 8453.027901791296, 8554.95722521388, 8702.17329353712, 8702.695405660803, 8450.070492245863, 8575.828483430327, 8599.355048371366, 8604.05355410906, 8606.61270242839, 2317.362725250561, 2344.6483027545833, 2344.648302754592, 2345.7536958619357, 2349.9647505287435, 2310.364649721323, 2337.532493501298, 2352.9411764705933, 2353.3528279723128, 2355.49356888269, 2330.5571941331177, 2344.8827558622, 2354.682117914077, 2370.0756704885107, 2370.6444033394955, 2311.248844125666, 2336.7663233676667, 2342.3558521406662, 2344.976550234493, 2349.835511514195, 2274.4882401459704, 2275.3174047785596, 2283.4633861042644, 2284.1776960294283, 2288.4507718147693, 8531.488110713377, 8666.306695464347, 8676.392652514327, 8680.826383472295, 8696.78258043554, 4908.410990681105, 5088.465711100318, 5107.029664363796, 5128.410232823198, 5134.0758663440565, 3340.7494437917253, 3453.9654603453896, 3514.6309637487952, 3520.190356218084, 3525.0, 1185.887340702632, 1217.908656850731, 1241.509603706531, 1254.7741406546818, 1254.974900501994, 11744.882551174464, 11862.0, 11884.10869184806, 11887.346195959219, 11893.167478276524, 4311.805968731414, 4438.423005009393, 4565.931511027337, 4575.0, 4586.8074300682065, 9405.529723513797, 9406.153446189739, 9411.152996230372, 9411.294152938557, 9418.434893906388, 4993.550580447777, 5010.323606313174, 5029.321041659402, 5032.295478632995, 5036.219385995177, 4014.8193331300163, 4199.202151591188, 4327.1345730853955, 4660.953390466052, 4694.600958918462, 3638.3632864248652, 3671.173985853215, 3734.141147536082, 3746.83139258734, 3775.86784462548, 1104.1442881766534, 1125.5104029747085, 1127.672974837288, 1136.244397475686, 1143.8112711402525, 986.161762501882, 995.1242906242605, 996.4121168510613, 1010.0757806606872, 1012.6253286283975, 5921.585489015813, 5944.167816505693, 5968.253968253968, 5969.880602387928, 6131.294901086343, 456.776179671965, 460.1854717150625, 464.6886585987329, 470.3062982101373, 478.81326282749757, 4149.128682976549, 4237.957620423818, 4318.460192475941, 4358.237308471005, 4445.688801783844, 10366.792664146675, 10664.893351066545, 10709.036186743231, 10741.19441041925, 10755.139588832875, 10628.681139565826, 10630.893691063146, 10635.0960168385, 10652.201084918663, 10657.25399222047, 7690.15408305086, 7839.725609603636, 7889.408294377945, 7900.644470998704, 7901.288884000468, 6005.309389420273, 6051.425114614105, 6181.227346581677, 6215.223097112861, 6270.811875643738, 10007.449590272605, 10036.247281453774, 10073.445960472245, 10168.745781355525, 10201.132903703268, 8890.73327800167, 9518.714438566854, 9946.45294508809, 9950.154236889946, 10087.142592879687, 7827.373810095292, 8009.599520024092, 8080.676772929252, 8080.717174899086, 8222.876656850272, 8200.0979892213, 8293.83412331762, 8321.791955201168, 8385.28725058377, 8389.496630202208, 7412.258774122544, 7555.206703296295, 7589.279018493235, 7602.201768814195, 7611.695532178873, 7527.698892044257, 7541.170471248049, 7554.0, 7574.0, 7672.539647621161, 6788.2193547742645, 6984.895226571707, 7087.50387472872, 7142.785716428515, 7154.821129471805, 5135.3324067870935, 5179.45615710345, 5227.294315267391, 5243.947560524346, 5379.65032272901, 5273.89452210946, 5285.28648632445, 5297.364316281916, 5383.380911195262, 5423.511883930308], "value": 4497.931296575574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.69448778716605, 339.7927264368735, 345.5939271356157, 350.78426767537974, 352.32705532433044, 5333.91999120013, 5340.439253878345, 5353.223782551528, 5370.650907690997, 5381.48875856793, 5000.149974504343, 5014.272930425086, 5182.714950677711, 5195.948040519594, 5296.629235953485, 4150.879262599112, 4152.256052457975, 4154.878182890625, 4159.878461984395, 4163.16820598937, 4164.0, 4178.665706743468, 4183.226103170908, 4184.3305071188615, 4204.768737719424, 3866.961330386688, 3911.9413208801748, 4049.5343035550845, 4066.9796651016704, 4139.1100913303635, 4077.245709543744, 4080.10237747695, 4099.61053699898, 4107.486564179478, 4114.567970363114, 3640.672339489432, 3649.4525821127045, 3652.981735091334, 3665.321915445651, 3710.9257814843822, 5022.0, 5040.395152581714, 5068.26510156029, 5175.456577059392, 5184.351956005499, 4661.137689527448, 4673.415823022122, 4683.437987441529, 4701.764911754432, 4747.053707979711, 5418.322709661293, 5421.891562168774, 5423.891522169574, 5436.374816896068, 5443.292371991616, 3918.921621567553, 4016.116454380032, 4021.2158629067344, 4052.331365324718, 4060.2894493463527, 5614.971925140389, 5618.494335509824, 5623.550115990711, 5635.408282130358, 5637.0, 4096.549379568245, 4101.0, 4109.671226301948, 4132.91734165315, 4134.049168691218, 4044.292248856438, 4161.542230354658, 4186.434831297796, 4194.224068547329, 4197.895052623648, 4666.416697912761, 4669.089527542164, 4672.649551283599, 4707.129181101507, 4711.764411779397, 5428.4842939920645, 5443.265159203457, 5458.781648734085, 5472.425395333512, 5479.698526618829, 1412.8799052080687, 1433.6344232220927, 1444.2129039673403, 1460.6494441334216, 1465.7215129125432, 937.4703292639773, 945.9952700236455, 947.9194268487117, 949.7720547068653, 972.8394814855611, 4636.374089497942, 4644.535546445329, 4685.595540192208, 4711.693739906895, 4742.407199100113, 4604.493505714368, 4868.9269660955115, 4887.0, 4905.435874874363, 4941.876453088702, 4600.332951722048, 4618.976905115453, 4649.279361698942, 4663.463701674283, 4668.439787225487, 2586.237060067285, 2595.9480810384066, 2600.7139214686367, 2611.5581930894673, 2625.6061590761537, 4686.976565117153, 4925.532074452921, 5029.547340739351, 5050.797968081309, 5105.004524117836, 4876.4642385959105, 5060.468650791688, 5063.746812659352, 5069.797208111634, 5110.49240474061, 4936.259561065797, 5012.649114561946, 5034.1625306762035, 5036.370453693362, 5058.3929928408825, 5192.675867653724, 5609.579281553818, 5669.31968163823, 5683.374828768915, 5690.459406356389, 5590.0, 5607.271054762855, 5626.578006649435, 5675.404082571271, 5696.515796157373, 5766.221560089502, 5851.941480585139, 5874.236349274567, 5908.172855800105, 5909.674967876808, 4083.3670781028986, 4108.732932359387, 4113.136241389342, 4114.773687447099, 4132.359484279941, 5478.260434841245, 5538.224648549126, 5684.943150568607, 5727.854429114111, 5739.311282646109, 5524.674078221278, 5528.834134975958, 5530.225768392348, 5530.972345138249, 5555.666660000251, 5375.220593014069, 5448.83653490396, 5485.75314110858, 5540.307461567304, 5566.860828479321, 5431.185322201702, 5477.233187353694, 5483.204935284281, 5509.807156749494, 5519.957615682063, 5545.112781954868, 5545.722713864371, 5548.278723765885, 5634.492650770531, 5635.577331700057, 5310.415854256106, 5356.410794812489, 5407.378151512627, 5438.320209973754, 5511.22842802016], "value": 4112.685079023012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.8677238097147, 744.9031625888633, 781.7342103684746, 786.2491320788646, 808.6684459371655, 15354.232288385578, 16275.104869232187, 16382.7542586861, 16495.0, 16511.917440412795, 14947.0, 15301.0, 15464.922675386608, 15495.690086198269, 15515.767263491029, 802.1777677880176, 825.995870020649, 829.4691397505601, 830.0620299062082, 830.3979614779267, 662.0598749775306, 792.3898598079476, 813.3371302388564, 823.2261674026425, 826.5784449930519, 859.2438653984485, 864.4251572704176, 864.6757465950269, 864.8400045991481, 864.8400045991481, 861.5950503263488, 862.8360611483798, 864.0409145848104, 868.5570359116833, 868.6785889220965, 505.27997603414985, 513.599392473871, 517.1467079319116, 633.7560039384824, 635.4503354598286, 14465.132092074404, 14853.405863765436, 14860.62848428787, 15583.844161558352, 15615.609609759733, 15075.170865602387, 15332.693346133126, 15606.141662208574, 15785.0, 15793.210339483096, 12782.366404617356, 12798.872011279862, 12971.67570810728, 12993.0, 13198.076134670577, 3859.9228015439817, 3866.2875799481076, 3966.147278335143, 4031.113155105872, 4093.5087789465156, 84858.0, 85261.31062791545, 85471.5726421364, 86906.0, 86981.0, 11111.666650000512, 11512.76974460506, 11746.29522228669, 11865.466054027589, 11929.940350298193, 22500.0, 22705.20531781413, 22767.0, 22884.31347059591, 22927.656085158735, 8789.252913502296, 8855.512946787989, 8994.145556172152, 9001.864972025425, 9064.048274931169, 4747.121782470254, 4802.351682522884, 5011.84964451067, 5069.239614057921, 5203.765830537635, 3607.8737244196327, 3740.7942563159286, 3746.5316835395574, 3746.644068813513, 3748.6438788315068, 612.8100288910452, 616.5154427656552, 638.3042483692797, 646.0567571345794, 660.3000819131639, 610.6946526736632, 656.3731636287334, 669.3072669786748, 716.5127713155, 795.9761207163795, 10183.867082118017, 10736.463176841127, 10851.131909447226, 11116.777664446667, 11267.718307042225, 622.2968046107869, 662.7779693802534, 710.6553321639001, 749.9887501687479, 760.4486747108413, 4617.676762626584, 4863.0, 4864.513548645107, 4869.318295438641, 4918.0901533216465, 70601.0, 73600.0, 124191.0, 129107.0, 130313.0, 105100.0, 109069.45465272781, 109147.0, 110012.0, 111232.0, 95239.18516822979, 95376.52311738397, 95392.0, 97181.0, 100255.0, 9262.045211607605, 9431.764205894908, 9563.09150630689, 9570.760730981781, 9732.854007189757, 48976.51023489719, 51354.74322628363, 52394.476055240484, 53267.60295786621, 53541.19688204758, 73953.63023185065, 77169.0, 78261.0, 81670.0, 82071.5896420514, 12550.246985180918, 12588.622341329774, 12704.6823829405, 12797.168184068007, 12799.808002879778, 14216.573502794932, 14234.359453824396, 14340.713185736435, 14418.206998615176, 14676.77984830207, 12556.560520381743, 12968.641114982578, 12979.610611681665, 13799.103058301178, 14148.858511414754, 12406.565770198, 12578.371081446074, 12652.620421387373, 12716.109872308849, 12893.41979610901, 12089.75820483603, 12115.333656648969, 12488.0, 13050.738985220432, 13570.660733481742, 11910.880891190976, 11975.449329254827, 12229.510819567118, 12365.814512782496, 13190.142640728322, 11858.466369013242, 12297.200681955645, 12487.625371238877, 12632.873671263538, 12741.299228542519], "value": 7736.560835022783, "unit": "score"}], "name": "dromaeo_css", "value": 7272.735771123205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 107.0, 110.0, 112.0, 111.0, 118.0, 110.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 146.0, 178.0, 123.0, 156.0, 146.0, 122.0, 180.0, 119.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 188.0, 77.0, 75.0, 74.0, 76.0, 177.0, 76.0], "value": 97.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 160.0, 86.0, 87.0, 86.0, 142.0, 86.0, 86.0, 139.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 50.0, 51.0, 62.0, 51.0, 53.0, 51.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 87.0, 80.0, 81.0, 78.0, 79.0, 79.0, 78.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 122.0, 122.0, 123.0, 122.0, 124.0, 121.0, 138.0, 124.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 163.0, 167.0, 163.0, 166.0, 165.0, 162.0, 164.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 67.0, 66.0, 64.0, 63.0, 64.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1524.9, "alertThreshold": 2.0}]} 23:37:00 INFO - Return code: 0 23:37:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:37:00 INFO - # TBPL SUCCESS # 23:37:00 INFO - Running post-action listener: _resource_record_post_action 23:37:00 INFO - [mozharness: 2016-08-22 06:37:00.332311Z] Finished run-tests step (success) 23:37:00 INFO - Running post-run listener: _resource_record_post_run 23:37:00 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 423538688; Read time: 20; Write time: 344560 23:37:00 INFO - TinderboxPrint: CPU usage
13.3% 23:37:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 23:37:00 INFO - TinderboxPrint: I/O write bytes / time
423,538,688 / 344,560 23:37:00 INFO - TinderboxPrint: CPU idle
8,275.5 (86.7%) 23:37:00 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 23:37:00 INFO - TinderboxPrint: Swap in / out
0 / 0 23:37:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 134643712; Read time: 0; Write time: 97348 23:37:00 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288002048; Read time: 8; Write time: 247192 23:37:00 INFO - Running post-run listener: _upload_blobber_files 23:37:00 INFO - Blob upload gear active. 23:37:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:37:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:37:01 INFO - (blobuploader) - INFO - Open directory for files ... 23:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:05 INFO - (blobuploader) - INFO - Done attempting. 23:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:37:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:05 INFO - (blobuploader) - INFO - Done attempting. 23:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:06 INFO - (blobuploader) - INFO - Done attempting. 23:37:06 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:06 INFO - Return code: 0 23:37:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8271cc25c3f89cd7b4e6ab2ebfce4649b3905e0d48836bcaf2ce2b5f5728f62ed8136bbd7052cc8a0684612c2acfecd49ce07cd577f39c79d7e513ff70289d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a5e110f2cae58d753112172d40d36aac88e2eb16fa6b3718139441c41b1b539f22beff6893a21f8fff8794b3393dd12e311fe630f9e890274b9d4a9ba78b8ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f44d63e7b1d409d1e0c4e5871bbdffb81b54c89a92832e10ced81dde2c0def610dd74757dffceabd91880f6f9484571a821b68fe9735457b85c966be786160d"} 23:37:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:06 INFO - Contents: 23:37:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8271cc25c3f89cd7b4e6ab2ebfce4649b3905e0d48836bcaf2ce2b5f5728f62ed8136bbd7052cc8a0684612c2acfecd49ce07cd577f39c79d7e513ff70289d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a5e110f2cae58d753112172d40d36aac88e2eb16fa6b3718139441c41b1b539f22beff6893a21f8fff8794b3393dd12e311fe630f9e890274b9d4a9ba78b8ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f44d63e7b1d409d1e0c4e5871bbdffb81b54c89a92832e10ced81dde2c0def610dd74757dffceabd91880f6f9484571a821b68fe9735457b85c966be786160d"} 23:37:06 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:06 INFO - Copying logs to upload dir... 23:37:06 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.491632 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-21 23:37:05.346226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:05.352425) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667 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/8271cc25c3f89cd7b4e6ab2ebfce4649b3905e0d48836bcaf2ce2b5f5728f62ed8136bbd7052cc8a0684612c2acfecd49ce07cd577f39c79d7e513ff70289d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a5e110f2cae58d753112172d40d36aac88e2eb16fa6b3718139441c41b1b539f22beff6893a21f8fff8794b3393dd12e311fe630f9e890274b9d4a9ba78b8ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f44d63e7b1d409d1e0c4e5871bbdffb81b54c89a92832e10ced81dde2c0def610dd74757dffceabd91880f6f9484571a821b68fe9735457b85c966be786160d"} build_url:https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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/8271cc25c3f89cd7b4e6ab2ebfce4649b3905e0d48836bcaf2ce2b5f5728f62ed8136bbd7052cc8a0684612c2acfecd49ce07cd577f39c79d7e513ff70289d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a5e110f2cae58d753112172d40d36aac88e2eb16fa6b3718139441c41b1b539f22beff6893a21f8fff8794b3393dd12e311fe630f9e890274b9d4a9ba78b8ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f44d63e7b1d409d1e0c4e5871bbdffb81b54c89a92832e10ced81dde2c0def610dd74757dffceabd91880f6f9484571a821b68fe9735457b85c966be786160d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:05.377320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:05.377621) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471844995.233779-2048251667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:05.463411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 23:37:05.463803) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 23:37:05.464094) ========= ========= Total master_lag: 0.39 =========