builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1471620264.13 results: success (0) buildid: 20160819073321 builduid: a561127ee9f046e1b6d1f34d0880f6e3 revision: 9474008843066a8a261379b51247e0c4c432323d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.128238) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.128733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.129013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.144392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.144772) ========= 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=00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 08:24:24-- 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% 222M=0s 2016-08-19 08:24:24 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120582 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.312609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.312947) ========= 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=00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.363828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:24.364216) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9474008843066a8a261379b51247e0c4c432323d --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 9474008843066a8a261379b51247e0c4c432323d --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=00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 08:24:24,494 truncating revision to first 12 chars 2016-08-19 08:24:24,494 Setting DEBUG logging. 2016-08-19 08:24:24,494 attempt 1/10 2016-08-19 08:24:24,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/947400884306?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 08:24:24,789 unpacking tar archive at: fx-team-947400884306/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650075 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:25.028432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:25.028758) ========= script_repo_revision: 9474008843066a8a261379b51247e0c4c432323d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:25.029166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:25.029433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 08:24:25.038069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-19 08:24:25.038447) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:25 INFO - MultiFileLogger online at 20160819 08:24:25 in /builds/slave/test 08:24:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:24:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:25 INFO - {'append_to_log': False, 08:24:25 INFO - 'base_work_dir': '/builds/slave/test', 08:24:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:24:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:25 INFO - 'branch': 'Fx-Team-Non-PGO', 08:24:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:25 INFO - 'config_files': ('talos/linux_config.py',), 08:24:25 INFO - 'default_actions': ('clobber', 08:24:25 INFO - 'read-buildbot-config', 08:24:25 INFO - 'download-and-extract', 08:24:25 INFO - 'populate-webroot', 08:24:25 INFO - 'create-virtualenv', 08:24:25 INFO - 'install', 08:24:25 INFO - 'run-tests'), 08:24:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:25 INFO - 'download_minidump_stackwalk': True, 08:24:25 INFO - 'download_symbols': 'ondemand', 08:24:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:25 INFO - 'installer_path': 'installer.exe', 08:24:25 INFO - 'log_level': 'info', 08:24:25 INFO - 'log_name': 'talos', 08:24:25 INFO - 'log_to_console': True, 08:24:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:25 INFO - 'opt_config_files': (), 08:24:25 INFO - 'pip_index': False, 08:24:25 INFO - 'sps_profile': False, 08:24:25 INFO - 'sps_profile_interval': 0, 08:24:25 INFO - 'suite': 'dromaeojs', 08:24:25 INFO - 'system_bits': '32', 08:24:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:25 INFO - 'title': 'talos-linux64-ix-016', 08:24:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:25 INFO - 'use_talos_json': True, 08:24:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:25 INFO - 'work_dir': 'build'} 08:24:25 INFO - [mozharness: 2016-08-19 15:24:25.262947Z] Running clobber step. 08:24:25 INFO - Running pre-action listener: _resource_record_pre_action 08:24:25 INFO - Running main action method: clobber 08:24:25 INFO - rmtree: /builds/slave/test/build 08:24:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:25 INFO - Running post-action listener: _resource_record_post_action 08:24:25 INFO - [mozharness: 2016-08-19 15:24:25.721594Z] Finished clobber step (success) 08:24:25 INFO - [mozharness: 2016-08-19 15:24:25.721694Z] Running read-buildbot-config step. 08:24:25 INFO - Running pre-action listener: _resource_record_pre_action 08:24:25 INFO - Running main action method: read_buildbot_config 08:24:25 INFO - Using buildbot properties: 08:24:25 INFO - { 08:24:25 INFO - "project": "", 08:24:25 INFO - "product": "firefox", 08:24:25 INFO - "script_repo_revision": "production", 08:24:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:24:25 INFO - "repository": "", 08:24:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:24:25 INFO - "buildid": "20160819073321", 08:24:25 INFO - "pgo_build": "False", 08:24:25 INFO - "basedir": "/builds/slave/test", 08:24:25 INFO - "buildnumber": 2102, 08:24:25 INFO - "slavename": "talos-linux64-ix-016", 08:24:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:24:25 INFO - "platform": "ubuntu64_hw", 08:24:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:24:25 INFO - "branch": "fx-team", 08:24:25 INFO - "repo_path": "integration/fx-team", 08:24:25 INFO - "revision": "9474008843066a8a261379b51247e0c4c432323d", 08:24:25 INFO - "stage_platform": "linux64", 08:24:25 INFO - "builduid": "a561127ee9f046e1b6d1f34d0880f6e3", 08:24:25 INFO - "slavebuilddir": "test" 08:24:25 INFO - } 08:24:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:24:25 INFO - Running post-action listener: _resource_record_post_action 08:24:25 INFO - [mozharness: 2016-08-19 15:24:25.724121Z] Finished read-buildbot-config step (success) 08:24:25 INFO - [mozharness: 2016-08-19 15:24:25.724210Z] Running download-and-extract step. 08:24:25 INFO - Running pre-action listener: _resource_record_pre_action 08:24:25 INFO - Running main action method: download_and_extract 08:24:25 INFO - mkdir: /builds/slave/test/build/tests 08:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:25 INFO - trying https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:24:25 INFO - Downloading https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:24:26 INFO - Downloaded 1361 bytes. 08:24:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:24:26 INFO - Using the following test package requirements: 08:24:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:24:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'jsshell-linux-x86_64.zip'], 08:24:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:24:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:24:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:26 INFO - trying https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:24:26 INFO - Downloading https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:27 INFO - Downloaded 20328569 bytes. 08:24:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:24:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:31 INFO - trying https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:24:31 INFO - Downloading https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:32 INFO - Downloaded 20328569 bytes. 08:24:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:37 INFO - trying https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:24:40 INFO - Downloaded 14413981 bytes. 08:24: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 08:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:41 INFO - trying https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:24:42 INFO - Downloaded 55773862 bytes. 08:24:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:42 INFO - mkdir: /builds/slave/test/properties 08:24:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:42 INFO - Contents: 08:24:42 INFO - build_url:https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:24:42 INFO - Running post-action listener: _resource_record_post_action 08:24:42 INFO - Running post-action listener: set_extra_try_arguments 08:24:42 INFO - [mozharness: 2016-08-19 15:24:42.992663Z] Finished download-and-extract step (success) 08:24:42 INFO - [mozharness: 2016-08-19 15:24:42.992887Z] Running populate-webroot step. 08:24:42 INFO - Running pre-action listener: _resource_record_pre_action 08:24:42 INFO - Running main action method: populate_webroot 08:24:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:43 INFO - '--tppagecycles', 08:24:43 INFO - '7'], 08:24:43 INFO - 'tests': ['tsvgm']}}, 08:24:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:24:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:24:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:24:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['damp', 'tps']}, 08:24:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'tests': ['damp', 'tps']}, 08:24:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['dromaeo_dom']}, 08:24:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['basic_compositor_video']}, 08:24:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:24:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['a11yr', 08:24:43 INFO - 'ts_paint', 08:24:43 INFO - 'tpaint', 08:24:43 INFO - 'sessionrestore', 08:24:43 INFO - 'sessionrestore_no_auto_restore', 08:24:43 INFO - 'tabpaint']}, 08:24:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:24:43 INFO - 'ts_paint', 08:24:43 INFO - 'tpaint', 08:24:43 INFO - 'sessionrestore', 08:24:43 INFO - 'sessionrestore_no_auto_restore', 08:24:43 INFO - 'tabpaint']}, 08:24:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:24:43 INFO - 'ts_paint', 08:24:43 INFO - 'tpaint', 08:24:43 INFO - 'sessionrestore', 08:24:43 INFO - 'sessionrestore_no_auto_restore', 08:24:43 INFO - 'tabpaint']}, 08:24:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:24:43 INFO - 'ts_paint', 08:24:43 INFO - 'tpaint', 08:24:43 INFO - 'sessionrestore', 08:24:43 INFO - 'sessionrestore_no_auto_restore', 08:24:43 INFO - 'tabpaint']}, 08:24:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['a11yr', 08:24:43 INFO - 'ts_paint', 08:24:43 INFO - 'tpaint', 08:24:43 INFO - 'sessionrestore', 08:24:43 INFO - 'sessionrestore_no_auto_restore', 08:24:43 INFO - 'tabpaint']}, 08:24:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['a11yr', 08:24:43 INFO - 'ts_paint', 08:24:43 INFO - 'tpaint', 08:24:43 INFO - 'sessionrestore', 08:24:43 INFO - 'sessionrestore_no_auto_restore', 08:24:43 INFO - 'tabpaint']}, 08:24:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['tsvgx', 08:24:43 INFO - 'tsvgr_opacity', 08:24:43 INFO - 'tart', 08:24:43 INFO - 'tscrollx', 08:24:43 INFO - 'cart']}, 08:24:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:24:43 INFO - 'tsvgr_opacity', 08:24:43 INFO - 'tart', 08:24:43 INFO - 'tscrollx', 08:24:43 INFO - 'cart']}, 08:24:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'talos_options': ['--disable-e10s'], 08:24:43 INFO - 'tests': ['tp5o']}, 08:24:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'tests': ['tp5o']}, 08:24:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'talos_options': ['--disable-e10s', 08:24:43 INFO - '--xperf_path', 08:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:43 INFO - 'tests': ['tp5n']}, 08:24:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:43 INFO - 'talos_options': ['--xperf_path', 08:24:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:43 INFO - 'tests': ['tp5n']}}, 08:24:43 INFO - 'talos.zip': {'path': '', 08:24:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:43 INFO - Running post-action listener: _resource_record_post_action 08:24:43 INFO - [mozharness: 2016-08-19 15:24:43.009101Z] Finished populate-webroot step (success) 08:24:43 INFO - [mozharness: 2016-08-19 15:24:43.009190Z] Running create-virtualenv step. 08:24:43 INFO - Running pre-action listener: _resource_record_pre_action 08:24:43 INFO - Running main action method: create_virtualenv 08:24:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:24:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:43 INFO - Using real prefix '/usr' 08:24:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:45 INFO - Installing pip.................done. 08:24:45 INFO - Return code: 0 08:24:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24: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', 'pip>=1.5'] in /builds/slave/test/build 08:24: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 pip>=1.5 08:24:45 INFO - Using env: {'DISPLAY': ':0', 08:24:45 INFO - 'HOME': '/home/cltbld', 08:24:45 INFO - 'LANG': 'en_US.UTF-8', 08:24:45 INFO - 'LANGUAGE': 'en_US:en', 08:24:45 INFO - 'LOGNAME': 'cltbld', 08:24:45 INFO - 'MAIL': '/var/mail/cltbld', 08:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:45 INFO - 'MOZ_NO_REMOTE': '1', 08:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:45 INFO - 'NO_EM_RESTART': '1', 08:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:45 INFO - 'PWD': '/builds/slave/test', 08:24:45 INFO - 'SHELL': '/bin/bash', 08:24:45 INFO - 'SHLVL': '1', 08:24:45 INFO - 'TERM': 'linux', 08:24:45 INFO - 'TMOUT': '86400', 08:24:45 INFO - 'USER': 'cltbld', 08:24:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:45 INFO - '_': '/tools/buildbot/bin/python'} 08:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24: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 08:24:45 INFO - Cleaning up... 08:24:45 INFO - Return code: 0 08:24:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24: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 08:24: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 08:24:45 INFO - Using env: {'DISPLAY': ':0', 08:24:45 INFO - 'HOME': '/home/cltbld', 08:24:45 INFO - 'LANG': 'en_US.UTF-8', 08:24:45 INFO - 'LANGUAGE': 'en_US:en', 08:24:45 INFO - 'LOGNAME': 'cltbld', 08:24:45 INFO - 'MAIL': '/var/mail/cltbld', 08:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:45 INFO - 'MOZ_NO_REMOTE': '1', 08:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:45 INFO - 'NO_EM_RESTART': '1', 08:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:45 INFO - 'PWD': '/builds/slave/test', 08:24:45 INFO - 'SHELL': '/bin/bash', 08:24:45 INFO - 'SHLVL': '1', 08:24:45 INFO - 'TERM': 'linux', 08:24:45 INFO - 'TMOUT': '86400', 08:24:45 INFO - 'USER': 'cltbld', 08:24:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:45 INFO - '_': '/tools/buildbot/bin/python'} 08:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:45 INFO - Downloading/unpacking psutil>=3.1.1 08:24: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 08:24: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 08:24: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 08:24: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 08:24: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 08:24: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 08:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:48 INFO - Installing collected packages: psutil 08:24:48 INFO - Running setup.py install for psutil 08:24:48 INFO - building 'psutil._psutil_linux' extension 08:24:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:24:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:24:48 INFO - building 'psutil._psutil_posix' extension 08:24:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:24:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:48 INFO - Successfully installed psutil 08:24:48 INFO - Cleaning up... 08:24:48 INFO - Return code: 0 08:24:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:24:48 INFO - Using env: {'DISPLAY': ':0', 08:24:48 INFO - 'HOME': '/home/cltbld', 08:24:48 INFO - 'LANG': 'en_US.UTF-8', 08:24:48 INFO - 'LANGUAGE': 'en_US:en', 08:24:48 INFO - 'LOGNAME': 'cltbld', 08:24:48 INFO - 'MAIL': '/var/mail/cltbld', 08:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:48 INFO - 'MOZ_NO_REMOTE': '1', 08:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:48 INFO - 'NO_EM_RESTART': '1', 08:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:48 INFO - 'PWD': '/builds/slave/test', 08:24:48 INFO - 'SHELL': '/bin/bash', 08:24:48 INFO - 'SHLVL': '1', 08:24:48 INFO - 'TERM': 'linux', 08:24:48 INFO - 'TMOUT': '86400', 08:24:48 INFO - 'USER': 'cltbld', 08:24:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:48 INFO - '_': '/tools/buildbot/bin/python'} 08:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:50 INFO - Installing collected packages: mozsystemmonitor 08:24:50 INFO - Running setup.py install for mozsystemmonitor 08:24:51 INFO - Successfully installed mozsystemmonitor 08:24:51 INFO - Cleaning up... 08:24:51 INFO - Return code: 0 08:24:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:24:51 INFO - Using env: {'DISPLAY': ':0', 08:24:51 INFO - 'HOME': '/home/cltbld', 08:24:51 INFO - 'LANG': 'en_US.UTF-8', 08:24:51 INFO - 'LANGUAGE': 'en_US:en', 08:24:51 INFO - 'LOGNAME': 'cltbld', 08:24:51 INFO - 'MAIL': '/var/mail/cltbld', 08:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:51 INFO - 'MOZ_NO_REMOTE': '1', 08:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:51 INFO - 'NO_EM_RESTART': '1', 08:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:51 INFO - 'PWD': '/builds/slave/test', 08:24:51 INFO - 'SHELL': '/bin/bash', 08:24:51 INFO - 'SHLVL': '1', 08:24:51 INFO - 'TERM': 'linux', 08:24:51 INFO - 'TMOUT': '86400', 08:24:51 INFO - 'USER': 'cltbld', 08:24:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:51 INFO - '_': '/tools/buildbot/bin/python'} 08:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:24:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:24:53 INFO - warning: no files found matching '*.txt' 08:24:53 INFO - no previously-included directories found matching 'build' 08:24:53 INFO - no previously-included directories found matching 'dist' 08:24:53 INFO - no previously-included directories found matching '.git*' 08:24:53 INFO - Installing collected packages: jsonschema, functools32 08:24:53 INFO - Running setup.py install for functools32 08:24:53 INFO - warning: no files found matching '*.txt' 08:24:53 INFO - no previously-included directories found matching 'build' 08:24:53 INFO - no previously-included directories found matching 'dist' 08:24:53 INFO - no previously-included directories found matching '.git*' 08:24:53 INFO - Successfully installed jsonschema functools32 08:24:53 INFO - Cleaning up... 08:24:53 INFO - Return code: 0 08:24:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:24:53 INFO - Using env: {'DISPLAY': ':0', 08:24:53 INFO - 'HOME': '/home/cltbld', 08:24:53 INFO - 'LANG': 'en_US.UTF-8', 08:24:53 INFO - 'LANGUAGE': 'en_US:en', 08:24:53 INFO - 'LOGNAME': 'cltbld', 08:24:53 INFO - 'MAIL': '/var/mail/cltbld', 08:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:53 INFO - 'MOZ_NO_REMOTE': '1', 08:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:53 INFO - 'NO_EM_RESTART': '1', 08:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:53 INFO - 'PWD': '/builds/slave/test', 08:24:53 INFO - 'SHELL': '/bin/bash', 08:24:53 INFO - 'SHLVL': '1', 08:24:53 INFO - 'TERM': 'linux', 08:24:53 INFO - 'TMOUT': '86400', 08:24:53 INFO - 'USER': 'cltbld', 08:24:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:53 INFO - '_': '/tools/buildbot/bin/python'} 08:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:24:53 INFO - Cleaning up... 08:24:53 INFO - Return code: 0 08:24:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:24:53 INFO - Using env: {'DISPLAY': ':0', 08:24:53 INFO - 'HOME': '/home/cltbld', 08:24:53 INFO - 'LANG': 'en_US.UTF-8', 08:24:53 INFO - 'LANGUAGE': 'en_US:en', 08:24:53 INFO - 'LOGNAME': 'cltbld', 08:24:53 INFO - 'MAIL': '/var/mail/cltbld', 08:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:53 INFO - 'MOZ_NO_REMOTE': '1', 08:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:53 INFO - 'NO_EM_RESTART': '1', 08:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:53 INFO - 'PWD': '/builds/slave/test', 08:24:53 INFO - 'SHELL': '/bin/bash', 08:24:53 INFO - 'SHLVL': '1', 08:24:53 INFO - 'TERM': 'linux', 08:24:53 INFO - 'TMOUT': '86400', 08:24:53 INFO - 'USER': 'cltbld', 08:24:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:53 INFO - '_': '/tools/buildbot/bin/python'} 08:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - Downloading docopt-0.6.1.tar.gz 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:56 INFO - Running setup.py install for blobuploader 08:24:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:56 INFO - Running setup.py install for requests 08:24:57 INFO - Running setup.py install for docopt 08:24:57 INFO - Successfully installed blobuploader requests docopt 08:24:57 INFO - Cleaning up... 08:24:57 INFO - Return code: 0 08:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:57 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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:24:57 INFO - Using env: {'DISPLAY': ':0', 08:24:57 INFO - 'HOME': '/home/cltbld', 08:24:57 INFO - 'LANG': 'en_US.UTF-8', 08:24:57 INFO - 'LANGUAGE': 'en_US:en', 08:24:57 INFO - 'LOGNAME': 'cltbld', 08:24:57 INFO - 'MAIL': '/var/mail/cltbld', 08:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:57 INFO - 'MOZ_NO_REMOTE': '1', 08:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:57 INFO - 'NO_EM_RESTART': '1', 08:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:57 INFO - 'PWD': '/builds/slave/test', 08:24:57 INFO - 'SHELL': '/bin/bash', 08:24:57 INFO - 'SHLVL': '1', 08:24:57 INFO - 'TERM': 'linux', 08:24:57 INFO - 'TMOUT': '86400', 08:24:57 INFO - 'USER': 'cltbld', 08:24:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:57 INFO - '_': '/tools/buildbot/bin/python'} 08:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:57 INFO - Running setup.py (path:/tmp/pip-xANLle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:57 INFO - Running setup.py (path:/tmp/pip-J_1mEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:57 INFO - Running setup.py (path:/tmp/pip-NPfhiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:57 INFO - Running setup.py (path:/tmp/pip-XbKiJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:57 INFO - Running setup.py (path:/tmp/pip-VXosob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:58 INFO - Running setup.py (path:/tmp/pip-qNxDG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:58 INFO - Running setup.py (path:/tmp/pip-DYvsFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:58 INFO - Running setup.py (path:/tmp/pip-NSmPd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:58 INFO - Running setup.py (path:/tmp/pip-Kcb4q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:58 INFO - Running setup.py (path:/tmp/pip-YjB9sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:58 INFO - Running setup.py (path:/tmp/pip-mzREEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:58 INFO - Running setup.py (path:/tmp/pip-rnb5pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:58 INFO - Running setup.py (path:/tmp/pip-zxe_sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:58 INFO - Running setup.py (path:/tmp/pip-vWjNuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:58 INFO - Running setup.py (path:/tmp/pip-u87XsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:58 INFO - Running setup.py (path:/tmp/pip-viXhnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:58 INFO - Running setup.py (path:/tmp/pip-4vPGYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:58 INFO - Running setup.py install for manifestparser 08:24:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozcrash 08:24:59 INFO - Running setup.py install for mozdebug 08:24:59 INFO - Running setup.py install for mozdevice 08:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozfile 08:24:59 INFO - Running setup.py install for mozhttpd 08:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozinfo 08:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozInstall 08:24:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for mozleak 08:24:59 INFO - Running setup.py install for mozlog 08:24:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:59 INFO - Running setup.py install for moznetwork 08:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Running setup.py install for mozprocess 08:25:00 INFO - Running setup.py install for mozprofile 08:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Running setup.py install for mozrunner 08:25:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Running setup.py install for mozscreenshot 08:25:00 INFO - Running setup.py install for moztest 08:25:00 INFO - Running setup.py install for mozversion 08:25:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:00 INFO - Cleaning up... 08:25:00 INFO - Return code: 0 08:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:00 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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:00 INFO - Using env: {'DISPLAY': ':0', 08:25:00 INFO - 'HOME': '/home/cltbld', 08:25:00 INFO - 'LANG': 'en_US.UTF-8', 08:25:00 INFO - 'LANGUAGE': 'en_US:en', 08:25:00 INFO - 'LOGNAME': 'cltbld', 08:25:00 INFO - 'MAIL': '/var/mail/cltbld', 08:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:00 INFO - 'MOZ_NO_REMOTE': '1', 08:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:00 INFO - 'NO_EM_RESTART': '1', 08:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:00 INFO - 'PWD': '/builds/slave/test', 08:25:00 INFO - 'SHELL': '/bin/bash', 08:25:00 INFO - 'SHLVL': '1', 08:25:00 INFO - 'TERM': 'linux', 08:25:00 INFO - 'TMOUT': '86400', 08:25:00 INFO - 'USER': 'cltbld', 08:25:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:00 INFO - '_': '/tools/buildbot/bin/python'} 08:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:00 INFO - Running setup.py (path:/tmp/pip-3Zuwkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:00 INFO - Running setup.py (path:/tmp/pip-wanjgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:01 INFO - Running setup.py (path:/tmp/pip-7V3xNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:01 INFO - Running setup.py (path:/tmp/pip-TLb7J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:01 INFO - Running setup.py (path:/tmp/pip-bJbfly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:01 INFO - Running setup.py (path:/tmp/pip-R_E_V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:01 INFO - Running setup.py (path:/tmp/pip-j8WIVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:01 INFO - Running setup.py (path:/tmp/pip-lSPNLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:01 INFO - Running setup.py (path:/tmp/pip-woj1VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:01 INFO - Running setup.py (path:/tmp/pip-OKEZyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:01 INFO - Running setup.py (path:/tmp/pip-7m0qXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:01 INFO - Running setup.py (path:/tmp/pip-jFJN3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:01 INFO - Running setup.py (path:/tmp/pip-K9YM5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:01 INFO - Running setup.py (path:/tmp/pip-xGusaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:01 INFO - Running setup.py (path:/tmp/pip-dwa4wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:02 INFO - Running setup.py (path:/tmp/pip-hDM7Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:02 INFO - Running setup.py (path:/tmp/pip-Dy4yGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:04 INFO - Downloading blessings-1.6.tar.gz 08:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:04 INFO - Installing collected packages: blessings 08:25:04 INFO - Running setup.py install for blessings 08:25:04 INFO - Successfully installed blessings 08:25:04 INFO - Cleaning up... 08:25:04 INFO - Return code: 0 08:25:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:04 INFO - Reading from file tmpfile_stdout 08:25:04 INFO - Current package versions: 08:25:04 INFO - argparse == 1.2.1 08:25:04 INFO - blessings == 1.6 08:25:04 INFO - blobuploader == 1.2.4 08:25:04 INFO - docopt == 0.6.1 08:25:04 INFO - functools32 == 3.2.3-2 08:25:04 INFO - jsonschema == 2.5.1 08:25:04 INFO - manifestparser == 1.1 08:25:04 INFO - mozInstall == 1.12 08:25:04 INFO - mozcrash == 0.17 08:25:04 INFO - mozdebug == 0.1 08:25:04 INFO - mozdevice == 0.48 08:25:04 INFO - mozfile == 1.2 08:25:04 INFO - mozhttpd == 0.7 08:25:04 INFO - mozinfo == 0.9 08:25:04 INFO - mozleak == 0.1 08:25:04 INFO - mozlog == 3.3 08:25:04 INFO - moznetwork == 0.27 08:25:04 INFO - mozprocess == 0.23 08:25:04 INFO - mozprofile == 0.28 08:25:04 INFO - mozrunner == 6.12 08:25:04 INFO - mozscreenshot == 0.1 08:25:04 INFO - mozsystemmonitor == 0.3 08:25:04 INFO - moztest == 0.7 08:25:04 INFO - mozversion == 1.4 08:25:04 INFO - psutil == 3.1.1 08:25:04 INFO - requests == 1.2.3 08:25:04 INFO - wsgiref == 0.1.2 08:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:04 INFO - Using env: {'DISPLAY': ':0', 08:25:04 INFO - 'HOME': '/home/cltbld', 08:25:04 INFO - 'LANG': 'en_US.UTF-8', 08:25:04 INFO - 'LANGUAGE': 'en_US:en', 08:25:04 INFO - 'LOGNAME': 'cltbld', 08:25:04 INFO - 'MAIL': '/var/mail/cltbld', 08:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:04 INFO - 'MOZ_NO_REMOTE': '1', 08:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:04 INFO - 'NO_EM_RESTART': '1', 08:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:04 INFO - 'PWD': '/builds/slave/test', 08:25:04 INFO - 'SHELL': '/bin/bash', 08:25:04 INFO - 'SHLVL': '1', 08:25:04 INFO - 'TERM': 'linux', 08:25:04 INFO - 'TMOUT': '86400', 08:25:04 INFO - 'USER': 'cltbld', 08:25:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:04 INFO - '_': '/tools/buildbot/bin/python'} 08:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:04 INFO - Cleaning up... 08:25:04 INFO - Return code: 0 08:25:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 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 0x7f178d21ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, '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': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:25:04 INFO - Using env: {'DISPLAY': ':0', 08:25:04 INFO - 'HOME': '/home/cltbld', 08:25:04 INFO - 'LANG': 'en_US.UTF-8', 08:25:04 INFO - 'LANGUAGE': 'en_US:en', 08:25:04 INFO - 'LOGNAME': 'cltbld', 08:25:04 INFO - 'MAIL': '/var/mail/cltbld', 08:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:04 INFO - 'MOZ_NO_REMOTE': '1', 08:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:04 INFO - 'NO_EM_RESTART': '1', 08:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:04 INFO - 'PWD': '/builds/slave/test', 08:25:04 INFO - 'SHELL': '/bin/bash', 08:25:04 INFO - 'SHLVL': '1', 08:25:04 INFO - 'TERM': 'linux', 08:25:04 INFO - 'TMOUT': '86400', 08:25:04 INFO - 'USER': 'cltbld', 08:25:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:04 INFO - '_': '/tools/buildbot/bin/python'} 08:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:04 INFO - Cleaning up... 08:25:04 INFO - Return code: 0 08:25:04 INFO - Running post-action listener: _resource_record_post_action 08:25:04 INFO - Running post-action listener: _start_resource_monitoring 08:25:05 INFO - Starting resource monitoring. 08:25:05 INFO - [mozharness: 2016-08-19 15:25:05.021201Z] Finished create-virtualenv step (success) 08:25:05 INFO - [mozharness: 2016-08-19 15:25:05.021712Z] Running install step. 08:25:05 INFO - Running pre-action listener: _resource_record_pre_action 08:25:05 INFO - Running main action method: install 08:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:05 INFO - Reading from file tmpfile_stdout 08:25:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:05 INFO - Reading from file tmpfile_stdout 08:25:05 INFO - Output received: 08:25:05 INFO - Usage: mozinstall [options] installer 08:25:05 INFO - Options: 08:25:05 INFO - -h, --help show this help message and exit 08:25:05 INFO - -d DEST, --destination=DEST 08:25:05 INFO - Directory to install application into. [default: 08:25:05 INFO - "/builds/slave/test"] 08:25:05 INFO - --app=APP Application being installed. [default: firefox] 08:25:05 INFO - mkdir: /builds/slave/test/build/application 08:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:25:21 INFO - Reading from file tmpfile_stdout 08:25:21 INFO - Output received: 08:25:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:21 INFO - Running post-action listener: _resource_record_post_action 08:25:21 INFO - [mozharness: 2016-08-19 15:25:21.417217Z] Finished install step (success) 08:25:21 INFO - [mozharness: 2016-08-19 15:25:21.417469Z] Running run-tests step. 08:25:21 INFO - Running pre-action listener: _resource_record_pre_action 08:25:21 INFO - Running main action method: run_tests 08:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:21 INFO - Python 2.7.3 08:25:21 INFO - Return code: 0 08:25:21 INFO - grabbing minidump binary from tooltool 08:25: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')]} 08:25: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 0x1d6d090>, '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 0x1d709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d70e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25: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 08:25: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 08:25: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 08:25:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:21 INFO - Return code: 0 08:25:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:25:21 INFO - Using env: {'DISPLAY': ':0', 08:25:21 INFO - 'HOME': '/home/cltbld', 08:25:21 INFO - 'LANG': 'en_US.UTF-8', 08:25:21 INFO - 'LANGUAGE': 'en_US:en', 08:25:21 INFO - 'LOGNAME': 'cltbld', 08:25:21 INFO - 'MAIL': '/var/mail/cltbld', 08:25:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:21 INFO - 'MOZ_NO_REMOTE': '1', 08:25:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:21 INFO - 'NO_EM_RESTART': '1', 08:25:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:21 INFO - 'PWD': '/builds/slave/test', 08:25:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:21 INFO - 'SHELL': '/bin/bash', 08:25:21 INFO - 'SHLVL': '1', 08:25:21 INFO - 'TERM': 'linux', 08:25:21 INFO - 'TMOUT': '86400', 08:25:21 INFO - 'USER': 'cltbld', 08:25:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321', 08:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:21 INFO - '_': '/tools/buildbot/bin/python'} 08:25:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:25:21 INFO - mozversion application_buildid: 20160819073321 08:25:21 INFO - mozversion application_changeset: 9474008843066a8a261379b51247e0c4c432323d 08:25:21 INFO - mozversion application_display_name: Nightly 08:25:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:21 INFO - mozversion application_name: Firefox 08:25:21 INFO - mozversion application_remotingname: firefox 08:25:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:25:21 INFO - mozversion application_vendor: Mozilla 08:25:21 INFO - mozversion application_version: 51.0a1 08:25:21 INFO - mozversion platform_buildid: 20160819073321 08:25:21 INFO - mozversion platform_changeset: 9474008843066a8a261379b51247e0c4c432323d 08:25:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:25:21 INFO - mozversion platform_version: 51.0a1 08:25:21 INFO - using testdate: 1471620321 08:25:21 INFO - actual date: 1471620321 08:25:21 INFO - starting webserver on 'localhost:60060' 08:25:21 INFO - SUITE-START | Running 2 tests 08:25:21 INFO - TEST-START | dromaeo_css 08:25:21 INFO - operating with platform_type : linux_ 08:25:21 INFO - Initialising browser for dromaeo_css test... 08:25:21 INFO - TEST-INFO | started process 32345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSrnsgB/profile http://localhost:60060/getInfo.html) 08:25:26 INFO - PROCESS | 32345 | __metrics Screen width/height:1600/1200 08:25:26 INFO - PROCESS | 32345 | colorDepth:24 08:25:26 INFO - PROCESS | 32345 | Browser inner width/height: 1024/697 08:25:26 INFO - PROCESS | 32345 | __metrics 08:25:26 INFO - PROCESS | 32345 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:25:26 INFO - PROCESS | 32345 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:27 INFO - PROCESS | 32345 | console.error: PushService: 08:25:27 INFO - PROCESS | 32345 | stateChangeProcessEnqueue: Error transitioning state 08:25:27 INFO - PROCESS | 32345 | UnknownError 08:25:27 INFO - TEST-INFO | 32345: exit 0 08:25:27 INFO - Browser initialized. 08:25:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:27 INFO - TEST-INFO | started process 32428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSrnsgB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:39 INFO - PROCESS | 32428 | RSS: Main: 161689600 08:25:39 INFO - PROCESS | 32428 | 08:26:31 INFO - PROCESS | 32428 | 1471620391290 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:28:42 INFO - PROCESS | 32428 | Cycle 1(1): loaded http://localhost:60060/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60060/tests/dromaeo/cssquery-ext.html) 08:28:44 INFO - PROCESS | 32428 | RSS: Main: 236265472 08:28:44 INFO - PROCESS | 32428 | 08:31:46 INFO - PROCESS | 32428 | Cycle 1(1): loaded http://localhost:60060/tests/dromaeo/cssquery-ext.html (next: http://localhost:60060/tests/dromaeo/cssquery-jquery.html) 08:31:47 INFO - PROCESS | 32428 | RSS: Main: 243621888 08:31:47 INFO - PROCESS | 32428 | 08:34:49 INFO - PROCESS | 32428 | Cycle 1(1): loaded http://localhost:60060/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60060/tests/dromaeo/cssquery-mootools.html) 08:34:50 INFO - PROCESS | 32428 | RSS: Main: 213532672 08:34:50 INFO - PROCESS | 32428 | 08:37:52 INFO - PROCESS | 32428 | Cycle 1(1): loaded http://localhost:60060/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60060/tests/dromaeo/cssquery-prototype.html) 08:37:52 INFO - PROCESS | 32428 | RSS: Main: 189464576 08:37:52 INFO - PROCESS | 32428 | 08:40:55 INFO - PROCESS | 32428 | Cycle 1(1): loaded http://localhost:60060/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60060/tests/dromaeo/cssquery-yui.html) 08:40:56 INFO - PROCESS | 32428 | RSS: Main: 189169664 08:40:56 INFO - PROCESS | 32428 | 08:43:59 INFO - PROCESS | 32428 | Cycle 1(1): loaded http://localhost:60060/tests/dromaeo/cssquery-yui.html (next: http://localhost:60060/tests/dromaeo/cssquery-dojo.html) 08:44:00 INFO - PROCESS | 32428 | RSS: Main: 275496960 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | __start_tp_report 08:44:00 INFO - PROCESS | 32428 | _x_x_mozilla_page_load 08:44:00 INFO - PROCESS | 32428 | _x_x_mozilla_page_load_details 08:44:00 INFO - PROCESS | 32428 | |i|pagename|runs| 08:44:00 INFO - PROCESS | 32428 | |0;dojo.html;2568.1011645923927;2573.7812285955692;2603.6094585812125;2613.3597268669178;2621.3315604520844;4482;4557.088582283548;4600.562946520079;4690.1557719610455;4695.037517308952;4582.77086145693;4608.400907881971;4642.373279607252;4652.441706995157;4690.202665546857;4059.63463288304;4280.850170244042;4320.4599425071865;4348.30427131659;4357.564243575633;4311.935320970188;4315.697901146921;4337.262665346899;4343.891402714926;4351.28203846365;4126.236646220459;4171.791410429466;4179.352200408911;4292.012837047481;4295.871123866289;4221.577842215785;4289.764062976535;4305.052888364555;4339.067100573392;4356.803943822504;4266.722663026893;4299.226139294926;4302.741835489881;4304.203722311382;4311.461067366579;4415.845445409395;4698.295255711637;4716.646251531149;4721.740304283263;4732.881677958044;4865.70805751656;4881.511848815126;4891.804327826882;4963.8262660806695;4998.600111991032;5004.9749751251375;5008.048470790538;5012.298278241049;5015.774290156952;5023.673461225008;4526.524714904954;4682.391289132425;4694.389729335233;4694.95305046952;4698.177818881716;5035.244713293036;5087.313212716236;5097.898042039138;5143.691378517301;5161.096808058574;4937.654364194544;4943.085529177114;4944.184209605447;4946.060248552763;4949.802007919643;4806.110869489155;5023.547880690755;5027.874303142377;5029.84910452687;5033.5721463676;4847.127517046965;4895.559399654048;4896.6572339935865;4941.975290123526;4970.701757894538;4949.653524253267;4957.925631115536;4962.6774259673;4966;4967.850964471072;4080.9183816323507;4234.87295381139;4246.808893599796;4247.065645557972;4252;3629.4374371972385;3665.633436656313;3694.4458331250526;3697.8520859165333;3747.6252374762307;4287.356896465492;4287.549807270254;4297.892552686145;4300.483941926988;4301.634361079344;4834.492378300298;5007.824726134568;5012.724300163526;5019.52314530119;5021.648484606042;4210.894727631772;4244.278472659656;4254.702170848011;4288.571142885687;4291.0559676871035;4486.304622783474;4492.887677808081;4495.797689103998;4497.280435130363;4505.301678239878;4676.158291507561;4679.485256621769;4704.200285951465;4736.0764650894125;4736.502667219892;4838.564529192389;4927.236278376858;4933.975330123327;4951.678140920829;5043.36957880265;4721.693089949143;4747.216709242936;4753.714777113384;4754.263089221176;4762.976185119052;4939.308496810378;4950.084234416644;4954.925676114934;4957.975210123926;4966.875828104182;4823.276508523609;4870.853874383774;4887.706737595756;4937.35814344133;4991.625628077982;4797.112534181188;4812.51874812516;4857.028594281087;4858.587020103189;4861.1979023460735;4844.321794948781;4852.75736213195;4854.781534831011;4856.732879691651;4858.149823780895;4536.5236650151255;4676.532346765296;4719.5752382285755;4727.3854398927915;4784.808607655794;4847.612191024639;4877.341558889504;4879.829205977774;4884.218525035977;4887.169181239269;4770.499097594703;4777.3311736356245;4781.832635857867;4784.712917224978;4786.832460863853 08:44:00 INFO - PROCESS | 32428 | |1;ext.html;558.8463172627527;565.9886802263958;567.3645517020935;578.2446641752052;586.6656006076538;29019.419611607755;38625.80687096564;40056.39915401271;40181.397279040764;43084;39486.60513394865;39920.201595968065;40304.59695403045;40317.79841100798;40347.394789078186;7590.544567325965;7758.418118641096;7775.183605721402;7778.922210777905;7783.571903545303;7654.885176722353;7747.767566973;7751.844963100734;7753.185915478878;7758.7672369829;7775.183605721402;7814.296713295802;7822.217778222189;7824;7825.530468171928;7718.575478348688;7754.06951165858;7798.961005194938;7803.258690424401;7805.141434442206;7664.655090520884;7779.18318576547;7781.455298129134;7782;7784.3772498200005;38070.23859522822;38315.425268620995;38439.8078009611;38467;38525.42211866824;2982.2544363909024;2996.625421822272;3008.9548656770166;3028.4094601552706;3057.6636569977286;26081.347966300993;29016.27459313513;29240.8537957311;29905.102846914626;30644.40333949903;3300.950485742716;3365.848536815849;3380.5427001499306;3434.793912365266;3472.097254713767;174386;174975.12512437484;175276;175736.12131939258;175919;49149.26276105861;49429.50570494249;49454.50545494499;49501.75249123731;49505;31498.527522087188;32467.837660811543;52682;52711;52806;12896.419661115273;13146.60560183196;13160.473581056842;13161.144525605805;13179.07746457758;9844.9015509844;9925.057119573628;9930.801383972424;9935.261329267349;9942.850857237147;17555.912220438815;17565;17587.29650813979;17614.647707045788;17635.823641763676;6704.195496540447;6822.454203663695;6947.4789390795895;6988.811901976676;7036.6481675916;757.6779868555952;781.4959351218432;804.3766081286932;846.2595229174473;864.1013346119964;27312.590311145348;27373.45253094927;27754.444911101666;28003.579946300822;28164.43671126566;749.4678778067633;899.9640014399482;925.5927391947522;963.802420503795;1055.2824079625775;13753.449862005407;14401;14673.853261467462;14812.925935370255;14862.479813206703;368492;371330;371822;372105;372238;46368.76815615968;46945.29582056272;46962.5303746965;47020.29469557959;47059;1078.7464945737902;1125.2404626876826;1148.7817314710178;1156.5720683347215;1157.6989982604416;27188.72811271941;28430.57354139731;28904.710952891044;29010.27474313159;29406.705932940396;40281.19437611173;40747.38878916759;40785;40907;40911.590884091966;281251;283160.42617656227;283543;284046;391182;33756.49365259474;35522.82238588894;36053;36186.8190659045;36938;38615.6138438612;38648.42027369535;38877.41683874801;39149.412758808074;39283.214335713696;33879;34037.48943765796;34086.48870266898;34116.658833412344;34130.90429148518;33040.33919321648;33325.666743333226;34063.829680851435;34386.82806585951;34884.30231395409;31740.841295793372;32212;32343;32454.350912981135;32479;29825.105246842628;31066.844665776527;31211.843940780152;31229.219269518442;31292.530612040384;23208.651870222297;23573.410664732834;23898.641520377558;24256.272311830675;24293.14973975973 08:44:00 INFO - PROCESS | 32428 | |2;jquery.html;345.1061750067325;368.74188068352163;377.71671246565074;379.3532027892444;386.5709062940136;12697.555585554495;15884.841151588495;16265.918670406647;16921.83078169218;17752.911235443837;13878.236696981661;14093.71812563748;14168.858311416883;14241.857581424183;14464.421423143061;4393.494748103977;4872.878178045542;5113.590912726973;5117.616178786588;5184.144616138333;3790.109324308799;3938.8818335449837;5073.137566613685;5159.122949098643;5757.337906140785;6072.574919755619;6089.177960975256;6094.481969032638;6095.329513753483;6156.938430615682;5780.682062486561;5903.173555702205;5940.138679891392;5953.910691339634;6122.571420000601;5265.420803711589;5269.209618557209;5272.393674727417;5272.762725677316;5277.656952298088;12635.810462843065;17301.82698173027;19286.71069933952;20081;20172.798272017386;1778.2086971297779;1785.9642807143784;1849.7502837116951;1874.7843997940138;2213.6347502662043;9123.406978546373;9479.810403791955;9779.364341317792;11396.974272315532;13309.334533273297;1720.8021077576113;1743.7820272465942;1767.1959258537336;1778.102058460482;1790.4091649755549;64099.3590064098;66300.33699662989;67016.6649166756;67223.66388168077;67845;9204.677836275832;9420.811583768424;9529.523523823782;9884.456354900549;10181.847272290921;13783.655408614864;13795.2412617305;13816.861831381557;13836.446542138201;13861.168329900036;6649.138241292446;6768;6833.36872830004;6976.790696279119;7008.544444611186;6319.968400158062;6355.936440635534;6486.805395838132;6494.350564943468;6528.37980391862;4299.935500967488;4321.740695558214;4331.5884990925815;4359.367891655692;4473.619742321874;1663.5009497151048;1769.8318659727306;1804.3504338438152;1857.8142185781314;1860.4697661166774;741.2920660768953;802.7712102050888;813.7762115418308;932.8460803967405;940.6989763275823;16226.107564084088;16775.58061048459;17281.481555553353;17461.912690436468;17716.645667086585;801.4189712458538;804.2319584796505;840.3487297344607;859.6432480520514;867.2758246863813;7749.92250077492;9368.34421590482;9723.465209413409;9741.467218523236;9801.03979204162;291829;294097;294266;380467;380469;83040;86619.56690216508;86956;87395.56302218448;87447;917.7797328641078;929.8558723397884;930.1210356213448;969.3892847506168;971.5967873332629;11576.826347604625;14894.627634309229;15611.548870979053;16202.837971620133;16418.75371869447;34181.65818341785;35228.47157292591;37954.43068353922;38030;39235.6076439232;45670.54329456663;48412.757936210095;48443.757781210865;48507;50834.49165508297;6439.871202576016;6689.130413046273;6893.896591551031;7192.71229150849;7518.736844210426;10631.20265980039;11243.831342529706;11378.943105284421;11484.770304593694;11758.176927614984;9371.344005919793;9723.02769723022;9967;10033.347832390871;10209.74475638115;9545;9656.27577931672;9790.902090979;10021.649242276486;10034.899651003689;9791.804163916824;9855.782448949216;9869.654562090293;10537.209709271681;10811.081058109834;7554.169041405331;7696.114946780968;7853;7906.802329941567;7940.28537431634;9159.404638698463;9934.900650993686;10263.357862741925;10367.222458315808;10468.371897686164 08:44:00 INFO - PROCESS | 32428 | |3;mootools.html;1356.2201734002952;1373.0594542738224;1428.7142571485706;1582.351235993243;1642.5729310379297;7204;7786;7788.026496687914;7792.415568832332;7794.532328060313;6541.084248205243;7357.558546487215;7596.658150383232;7601.733939312126;7645.350145237648;2182.7271591051117;2205.856619319747;2206.6689996500572;2211.7014203082617;2215.7451893032267;2142.260919982611;2168.035224325176;2183.4213933307688;2185.4536365908525;2191.2659259148127;1872.6722823505831;2065.0810389376734;2126.36209137259;2135.9679604805942;2159.265849611132;2138.8930553472264;2143.624865648513;2162.3296777998794;2164.567086582674;2170.2729585588845;2132.776058513865;2141;2143.5498545305504;2145.710329105582;2149.140343862452;7806.687732490694;7875.684972601089;7883.684652613889;7888.053433587948;7890.408219383569;4210.389493523422;4217.8312867485265;4249.532551419341;4265.466816647919;4367.192069467159;2824.096289187461;2916.1105862711865;2946.8084574502805;2948.6756456789735;2950.5574163875376;872.9258013068896;899.3389858454032;915.8671992561108;920.5029284186531;930.8696782450462;10407.68776936693;10476.476176191236;10490.632827850988;10493.422861742602;10519.894801051969;3881.6506514413836;4061.3095773718537;4155.459790227251;4223.176480586318;4261.957380426156;8921.55392230386;8934.240589549961;8934.553272336358;8935.597898094602;8941.418807777474;4334.8266069357505;4336.544662810359;4337.783110844508;4340.913181736348;4341.739495630272;3850.4994350734223;3884.514435695538;3888.2612303662213;3903.336432806373;3905.8047097645003;3479.739019573542;3565;3573.964260357363;3583.3191693578137;3601.4957905893198;1177.5996161305027;1194.4386138514883;1197.7843988082054;1209.7822391969355;1212.8362671039297;656.1273506236694;684.3567046975827;724.2069933422894;768.6425811997448;774.5159275452842;4800.927986080212;4890.315355850184;4923.950760492349;4952.281919121707;5123.666961647481;830.6428235858639;847.4025811802665;849.9150084991575;866.8569686001739;869.3827382558328;3319.4522903720617;3337.7496687748517;3453.5165076889257;3509.105178179599;3591.5151454553825;9136.543172841331;9379.48412837287;9553.665621703207;9556.808863822824;9569.330146889652;9490.572924218426;9543.379680320895;9552.14030737237;9560.330776845554;9571.473568953774;6813.761518346834;6863.6568171591225;6957.756478523329;6962.617056061864;6968.233494315621;4824.396950381202;4970.701757894538;5030.647854650139;5091.389033315878;5112.207607820794;8756.387052906235;8811.162939520735;8823.544110224553;8825.205731484197;8848.07095254989;8642.178992995656;8921.776955576162;9063.13900179482;9074.682386116454;9086.772830679285;6634.933650663432;6748.358905903931;6748.595084294958;6757.662116894037;6782.96608516974;7406.518576292524;7407.888881666887;7412.888806668012;7460.477766556289;7466.514676546224;6680.257017517617;6738.2587915328295;6825;6858.897116543156;6910.792676219721;6495.545311828127;6584.7036883341325;6660.10088638047;6694.631795251308;6705.329467053256;5982;6015;6039.909401358896;6041.607295525777;6061.484773794101;4252.978735106305;4340.131973605355;4359.212722783644;4432.312991486325;4458.933116003327;4248.575142485726;4411.250087485071;4452.977735111303;4483.080968401405;4520.276755719069 08:44:00 INFO - PROCESS | 32428 | |4;prototype.html;288.5455407732821;291.87887026883845;298.26477732389657;303.84807596201915;306.2573259844876;4692.788824502897;4743.644226682995;4751.192297309457;4759.524047595239;4760.761961901909;4691.929621055687;4692.507286734886;4701.27130294804;4707.976460117703;4709.835155769549;3537.2394935089014;3666.3583872822283;3669.5596528416627;3679;3680.245549662326;3548.361294966905;3684.2263124743836;3716.0524066363173;3725.795081270529;3733.533308336458;3692.4830523726564;3699.648533389324;3713.2387860488534;3720;3724.14344700719;3601.981990090033;3680.858933730539;3688.8708895188806;3691.8338674759566;3697.85208591656;3258.527513510551;3258.7230085442766;3259.706626403611;3265.248992731685;3267.428200065003;4591.540845915415;4608.815647374101;4615.723056616614;4615.9076818463445;4617.492075871652;4055.1686904184867;4202.91594168118;4206.537280899099;4209.7474151551005;4217.177650358181;4916.53292937174;4918.311436398907;4920.729359885205;4926.901461970776;4932.186189278765;3543.929121417583;3544.3620148373284;3550.1006961275593;3550.5384300041087;3553.271579326232;4935.703857768545;5080.1617733074;5154.561862241677;5197.232940800109;5204.271402003723;3554.7156227501737;3570.785932782814;3584.5877724062066;3602.819859007039;3604.5221459201603;3652.7990960497427;3660.871869484555;3667.9266414671556;3677.209399978964;3683.686886614668;4188.8324467020975;4197.790110494463;4200.6219440250525;4200.941538646041;4205.243056249843;4757.714537127784;4926.064047830901;4932.4081110267;4960.280759289883;4975.303457515951;1235.6601934467913;1244.9190802597802;1246.389269258075;1250.1498980693034;1251.1492185313891;763.8815983522563;787.338635546144;790.5019837502336;795.9482633628795;796.944049134887;3969.4641223435046;4214.452121224222;4218.514870789837;4422.270325396274;4448.7330760153845;5168.147255702767;5169.121249387613;5173.586113111018;5174.663646862942;5182.611304152204;4419.889502762392;4425.734455932655;4427.977860110679;4430.579094985971;4436.44544431946;2612.6211699303494;2712.1456741126876;2717.527050384141;2735.2478068531314;2736.5906558122583;4862.902741945141;4865.95134048662;4866.732329721899;4871.611590696705;4879.072976134523;5261.605674496262;5265.473452654704;5271.393789714155;5272.182811664122;5272.261883336336;4697.718136911796;4797.208460604031;4812.639052071038;4825.95174048262;4846.418429788307;5108.821191258288;5115.56517696;5117.667351622133;5120.667156634807;5157.974210128926;4945.608132996039;5047.823326183713;5057.266696329085;5060.709519072613;5063.265826455217;4644.74453905025;4745.406824146981;4818.95181048185;4821.132196204717;4828.66199366041;3578.606353301083;3602.5676918769914;3603.585587657453;3604.18905746205;3607.719259662782;5097.745112744274;5098.617603679665;5101.285819985279;5108.719020453762;5113.642045056959;4807.927881081857;4897.404375680895;4934.5312195341385;4963.4540200577185;4970.701757894538;4932.186189278872;4933.605311574994;4949.950500495093;4967.801287948441;4968.254761785761;4852.781624826821;4899;4899.632527560376;4902.754862256944;4911.533404326583;4780.832670856504;4816.783244753924;4865.148598995091;4980.975095124646;4985.875353116201;4870.537298956735;4887.975560122177;4889.682170658896;4898.21628539432;4898.730569818694 08:44:00 INFO - PROCESS | 32428 | |5;yui.html;610.4292486525102;619.2785405003169;637.1844039629275;694.6804469943824;729.3108012927783;11989.880101198985;13250.867491325083;13299.401526931299;13320.800187997176;13356.13185142965;12438.44027018784;12500.56248031319;12506.249625022505;12541.247525148474;12556.05829562782;621.6829416997341;736.3851184261135;746.8020974441778;766.3983772738402;777;758.381918736231;769.200031966754;769.9576523291216;770.8034451214933;771.5987686403067;812.4191203289647;813.0974618173823;813.686730608717;813.7233340664174;813.9226773456512;651.6025224612982;785.3991696352296;803.4255507312241;808.9433739638228;809.5466538738325;587.891240120579;588.1736160694231;588.8174665853556;588.8733922206703;588.902831032879;12579.874201257962;12587.685307867376;12606.243625382507;12628.747425051448;12632.431540580696;12139.210951288138;12456;12695.936520317431;13072;13078.869211307956;11411.315321080761;11475.598354057567;11789.469473873696;11803.173777835469;12394.132410731252;4004.4815137557575;4062.471878655756;4107.794610269475;4247.235497610429;4300.677449191292;60909;60921.6953915232;60947.781044379306;61106.69446652783;61128.69435652838;9639.662611808553;9891;9929.801403972024;10213.080822725842;10399.116075133546;17720.291188352323;17725.379611713786;17739.645207096044;17757.644847102987;17804.821951780574;6835.726570937107;6841.521093523405;6965.129358830146;7044.189918159477;7122.28777122294;3610.1696609779374;3686.281175170816;3728.067983004249;3729.7389182756947;3788.2802267569073;2658.7341265873647;2735.39821239327;2756.8621568921476;2758.255271076838;2766.0871912268904;495.11374639395797;503.114518447535;504.9899002019939;510.9412417572027;519.7349351830594;424.82157493852657;450.14697148902644;469.9965573500601;474.11814025911775;517.8032347707847;7431.256874312526;7812.492188007761;7849.686012559548;7888.566128862853;7968.681252749941;542.5117394345122;546.5873265684382;571.4228629084654;576.0552693582528;580.2688612348387;3563.5367402237544;3616.2405894762396;3647.6717095461536;3691.5016472775833;3789.7915614640906;76134;78320.60839695766;78423;105953;107742;78491;78584.60707696425;79139;79774.60112699399;81245.18754812494;41935;63786.68106659437;71963.64018179875;72062.63968680229;72621;7697.6151192441275;8352.749417517483;8419.915800842158;8432.45189062709;8464.322854171529;31516.369672606877;31949.36101277915;38015.239695206496;43315.9171020727;43687.344689830315;54688;60773.69613151906;62909.68545157245;63611;67074.66462667656;10523.210759192938;10697;10762.51568679427;11033.282836615594;11208.159388045766;12153.939230303791;12242.877571224173;12938.159019663692;13022.348882556023;13390.196588204739;11411.771764564495;12117.636470905887;12225.144239903122;12858.935705321413;12878.549250776552;11399.487023083815;11782.293062416282;11918.106142039209;12132.393380331125;12295.446704898122;11475.540978361107;11486.898537395024;12043.75912481763;12055.336956467128;12108.273503589813;9580.0898914603;9960.900390995997;10100.191984641064;10143.188544916537;10184.388936663823;9142.98183405146;9420.152186303265;9545.618175272912;9626.808076281357;9667.661631842851 08:44:00 INFO - PROCESS | 32428 | __end_tp_report 08:44:00 INFO - PROCESS | 32428 | __start_cc_report 08:44:00 INFO - PROCESS | 32428 | _x_x_mozilla_cycle_collect,970 08:44:00 INFO - PROCESS | 32428 | __end_cc_report 08:44:00 INFO - PROCESS | 32428 | __startTimestamp1471621440122__endTimestamp 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | ------- Summary: start ------- 08:44:00 INFO - PROCESS | 32428 | Number of tests: 6 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | [#0] dojo.html Cycles:165 Average:4594.54 Median:4732.88 stddev:481.12 (10.2%) stddev-sans-first:455.58 08:44:00 INFO - PROCESS | 32428 | Values: 2568.1 2573.8 2603.6 2613.4 2621.3 4482.0 4557.1 4600.6 4690.2 4695.0 4582.8 4608.4 4642.4 4652.4 4690.2 4059.6 4280.9 4320.5 4348.3 4357.6 4311.9 4315.7 4337.3 4343.9 4351.3 4126.2 4171.8 4179.4 4292.0 4295.9 4221.6 4289.8 4305.1 4339.1 4356.8 4266.7 4299.2 4302.7 4304.2 4311.5 4415.8 4698.3 4716.6 4721.7 4732.9 4865.7 4881.5 4891.8 4963.8 4998.6 5005.0 5008.0 5012.3 5015.8 5023.7 4526.5 4682.4 4694.4 4695.0 4698.2 5035.2 5087.3 5097.9 5143.7 5161.1 4937.7 4943.1 4944.2 4946.1 4949.8 4806.1 5023.5 5027.9 5029.8 5033.6 4847.1 4895.6 4896.7 4942.0 4970.7 4949.7 4957.9 4962.7 4966.0 4967.9 4080.9 4234.9 4246.8 4247.1 4252.0 3629.4 3665.6 3694.4 3697.9 3747.6 4287.4 4287.5 4297.9 4300.5 4301.6 4834.5 5007.8 5012.7 5019.5 5021.6 4210.9 4244.3 4254.7 4288.6 4291.1 4486.3 4492.9 4495.8 4497.3 4505.3 4676.2 4679.5 4704.2 4736.1 4736.5 4838.6 4927.2 4934.0 4951.7 5043.4 4721.7 4747.2 4753.7 4754.3 4763.0 4939.3 4950.1 4954.9 4958.0 4966.9 4823.3 4870.9 4887.7 4937.4 4991.6 4797.1 4812.5 4857.0 4858.6 4861.2 4844.3 4852.8 4854.8 4856.7 4858.1 4536.5 4676.5 4719.6 4727.4 4784.8 4847.6 4877.3 4879.8 4884.2 4887.2 4770.5 4777.3 4781.8 4784.7 4786.8 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | [#1] ext.html Cycles:180 Average:43742.74 Median:371963.50 stddev:78122.36 (21.0%) stddev-sans-first:78274.23 08:44:00 INFO - PROCESS | 32428 | Values: 558.8 566.0 567.4 578.2 586.7 29019.4 38625.8 40056.4 40181.4 43084.0 39486.6 39920.2 40304.6 40317.8 40347.4 7590.5 7758.4 7775.2 7778.9 7783.6 7654.9 7747.8 7751.8 7753.2 7758.8 7775.2 7814.3 7822.2 7824.0 7825.5 7718.6 7754.1 7799.0 7803.3 7805.1 7664.7 7779.2 7781.5 7782.0 7784.4 38070.2 38315.4 38439.8 38467.0 38525.4 2982.3 2996.6 3009.0 3028.4 3057.7 26081.3 29016.3 29240.9 29905.1 30644.4 3301.0 3365.8 3380.5 3434.8 3472.1 174386.0 174975.1 175276.0 175736.1 175919.0 49149.3 49429.5 49454.5 49501.8 49505.0 31498.5 32467.8 52682.0 52711.0 52806.0 12896.4 13146.6 13160.5 13161.1 13179.1 9844.9 9925.1 9930.8 9935.3 9942.9 17555.9 17565.0 17587.3 17614.6 17635.8 6704.2 6822.5 6947.5 6988.8 7036.6 757.7 781.5 804.4 846.3 864.1 27312.6 27373.5 27754.4 28003.6 28164.4 749.5 900.0 925.6 963.8 1055.3 13753.4 14401.0 14673.9 14812.9 14862.5 368492.0 371330.0 371822.0 372105.0 372238.0 46368.8 46945.3 46962.5 47020.3 47059.0 1078.7 1125.2 1148.8 1156.6 1157.7 27188.7 28430.6 28904.7 29010.3 29406.7 40281.2 40747.4 40785.0 40907.0 40911.6 281251.0 283160.4 283543.0 284046.0 391182.0 33756.5 35522.8 36053.0 36186.8 36938.0 38615.6 38648.4 38877.4 39149.4 39283.2 33879.0 34037.5 34086.5 34116.7 34130.9 33040.3 33325.7 34063.8 34386.8 34884.3 31740.8 32212.0 32343.0 32454.4 32479.0 29825.1 31066.8 31211.8 31229.2 31292.5 23208.7 23573.4 23898.6 24256.3 24293.1 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | [#2] jquery.html Cycles:180 Average:22463.22 Median:27953.81 stddev:55345.94 (198.0%) stddev-sans-first:55476.28 08:44:00 INFO - PROCESS | 32428 | Values: 345.1 368.7 377.7 379.4 386.6 12697.6 15884.8 16265.9 16921.8 17752.9 13878.2 14093.7 14168.9 14241.9 14464.4 4393.5 4872.9 5113.6 5117.6 5184.1 3790.1 3938.9 5073.1 5159.1 5757.3 6072.6 6089.2 6094.5 6095.3 6156.9 5780.7 5903.2 5940.1 5953.9 6122.6 5265.4 5269.2 5272.4 5272.8 5277.7 12635.8 17301.8 19286.7 20081.0 20172.8 1778.2 1786.0 1849.8 1874.8 2213.6 9123.4 9479.8 9779.4 11397.0 13309.3 1720.8 1743.8 1767.2 1778.1 1790.4 64099.4 66300.3 67016.7 67223.7 67845.0 9204.7 9420.8 9529.5 9884.5 10181.8 13783.7 13795.2 13816.9 13836.4 13861.2 6649.1 6768.0 6833.4 6976.8 7008.5 6320.0 6355.9 6486.8 6494.4 6528.4 4299.9 4321.7 4331.6 4359.4 4473.6 1663.5 1769.8 1804.4 1857.8 1860.5 741.3 802.8 813.8 932.8 940.7 16226.1 16775.6 17281.5 17461.9 17716.6 801.4 804.2 840.3 859.6 867.3 7749.9 9368.3 9723.5 9741.5 9801.0 291829.0 294097.0 294266.0 380467.0 380469.0 83040.0 86619.6 86956.0 87395.6 87447.0 917.8 929.9 930.1 969.4 971.6 11576.8 14894.6 15611.5 16202.8 16418.8 34181.7 35228.5 37954.4 38030.0 39235.6 45670.5 48412.8 48443.8 48507.0 50834.5 6439.9 6689.1 6893.9 7192.7 7518.7 10631.2 11243.8 11378.9 11484.8 11758.2 9371.3 9723.0 9967.0 10033.3 10209.7 9545.0 9656.3 9790.9 10021.6 10034.9 9791.8 9855.8 9869.7 10537.2 10811.1 7554.2 7696.1 7853.0 7906.8 7940.3 9159.4 9934.9 10263.4 10367.2 10468.4 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | [#3] mootools.html Cycles:180 Average:5021.06 Median:5000.67 stddev:2842.05 (56.8%) stddev-sans-first:2836.68 08:44:00 INFO - PROCESS | 32428 | Values: 1356.2 1373.1 1428.7 1582.4 1642.6 7204.0 7786.0 7788.0 7792.4 7794.5 6541.1 7357.6 7596.7 7601.7 7645.4 2182.7 2205.9 2206.7 2211.7 2215.7 2142.3 2168.0 2183.4 2185.5 2191.3 1872.7 2065.1 2126.4 2136.0 2159.3 2138.9 2143.6 2162.3 2164.6 2170.3 2132.8 2141.0 2143.5 2145.7 2149.1 7806.7 7875.7 7883.7 7888.1 7890.4 4210.4 4217.8 4249.5 4265.5 4367.2 2824.1 2916.1 2946.8 2948.7 2950.6 872.9 899.3 915.9 920.5 930.9 10407.7 10476.5 10490.6 10493.4 10519.9 3881.7 4061.3 4155.5 4223.2 4262.0 8921.6 8934.2 8934.6 8935.6 8941.4 4334.8 4336.5 4337.8 4340.9 4341.7 3850.5 3884.5 3888.3 3903.3 3905.8 3479.7 3565.0 3574.0 3583.3 3601.5 1177.6 1194.4 1197.8 1209.8 1212.8 656.1 684.4 724.2 768.6 774.5 4800.9 4890.3 4924.0 4952.3 5123.7 830.6 847.4 849.9 866.9 869.4 3319.5 3337.7 3453.5 3509.1 3591.5 9136.5 9379.5 9553.7 9556.8 9569.3 9490.6 9543.4 9552.1 9560.3 9571.5 6813.8 6863.7 6957.8 6962.6 6968.2 4824.4 4970.7 5030.6 5091.4 5112.2 8756.4 8811.2 8823.5 8825.2 8848.1 8642.2 8921.8 9063.1 9074.7 9086.8 6634.9 6748.4 6748.6 6757.7 6783.0 7406.5 7407.9 7412.9 7460.5 7466.5 6680.3 6738.3 6825.0 6858.9 6910.8 6495.5 6584.7 6660.1 6694.6 6705.3 5982.0 6015.0 6039.9 6041.6 6061.5 4253.0 4340.1 4359.2 4432.3 4458.9 4248.6 4411.3 4453.0 4483.1 4520.3 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | [#4] prototype.html Cycles:180 Average:4115.01 Median:4704.62 stddev:1203.01 (25.6%) stddev-sans-first:1171.60 08:44:00 INFO - PROCESS | 32428 | Values: 288.5 291.9 298.3 303.8 306.3 4692.8 4743.6 4751.2 4759.5 4760.8 4691.9 4692.5 4701.3 4708.0 4709.8 3537.2 3666.4 3669.6 3679.0 3680.2 3548.4 3684.2 3716.1 3725.8 3733.5 3692.5 3699.6 3713.2 3720.0 3724.1 3602.0 3680.9 3688.9 3691.8 3697.9 3258.5 3258.7 3259.7 3265.2 3267.4 4591.5 4608.8 4615.7 4615.9 4617.5 4055.2 4202.9 4206.5 4209.7 4217.2 4916.5 4918.3 4920.7 4926.9 4932.2 3543.9 3544.4 3550.1 3550.5 3553.3 4935.7 5080.2 5154.6 5197.2 5204.3 3554.7 3570.8 3584.6 3602.8 3604.5 3652.8 3660.9 3667.9 3677.2 3683.7 4188.8 4197.8 4200.6 4200.9 4205.2 4757.7 4926.1 4932.4 4960.3 4975.3 1235.7 1244.9 1246.4 1250.1 1251.1 763.9 787.3 790.5 795.9 796.9 3969.5 4214.5 4218.5 4422.3 4448.7 5168.1 5169.1 5173.6 5174.7 5182.6 4419.9 4425.7 4428.0 4430.6 4436.4 2612.6 2712.1 2717.5 2735.2 2736.6 4862.9 4866.0 4866.7 4871.6 4879.1 5261.6 5265.5 5271.4 5272.2 5272.3 4697.7 4797.2 4812.6 4826.0 4846.4 5108.8 5115.6 5117.7 5120.7 5158.0 4945.6 5047.8 5057.3 5060.7 5063.3 4644.7 4745.4 4819.0 4821.1 4828.7 3578.6 3602.6 3603.6 3604.2 3607.7 5097.7 5098.6 5101.3 5108.7 5113.6 4807.9 4897.4 4934.5 4963.5 4970.7 4932.2 4933.6 4950.0 4967.8 4968.3 4852.8 4899.0 4899.6 4902.8 4911.5 4780.8 4816.8 4865.1 4981.0 4985.9 4870.5 4888.0 4889.7 4898.2 4898.7 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - PROCESS | 32428 | [#5] yui.html Cycles:180 Average:16843.92 Median:472.06 stddev:23590.21 (4997.3%) stddev-sans-first:23624.89 08:44:00 INFO - PROCESS | 32428 | Values: 610.4 619.3 637.2 694.7 729.3 11989.9 13250.9 13299.4 13320.8 13356.1 12438.4 12500.6 12506.2 12541.2 12556.1 621.7 736.4 746.8 766.4 777.0 758.4 769.2 770.0 770.8 771.6 812.4 813.1 813.7 813.7 813.9 651.6 785.4 803.4 808.9 809.5 587.9 588.2 588.8 588.9 588.9 12579.9 12587.7 12606.2 12628.7 12632.4 12139.2 12456.0 12695.9 13072.0 13078.9 11411.3 11475.6 11789.5 11803.2 12394.1 4004.5 4062.5 4107.8 4247.2 4300.7 60909.0 60921.7 60947.8 61106.7 61128.7 9639.7 9891.0 9929.8 10213.1 10399.1 17720.3 17725.4 17739.6 17757.6 17804.8 6835.7 6841.5 6965.1 7044.2 7122.3 3610.2 3686.3 3728.1 3729.7 3788.3 2658.7 2735.4 2756.9 2758.3 2766.1 495.1 503.1 505.0 510.9 519.7 424.8 450.1 470.0 474.1 517.8 7431.3 7812.5 7849.7 7888.6 7968.7 542.5 546.6 571.4 576.1 580.3 3563.5 3616.2 3647.7 3691.5 3789.8 76134.0 78320.6 78423.0 105953.0 107742.0 78491.0 78584.6 79139.0 79774.6 81245.2 41935.0 63786.7 71963.6 72062.6 72621.0 7697.6 8352.7 8419.9 8432.5 8464.3 31516.4 31949.4 38015.2 43315.9 43687.3 54688.0 60773.7 62909.7 63611.0 67074.7 10523.2 10697.0 10762.5 11033.3 11208.2 12153.9 12242.9 12938.2 13022.3 13390.2 11411.8 12117.6 12225.1 12858.9 12878.5 11399.5 11782.3 11918.1 12132.4 12295.4 11475.5 11486.9 12043.8 12055.3 12108.3 9580.1 9960.9 10100.2 10143.2 10184.4 9143.0 9420.2 9545.6 9626.8 9667.7 08:44:00 INFO - PROCESS | 32428 | -------- Summary: end -------- 08:44:00 INFO - PROCESS | 32428 | 08:44:00 INFO - TEST-INFO | 32428: exit 0 08:44:00 INFO - TEST-OK | dromaeo_css | took 1119292ms 08:44:00 INFO - TEST-START | kraken 08:44:00 INFO - operating with platform_type : linux_ 08:44:00 INFO - Initialising browser for kraken test... 08:44:00 INFO - TEST-INFO | started process 32732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7QfgBX/profile http://localhost:60060/getInfo.html) 08:44:05 INFO - PROCESS | 32732 | __metrics Screen width/height:1600/1200 08:44:05 INFO - PROCESS | 32732 | colorDepth:24 08:44:05 INFO - PROCESS | 32732 | Browser inner width/height: 1024/697 08:44:05 INFO - PROCESS | 32732 | __metrics 08:44:05 INFO - PROCESS | 32732 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:44:05 INFO - PROCESS | 32732 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:06 INFO - PROCESS | 32732 | console.error: PushService: 08:44:06 INFO - PROCESS | 32732 | stateChangeProcessEnqueue: Error transitioning state 08:44:06 INFO - PROCESS | 32732 | UnknownError 08:44:06 INFO - TEST-INFO | 32732: exit 0 08:44:06 INFO - Browser initialized. 08:44:06 INFO - Running cycle 1/1 for kraken test... 08:44:06 INFO - TEST-INFO | started process 347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7QfgBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:18 INFO - PROCESS | 347 | RSS: Main: 157032448 08:44:18 INFO - PROCESS | 347 | 08:44:21 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60060/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:22 INFO - PROCESS | 347 | RSS: Main: 212475904 08:44:22 INFO - PROCESS | 347 | 08:44:25 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60060/tests/kraken/driver.html?testName=audio-dft) 08:44:25 INFO - PROCESS | 347 | RSS: Main: 191488000 08:44:25 INFO - PROCESS | 347 | 08:44:29 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60060/tests/kraken/driver.html?testName=audio-fft) 08:44:29 INFO - PROCESS | 347 | RSS: Main: 270340096 08:44:29 INFO - PROCESS | 347 | 08:44:32 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60060/tests/kraken/driver.html?testName=audio-oscillator) 08:44:32 INFO - PROCESS | 347 | RSS: Main: 180322304 08:44:32 INFO - PROCESS | 347 | 08:44:34 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60060/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:35 INFO - PROCESS | 347 | RSS: Main: 184348672 08:44:35 INFO - PROCESS | 347 | 08:44:38 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60060/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:39 INFO - PROCESS | 347 | RSS: Main: 221683712 08:44:39 INFO - PROCESS | 347 | 08:44:42 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60060/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:43 INFO - PROCESS | 347 | RSS: Main: 215203840 08:44:43 INFO - PROCESS | 347 | 08:44:46 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60060/tests/kraken/driver.html?testName=json-parse-financial) 08:44:46 INFO - PROCESS | 347 | RSS: Main: 218411008 08:44:46 INFO - PROCESS | 347 | 08:44:48 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60060/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:49 INFO - PROCESS | 347 | RSS: Main: 181821440 08:44:49 INFO - PROCESS | 347 | 08:44:51 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:51 INFO - PROCESS | 347 | RSS: Main: 189132800 08:44:51 INFO - PROCESS | 347 | 08:44:53 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:54 INFO - PROCESS | 347 | RSS: Main: 194162688 08:44:54 INFO - PROCESS | 347 | 08:44:57 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:58 INFO - PROCESS | 347 | RSS: Main: 189104128 08:44:58 INFO - PROCESS | 347 | 08:45:01 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:01 INFO - PROCESS | 347 | RSS: Main: 192073728 08:45:01 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | Cycle 1(1): loaded http://localhost:60060/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60060/tests/kraken/driver.html?testName=ai-astar) 08:45:03 INFO - PROCESS | 347 | RSS: Main: 243376128 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | __start_tp_report 08:45:03 INFO - PROCESS | 347 | _x_x_mozilla_page_load 08:45:03 INFO - PROCESS | 347 | _x_x_mozilla_page_load_details 08:45:03 INFO - PROCESS | 347 | |i|pagename|runs| 08:45:03 INFO - PROCESS | 347 | |0;ai-astar;109;116;114;117;114;116;116;114;116;116 08:45:03 INFO - PROCESS | 347 | |1;audio-beat-detection;155;124;134;191;121;147;157;123;187;121 08:45:03 INFO - PROCESS | 347 | |2;audio-dft;161;161;163;163;161;162;162;161;161;160 08:45:03 INFO - PROCESS | 347 | |3;audio-fft;77;75;76;109;76;89;75;75;100;75 08:45:03 INFO - PROCESS | 347 | |4;audio-oscillator;87;86;134;86;86;87;132;86;86;135 08:45:03 INFO - PROCESS | 347 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 08:45:03 INFO - PROCESS | 347 | |6;imaging-darkroom;147;146;146;145;145;146;145;146;146;145 08:45:03 INFO - PROCESS | 347 | |7;imaging-desaturate;95;94;94;95;95;95;95;95;95;94 08:45:03 INFO - PROCESS | 347 | |8;json-parse-financial;63;62;63;63;63;65;63;64;72;62 08:45:03 INFO - PROCESS | 347 | |9;json-stringify-tinderbox;65;65;65;65;67;64;65;66;65;66 08:45:03 INFO - PROCESS | 347 | |10;stanford-crypto-aes;82;82;82;87;82;83;83;82;82;81 08:45:03 INFO - PROCESS | 347 | |11;stanford-crypto-ccm;135;134;150;142;133;131;133;131;165;133 08:45:03 INFO - PROCESS | 347 | |12;stanford-crypto-pbkdf2;178;176;173;172;174;170;171;174;172;171 08:45:03 INFO - PROCESS | 347 | |13;stanford-crypto-sha256-iterative;68;69;68;69;68;69;68;68;67;67 08:45:03 INFO - PROCESS | 347 | __end_tp_report 08:45:03 INFO - PROCESS | 347 | __start_cc_report 08:45:03 INFO - PROCESS | 347 | _x_x_mozilla_cycle_collect,1949 08:45:03 INFO - PROCESS | 347 | __end_cc_report 08:45:03 INFO - PROCESS | 347 | __startTimestamp1471621503675__endTimestamp 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | ------- Summary: start ------- 08:45:03 INFO - PROCESS | 347 | Number of tests: 14 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.30 (2.0%) stddev-sans-first:1.13 08:45:03 INFO - PROCESS | 347 | Values: 109.0 116.0 114.0 117.0 114.0 116.0 116.0 114.0 116.0 116.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:151.00 stddev:26.49 (17.5%) stddev-sans-first:27.90 08:45:03 INFO - PROCESS | 347 | Values: 155.0 124.0 134.0 191.0 121.0 147.0 157.0 123.0 187.0 121.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:45:03 INFO - PROCESS | 347 | Values: 161.0 161.0 163.0 163.0 161.0 162.0 162.0 161.0 161.0 160.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:12.43 (16.5%) stddev-sans-first:13.01 08:45:03 INFO - PROCESS | 347 | Values: 77.0 75.0 76.0 109.0 76.0 89.0 75.0 75.0 100.0 75.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:86.00 stddev:22.90 (26.6%) stddev-sans-first:23.76 08:45:03 INFO - PROCESS | 347 | Values: 87.0 86.0 134.0 86.0 86.0 87.0 132.0 86.0 86.0 135.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:45:03 INFO - PROCESS | 347 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 08:45:03 INFO - PROCESS | 347 | Values: 147.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:45:03 INFO - PROCESS | 347 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:63.00 stddev:2.94 (4.7%) stddev-sans-first:3.10 08:45:03 INFO - PROCESS | 347 | Values: 63.0 62.0 63.0 63.0 63.0 65.0 63.0 64.0 72.0 62.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:45:03 INFO - PROCESS | 347 | Values: 65.0 65.0 65.0 65.0 67.0 64.0 65.0 66.0 65.0 66.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:1.65 (2.0%) stddev-sans-first:1.73 08:45:03 INFO - PROCESS | 347 | Values: 82.0 82.0 82.0 87.0 82.0 83.0 83.0 82.0 82.0 81.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:134.50 stddev:10.97 (8.2%) stddev-sans-first:11.55 08:45:03 INFO - PROCESS | 347 | Values: 135.0 134.0 150.0 142.0 133.0 131.0 133.0 131.0 165.0 133.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.50 stddev:2.47 (1.4%) stddev-sans-first:1.88 08:45:03 INFO - PROCESS | 347 | Values: 178.0 176.0 173.0 172.0 174.0 170.0 171.0 174.0 172.0 171.0 08:45:03 INFO - PROCESS | 347 | 08:45:03 INFO - PROCESS | 347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 08:45:03 INFO - PROCESS | 347 | Values: 68.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 67.0 67.0 08:45:03 INFO - PROCESS | 347 | -------- Summary: end -------- 08:45:03 INFO - PROCESS | 347 | 08:45:04 INFO - TEST-INFO | 347: exit 0 08:45:04 INFO - TEST-OK | kraken | took 63837ms 08:45:04 INFO - SUITE-END | took 1183s 08:45:04 INFO - Completed test suite (00:19:43) 08:45:04 INFO - javascript benchmark 08:45:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.1011645923927, 2573.7812285955692, 2603.6094585812125, 2613.3597268669178, 2621.3315604520844, 4482.0, 4557.088582283548, 4600.562946520079, 4690.1557719610455, 4695.037517308952, 4582.77086145693, 4608.400907881971, 4642.373279607252, 4652.441706995157, 4690.202665546857, 4059.63463288304, 4280.850170244042, 4320.4599425071865, 4348.30427131659, 4357.564243575633, 4311.935320970188, 4315.697901146921, 4337.262665346899, 4343.891402714926, 4351.28203846365, 4126.236646220459, 4171.791410429466, 4179.352200408911, 4292.012837047481, 4295.871123866289, 4221.577842215785, 4289.764062976535, 4305.052888364555, 4339.067100573392, 4356.803943822504, 4266.722663026893, 4299.226139294926, 4302.741835489881, 4304.203722311382, 4311.461067366579, 4415.845445409395, 4698.295255711637, 4716.646251531149, 4721.740304283263, 4732.881677958044, 4865.70805751656, 4881.511848815126, 4891.804327826882, 4963.8262660806695, 4998.600111991032, 5004.9749751251375, 5008.048470790538, 5012.298278241049, 5015.774290156952, 5023.673461225008, 4526.524714904954, 4682.391289132425, 4694.389729335233, 4694.95305046952, 4698.177818881716, 5035.244713293036, 5087.313212716236, 5097.898042039138, 5143.691378517301, 5161.096808058574, 4937.654364194544, 4943.085529177114, 4944.184209605447, 4946.060248552763, 4949.802007919643, 4806.110869489155, 5023.547880690755, 5027.874303142377, 5029.84910452687, 5033.5721463676, 4847.127517046965, 4895.559399654048, 4896.6572339935865, 4941.975290123526, 4970.701757894538, 4949.653524253267, 4957.925631115536, 4962.6774259673, 4966.0, 4967.850964471072, 4080.9183816323507, 4234.87295381139, 4246.808893599796, 4247.065645557972, 4252.0, 3629.4374371972385, 3665.633436656313, 3694.4458331250526, 3697.8520859165333, 3747.6252374762307, 4287.356896465492, 4287.549807270254, 4297.892552686145, 4300.483941926988, 4301.634361079344, 4834.492378300298, 5007.824726134568, 5012.724300163526, 5019.52314530119, 5021.648484606042, 4210.894727631772, 4244.278472659656, 4254.702170848011, 4288.571142885687, 4291.0559676871035, 4486.304622783474, 4492.887677808081, 4495.797689103998, 4497.280435130363, 4505.301678239878, 4676.158291507561, 4679.485256621769, 4704.200285951465, 4736.0764650894125, 4736.502667219892, 4838.564529192389, 4927.236278376858, 4933.975330123327, 4951.678140920829, 5043.36957880265, 4721.693089949143, 4747.216709242936, 4753.714777113384, 4754.263089221176, 4762.976185119052, 4939.308496810378, 4950.084234416644, 4954.925676114934, 4957.975210123926, 4966.875828104182, 4823.276508523609, 4870.853874383774, 4887.706737595756, 4937.35814344133, 4991.625628077982, 4797.112534181188, 4812.51874812516, 4857.028594281087, 4858.587020103189, 4861.1979023460735, 4844.321794948781, 4852.75736213195, 4854.781534831011, 4856.732879691651, 4858.149823780895, 4536.5236650151255, 4676.532346765296, 4719.5752382285755, 4727.3854398927915, 4784.808607655794, 4847.612191024639, 4877.341558889504, 4879.829205977774, 4884.218525035977, 4887.169181239269, 4770.499097594703, 4777.3311736356245, 4781.832635857867, 4784.712917224978, 4786.832460863853], "value": 4563.892476180867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8463172627527, 565.9886802263958, 567.3645517020935, 578.2446641752052, 586.6656006076538, 29019.419611607755, 38625.80687096564, 40056.39915401271, 40181.397279040764, 43084.0, 39486.60513394865, 39920.201595968065, 40304.59695403045, 40317.79841100798, 40347.394789078186, 7590.544567325965, 7758.418118641096, 7775.183605721402, 7778.922210777905, 7783.571903545303, 7654.885176722353, 7747.767566973, 7751.844963100734, 7753.185915478878, 7758.7672369829, 7775.183605721402, 7814.296713295802, 7822.217778222189, 7824.0, 7825.530468171928, 7718.575478348688, 7754.06951165858, 7798.961005194938, 7803.258690424401, 7805.141434442206, 7664.655090520884, 7779.18318576547, 7781.455298129134, 7782.0, 7784.3772498200005, 38070.23859522822, 38315.425268620995, 38439.8078009611, 38467.0, 38525.42211866824, 2982.2544363909024, 2996.625421822272, 3008.9548656770166, 3028.4094601552706, 3057.6636569977286, 26081.347966300993, 29016.27459313513, 29240.8537957311, 29905.102846914626, 30644.40333949903, 3300.950485742716, 3365.848536815849, 3380.5427001499306, 3434.793912365266, 3472.097254713767, 174386.0, 174975.12512437484, 175276.0, 175736.12131939258, 175919.0, 49149.26276105861, 49429.50570494249, 49454.50545494499, 49501.75249123731, 49505.0, 31498.527522087188, 32467.837660811543, 52682.0, 52711.0, 52806.0, 12896.419661115273, 13146.60560183196, 13160.473581056842, 13161.144525605805, 13179.07746457758, 9844.9015509844, 9925.057119573628, 9930.801383972424, 9935.261329267349, 9942.850857237147, 17555.912220438815, 17565.0, 17587.29650813979, 17614.647707045788, 17635.823641763676, 6704.195496540447, 6822.454203663695, 6947.4789390795895, 6988.811901976676, 7036.6481675916, 757.6779868555952, 781.4959351218432, 804.3766081286932, 846.2595229174473, 864.1013346119964, 27312.590311145348, 27373.45253094927, 27754.444911101666, 28003.579946300822, 28164.43671126566, 749.4678778067633, 899.9640014399482, 925.5927391947522, 963.802420503795, 1055.2824079625775, 13753.449862005407, 14401.0, 14673.853261467462, 14812.925935370255, 14862.479813206703, 368492.0, 371330.0, 371822.0, 372105.0, 372238.0, 46368.76815615968, 46945.29582056272, 46962.5303746965, 47020.29469557959, 47059.0, 1078.7464945737902, 1125.2404626876826, 1148.7817314710178, 1156.5720683347215, 1157.6989982604416, 27188.72811271941, 28430.57354139731, 28904.710952891044, 29010.27474313159, 29406.705932940396, 40281.19437611173, 40747.38878916759, 40785.0, 40907.0, 40911.590884091966, 281251.0, 283160.42617656227, 283543.0, 284046.0, 391182.0, 33756.49365259474, 35522.82238588894, 36053.0, 36186.8190659045, 36938.0, 38615.6138438612, 38648.42027369535, 38877.41683874801, 39149.412758808074, 39283.214335713696, 33879.0, 34037.48943765796, 34086.48870266898, 34116.658833412344, 34130.90429148518, 33040.33919321648, 33325.666743333226, 34063.829680851435, 34386.82806585951, 34884.30231395409, 31740.841295793372, 32212.0, 32343.0, 32454.350912981135, 32479.0, 29825.105246842628, 31066.844665776527, 31211.843940780152, 31229.219269518442, 31292.530612040384, 23208.651870222297, 23573.410664732834, 23898.641520377558, 24256.272311830675, 24293.14973975973], "value": 16826.559751689052, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.1061750067325, 368.74188068352163, 377.71671246565074, 379.3532027892444, 386.5709062940136, 12697.555585554495, 15884.841151588495, 16265.918670406647, 16921.83078169218, 17752.911235443837, 13878.236696981661, 14093.71812563748, 14168.858311416883, 14241.857581424183, 14464.421423143061, 4393.494748103977, 4872.878178045542, 5113.590912726973, 5117.616178786588, 5184.144616138333, 3790.109324308799, 3938.8818335449837, 5073.137566613685, 5159.122949098643, 5757.337906140785, 6072.574919755619, 6089.177960975256, 6094.481969032638, 6095.329513753483, 6156.938430615682, 5780.682062486561, 5903.173555702205, 5940.138679891392, 5953.910691339634, 6122.571420000601, 5265.420803711589, 5269.209618557209, 5272.393674727417, 5272.762725677316, 5277.656952298088, 12635.810462843065, 17301.82698173027, 19286.71069933952, 20081.0, 20172.798272017386, 1778.2086971297779, 1785.9642807143784, 1849.7502837116951, 1874.7843997940138, 2213.6347502662043, 9123.406978546373, 9479.810403791955, 9779.364341317792, 11396.974272315532, 13309.334533273297, 1720.8021077576113, 1743.7820272465942, 1767.1959258537336, 1778.102058460482, 1790.4091649755549, 64099.3590064098, 66300.33699662989, 67016.6649166756, 67223.66388168077, 67845.0, 9204.677836275832, 9420.811583768424, 9529.523523823782, 9884.456354900549, 10181.847272290921, 13783.655408614864, 13795.2412617305, 13816.861831381557, 13836.446542138201, 13861.168329900036, 6649.138241292446, 6768.0, 6833.36872830004, 6976.790696279119, 7008.544444611186, 6319.968400158062, 6355.936440635534, 6486.805395838132, 6494.350564943468, 6528.37980391862, 4299.935500967488, 4321.740695558214, 4331.5884990925815, 4359.367891655692, 4473.619742321874, 1663.5009497151048, 1769.8318659727306, 1804.3504338438152, 1857.8142185781314, 1860.4697661166774, 741.2920660768953, 802.7712102050888, 813.7762115418308, 932.8460803967405, 940.6989763275823, 16226.107564084088, 16775.58061048459, 17281.481555553353, 17461.912690436468, 17716.645667086585, 801.4189712458538, 804.2319584796505, 840.3487297344607, 859.6432480520514, 867.2758246863813, 7749.92250077492, 9368.34421590482, 9723.465209413409, 9741.467218523236, 9801.03979204162, 291829.0, 294097.0, 294266.0, 380467.0, 380469.0, 83040.0, 86619.56690216508, 86956.0, 87395.56302218448, 87447.0, 917.7797328641078, 929.8558723397884, 930.1210356213448, 969.3892847506168, 971.5967873332629, 11576.826347604625, 14894.627634309229, 15611.548870979053, 16202.837971620133, 16418.75371869447, 34181.65818341785, 35228.47157292591, 37954.43068353922, 38030.0, 39235.6076439232, 45670.54329456663, 48412.757936210095, 48443.757781210865, 48507.0, 50834.49165508297, 6439.871202576016, 6689.130413046273, 6893.896591551031, 7192.71229150849, 7518.736844210426, 10631.20265980039, 11243.831342529706, 11378.943105284421, 11484.770304593694, 11758.176927614984, 9371.344005919793, 9723.02769723022, 9967.0, 10033.347832390871, 10209.74475638115, 9545.0, 9656.27577931672, 9790.902090979, 10021.649242276486, 10034.899651003689, 9791.804163916824, 9855.782448949216, 9869.654562090293, 10537.209709271681, 10811.081058109834, 7554.169041405331, 7696.114946780968, 7853.0, 7906.802329941567, 7940.28537431634, 9159.404638698463, 9934.900650993686, 10263.357862741925, 10367.222458315808, 10468.371897686164], "value": 8018.377862141132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.2201734002952, 1373.0594542738224, 1428.7142571485706, 1582.351235993243, 1642.5729310379297, 7204.0, 7786.0, 7788.026496687914, 7792.415568832332, 7794.532328060313, 6541.084248205243, 7357.558546487215, 7596.658150383232, 7601.733939312126, 7645.350145237648, 2182.7271591051117, 2205.856619319747, 2206.6689996500572, 2211.7014203082617, 2215.7451893032267, 2142.260919982611, 2168.035224325176, 2183.4213933307688, 2185.4536365908525, 2191.2659259148127, 1872.6722823505831, 2065.0810389376734, 2126.36209137259, 2135.9679604805942, 2159.265849611132, 2138.8930553472264, 2143.624865648513, 2162.3296777998794, 2164.567086582674, 2170.2729585588845, 2132.776058513865, 2141.0, 2143.5498545305504, 2145.710329105582, 2149.140343862452, 7806.687732490694, 7875.684972601089, 7883.684652613889, 7888.053433587948, 7890.408219383569, 4210.389493523422, 4217.8312867485265, 4249.532551419341, 4265.466816647919, 4367.192069467159, 2824.096289187461, 2916.1105862711865, 2946.8084574502805, 2948.6756456789735, 2950.5574163875376, 872.9258013068896, 899.3389858454032, 915.8671992561108, 920.5029284186531, 930.8696782450462, 10407.68776936693, 10476.476176191236, 10490.632827850988, 10493.422861742602, 10519.894801051969, 3881.6506514413836, 4061.3095773718537, 4155.459790227251, 4223.176480586318, 4261.957380426156, 8921.55392230386, 8934.240589549961, 8934.553272336358, 8935.597898094602, 8941.418807777474, 4334.8266069357505, 4336.544662810359, 4337.783110844508, 4340.913181736348, 4341.739495630272, 3850.4994350734223, 3884.514435695538, 3888.2612303662213, 3903.336432806373, 3905.8047097645003, 3479.739019573542, 3565.0, 3573.964260357363, 3583.3191693578137, 3601.4957905893198, 1177.5996161305027, 1194.4386138514883, 1197.7843988082054, 1209.7822391969355, 1212.8362671039297, 656.1273506236694, 684.3567046975827, 724.2069933422894, 768.6425811997448, 774.5159275452842, 4800.927986080212, 4890.315355850184, 4923.950760492349, 4952.281919121707, 5123.666961647481, 830.6428235858639, 847.4025811802665, 849.9150084991575, 866.8569686001739, 869.3827382558328, 3319.4522903720617, 3337.7496687748517, 3453.5165076889257, 3509.105178179599, 3591.5151454553825, 9136.543172841331, 9379.48412837287, 9553.665621703207, 9556.808863822824, 9569.330146889652, 9490.572924218426, 9543.379680320895, 9552.14030737237, 9560.330776845554, 9571.473568953774, 6813.761518346834, 6863.6568171591225, 6957.756478523329, 6962.617056061864, 6968.233494315621, 4824.396950381202, 4970.701757894538, 5030.647854650139, 5091.389033315878, 5112.207607820794, 8756.387052906235, 8811.162939520735, 8823.544110224553, 8825.205731484197, 8848.07095254989, 8642.178992995656, 8921.776955576162, 9063.13900179482, 9074.682386116454, 9086.772830679285, 6634.933650663432, 6748.358905903931, 6748.595084294958, 6757.662116894037, 6782.96608516974, 7406.518576292524, 7407.888881666887, 7412.888806668012, 7460.477766556289, 7466.514676546224, 6680.257017517617, 6738.2587915328295, 6825.0, 6858.897116543156, 6910.792676219721, 6495.545311828127, 6584.7036883341325, 6660.10088638047, 6694.631795251308, 6705.329467053256, 5982.0, 6015.0, 6039.909401358896, 6041.607295525777, 6061.484773794101, 4252.978735106305, 4340.131973605355, 4359.212722783644, 4432.312991486325, 4458.933116003327, 4248.575142485726, 4411.250087485071, 4452.977735111303, 4483.080968401405, 4520.276755719069], "value": 4033.644931355252, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5455407732821, 291.87887026883845, 298.26477732389657, 303.84807596201915, 306.2573259844876, 4692.788824502897, 4743.644226682995, 4751.192297309457, 4759.524047595239, 4760.761961901909, 4691.929621055687, 4692.507286734886, 4701.27130294804, 4707.976460117703, 4709.835155769549, 3537.2394935089014, 3666.3583872822283, 3669.5596528416627, 3679.0, 3680.245549662326, 3548.361294966905, 3684.2263124743836, 3716.0524066363173, 3725.795081270529, 3733.533308336458, 3692.4830523726564, 3699.648533389324, 3713.2387860488534, 3720.0, 3724.14344700719, 3601.981990090033, 3680.858933730539, 3688.8708895188806, 3691.8338674759566, 3697.85208591656, 3258.527513510551, 3258.7230085442766, 3259.706626403611, 3265.248992731685, 3267.428200065003, 4591.540845915415, 4608.815647374101, 4615.723056616614, 4615.9076818463445, 4617.492075871652, 4055.1686904184867, 4202.91594168118, 4206.537280899099, 4209.7474151551005, 4217.177650358181, 4916.53292937174, 4918.311436398907, 4920.729359885205, 4926.901461970776, 4932.186189278765, 3543.929121417583, 3544.3620148373284, 3550.1006961275593, 3550.5384300041087, 3553.271579326232, 4935.703857768545, 5080.1617733074, 5154.561862241677, 5197.232940800109, 5204.271402003723, 3554.7156227501737, 3570.785932782814, 3584.5877724062066, 3602.819859007039, 3604.5221459201603, 3652.7990960497427, 3660.871869484555, 3667.9266414671556, 3677.209399978964, 3683.686886614668, 4188.8324467020975, 4197.790110494463, 4200.6219440250525, 4200.941538646041, 4205.243056249843, 4757.714537127784, 4926.064047830901, 4932.4081110267, 4960.280759289883, 4975.303457515951, 1235.6601934467913, 1244.9190802597802, 1246.389269258075, 1250.1498980693034, 1251.1492185313891, 763.8815983522563, 787.338635546144, 790.5019837502336, 795.9482633628795, 796.944049134887, 3969.4641223435046, 4214.452121224222, 4218.514870789837, 4422.270325396274, 4448.7330760153845, 5168.147255702767, 5169.121249387613, 5173.586113111018, 5174.663646862942, 5182.611304152204, 4419.889502762392, 4425.734455932655, 4427.977860110679, 4430.579094985971, 4436.44544431946, 2612.6211699303494, 2712.1456741126876, 2717.527050384141, 2735.2478068531314, 2736.5906558122583, 4862.902741945141, 4865.95134048662, 4866.732329721899, 4871.611590696705, 4879.072976134523, 5261.605674496262, 5265.473452654704, 5271.393789714155, 5272.182811664122, 5272.261883336336, 4697.718136911796, 4797.208460604031, 4812.639052071038, 4825.95174048262, 4846.418429788307, 5108.821191258288, 5115.56517696, 5117.667351622133, 5120.667156634807, 5157.974210128926, 4945.608132996039, 5047.823326183713, 5057.266696329085, 5060.709519072613, 5063.265826455217, 4644.74453905025, 4745.406824146981, 4818.95181048185, 4821.132196204717, 4828.66199366041, 3578.606353301083, 3602.5676918769914, 3603.585587657453, 3604.18905746205, 3607.719259662782, 5097.745112744274, 5098.617603679665, 5101.285819985279, 5108.719020453762, 5113.642045056959, 4807.927881081857, 4897.404375680895, 4934.5312195341385, 4963.4540200577185, 4970.701757894538, 4932.186189278872, 4933.605311574994, 4949.950500495093, 4967.801287948441, 4968.254761785761, 4852.781624826821, 4899.0, 4899.632527560376, 4902.754862256944, 4911.533404326583, 4780.832670856504, 4816.783244753924, 4865.148598995091, 4980.975095124646, 4985.875353116201, 4870.537298956735, 4887.975560122177, 4889.682170658896, 4898.21628539432, 4898.730569818694], "value": 3729.2295631967336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.4292486525102, 619.2785405003169, 637.1844039629275, 694.6804469943824, 729.3108012927783, 11989.880101198985, 13250.867491325083, 13299.401526931299, 13320.800187997176, 13356.13185142965, 12438.44027018784, 12500.56248031319, 12506.249625022505, 12541.247525148474, 12556.05829562782, 621.6829416997341, 736.3851184261135, 746.8020974441778, 766.3983772738402, 777.0, 758.381918736231, 769.200031966754, 769.9576523291216, 770.8034451214933, 771.5987686403067, 812.4191203289647, 813.0974618173823, 813.686730608717, 813.7233340664174, 813.9226773456512, 651.6025224612982, 785.3991696352296, 803.4255507312241, 808.9433739638228, 809.5466538738325, 587.891240120579, 588.1736160694231, 588.8174665853556, 588.8733922206703, 588.902831032879, 12579.874201257962, 12587.685307867376, 12606.243625382507, 12628.747425051448, 12632.431540580696, 12139.210951288138, 12456.0, 12695.936520317431, 13072.0, 13078.869211307956, 11411.315321080761, 11475.598354057567, 11789.469473873696, 11803.173777835469, 12394.132410731252, 4004.4815137557575, 4062.471878655756, 4107.794610269475, 4247.235497610429, 4300.677449191292, 60909.0, 60921.6953915232, 60947.781044379306, 61106.69446652783, 61128.69435652838, 9639.662611808553, 9891.0, 9929.801403972024, 10213.080822725842, 10399.116075133546, 17720.291188352323, 17725.379611713786, 17739.645207096044, 17757.644847102987, 17804.821951780574, 6835.726570937107, 6841.521093523405, 6965.129358830146, 7044.189918159477, 7122.28777122294, 3610.1696609779374, 3686.281175170816, 3728.067983004249, 3729.7389182756947, 3788.2802267569073, 2658.7341265873647, 2735.39821239327, 2756.8621568921476, 2758.255271076838, 2766.0871912268904, 495.11374639395797, 503.114518447535, 504.9899002019939, 510.9412417572027, 519.7349351830594, 424.82157493852657, 450.14697148902644, 469.9965573500601, 474.11814025911775, 517.8032347707847, 7431.256874312526, 7812.492188007761, 7849.686012559548, 7888.566128862853, 7968.681252749941, 542.5117394345122, 546.5873265684382, 571.4228629084654, 576.0552693582528, 580.2688612348387, 3563.5367402237544, 3616.2405894762396, 3647.6717095461536, 3691.5016472775833, 3789.7915614640906, 76134.0, 78320.60839695766, 78423.0, 105953.0, 107742.0, 78491.0, 78584.60707696425, 79139.0, 79774.60112699399, 81245.18754812494, 41935.0, 63786.68106659437, 71963.64018179875, 72062.63968680229, 72621.0, 7697.6151192441275, 8352.749417517483, 8419.915800842158, 8432.45189062709, 8464.322854171529, 31516.369672606877, 31949.36101277915, 38015.239695206496, 43315.9171020727, 43687.344689830315, 54688.0, 60773.69613151906, 62909.68545157245, 63611.0, 67074.66462667656, 10523.210759192938, 10697.0, 10762.51568679427, 11033.282836615594, 11208.159388045766, 12153.939230303791, 12242.877571224173, 12938.159019663692, 13022.348882556023, 13390.196588204739, 11411.771764564495, 12117.636470905887, 12225.144239903122, 12858.935705321413, 12878.549250776552, 11399.487023083815, 11782.293062416282, 11918.106142039209, 12132.393380331125, 12295.446704898122, 11475.540978361107, 11486.898537395024, 12043.75912481763, 12055.336956467128, 12108.273503589813, 9580.0898914603, 9960.900390995997, 10100.191984641064, 10143.188544916537, 10184.388936663823, 9142.98183405146, 9420.152186303265, 9545.618175272912, 9626.808076281357, 9667.661631842851], "value": 6395.064247557604, "unit": "score"}], "name": "dromaeo_css", "value": 6243.643904690132, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 114.0, 117.0, 114.0, 116.0, 116.0, 114.0, 116.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 134.0, 191.0, 121.0, 147.0, 157.0, 123.0, 187.0, 121.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 163.0, 161.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 109.0, 76.0, 89.0, 75.0, 75.0, 100.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 134.0, 86.0, 86.0, 87.0, 132.0, 86.0, 86.0, 135.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 65.0, 63.0, 64.0, 72.0, 62.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0, 66.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 87.0, 82.0, 83.0, 83.0, 82.0, 82.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 150.0, 142.0, 133.0, 131.0, 133.0, 131.0, 165.0, 133.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 173.0, 172.0, 174.0, 170.0, 171.0, 174.0, 172.0, 171.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1554.5999999999997, "alertThreshold": 2.0}]} 08:45:04 INFO - Return code: 0 08:45:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:45:04 INFO - # TBPL SUCCESS # 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - [mozharness: 2016-08-19 15:45:04.957998Z] Finished run-tests step (success) 08:45:04 INFO - Running post-run listener: _resource_record_post_run 08:45:05 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 396984320; Read time: 192; Write time: 312416 08:45:05 INFO - TinderboxPrint: CPU usage
13.0% 08:45:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 08:45:05 INFO - TinderboxPrint: I/O write bytes / time
396,984,320 / 312,416 08:45:05 INFO - TinderboxPrint: CPU idle
8,327.6 (87.0%) 08:45:05 INFO - TinderboxPrint: CPU user
1,198.2 (12.5%) 08:45:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:45:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113860608; Read time: 0; Write time: 111208 08:45:05 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282509312; Read time: 176; Write time: 201208 08:45:05 INFO - Running post-run listener: _upload_blobber_files 08:45:05 INFO - Blob upload gear active. 08:45:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:45:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:45:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:45:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:06 INFO - (blobuploader) - INFO - Done attempting. 08:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:15 INFO - (blobuploader) - INFO - Done attempting. 08:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:15 INFO - (blobuploader) - INFO - Done attempting. 08:45:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:15 INFO - Return code: 0 08:45:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed3b6b6d7cd604bf7079f34b1b127655aba7066cfe90e87ef4658a8c39474c1ff8e38f242a8c6b9d2ed3e288e6ae04a44105d6591cdf22039c582fc02c0df90d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb0a84b8e19a29456a5d65bd353af14cb48e77fdb6723ebda61d43b05569b30a9a3cd98c057f4be40431fca74b18cf630cefdc78fc46b06978980ef6f075ee6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50b3809a0b2f442fcd2e4d915b4a32663374ff4107a1a9e89d67da0580e8dead96c7f31c0f08721abdf2293a60b056375f52f1d4b23856eed8985e302760945a"} 08:45:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:15 INFO - Contents: 08:45:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed3b6b6d7cd604bf7079f34b1b127655aba7066cfe90e87ef4658a8c39474c1ff8e38f242a8c6b9d2ed3e288e6ae04a44105d6591cdf22039c582fc02c0df90d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb0a84b8e19a29456a5d65bd353af14cb48e77fdb6723ebda61d43b05569b30a9a3cd98c057f4be40431fca74b18cf630cefdc78fc46b06978980ef6f075ee6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50b3809a0b2f442fcd2e4d915b4a32663374ff4107a1a9e89d67da0580e8dead96c7f31c0f08721abdf2293a60b056375f52f1d4b23856eed8985e302760945a"} 08:45:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:15 INFO - Copying logs to upload dir... 08:45:15 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.759556 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-19 08:45:15.829290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:15.832782) ========= 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=00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321 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-Non-PGO/sha512/ed3b6b6d7cd604bf7079f34b1b127655aba7066cfe90e87ef4658a8c39474c1ff8e38f242a8c6b9d2ed3e288e6ae04a44105d6591cdf22039c582fc02c0df90d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb0a84b8e19a29456a5d65bd353af14cb48e77fdb6723ebda61d43b05569b30a9a3cd98c057f4be40431fca74b18cf630cefdc78fc46b06978980ef6f075ee6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50b3809a0b2f442fcd2e4d915b4a32663374ff4107a1a9e89d67da0580e8dead96c7f31c0f08721abdf2293a60b056375f52f1d4b23856eed8985e302760945a"} build_url:https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/HuDQ0u5SSs-U9RH0PHfIRQ/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-Non-PGO/sha512/ed3b6b6d7cd604bf7079f34b1b127655aba7066cfe90e87ef4658a8c39474c1ff8e38f242a8c6b9d2ed3e288e6ae04a44105d6591cdf22039c582fc02c0df90d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb0a84b8e19a29456a5d65bd353af14cb48e77fdb6723ebda61d43b05569b30a9a3cd98c057f4be40431fca74b18cf630cefdc78fc46b06978980ef6f075ee6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50b3809a0b2f442fcd2e4d915b4a32663374ff4107a1a9e89d67da0580e8dead96c7f31c0f08721abdf2293a60b056375f52f1d4b23856eed8985e302760945a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:15.860133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:15.860468) ========= 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=00204705a9daa57ed339a427000001b9-1471620263.386910-1568876321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 08:45:15.945402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:45:15.945890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 08:45:15.946583) ========= ========= Total master_lag: 0.22 =========