builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1471889830.33 results: success (0) buildid: 20160822094813 builduid: da92e60b93434033a0e19423815b9a92 revision: d15eeb67d8bff77fdbce4714f9a04f8dec63e576 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.330437) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.330892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.331191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.342713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.343074) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 11:17:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 126K=0.09s 2016-08-22 11:17:10 (126 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.214607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.571741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.572069) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016577 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.622011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:10.622365) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d15eeb67d8bff77fdbce4714f9a04f8dec63e576 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d15eeb67d8bff77fdbce4714f9a04f8dec63e576 --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=6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 11:17:10,985 truncating revision to first 12 chars 2016-08-22 11:17:10,985 Setting DEBUG logging. 2016-08-22 11:17:10,985 attempt 1/10 2016-08-22 11:17:10,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d15eeb67d8bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 11:17:11,248 unpacking tar archive at: autoland-d15eeb67d8bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:11.189989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:11.190311) ========= script_repo_revision: d15eeb67d8bff77fdbce4714f9a04f8dec63e576 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:11.190684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:11.190946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 11:17:11.199904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-22 11:17:11.200227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:11 INFO - MultiFileLogger online at 20160822 11:17:11 in /builds/slave/test 11:17:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:17:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:11 INFO - {'append_to_log': False, 11:17:11 INFO - 'base_work_dir': '/builds/slave/test', 11:17:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:17:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:11 INFO - 'branch': 'Autoland-Non-PGO', 11:17:11 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:11 INFO - 'config_files': ('talos/linux_config.py',), 11:17:11 INFO - 'default_actions': ('clobber', 11:17:11 INFO - 'read-buildbot-config', 11:17:11 INFO - 'download-and-extract', 11:17:11 INFO - 'populate-webroot', 11:17:11 INFO - 'create-virtualenv', 11:17:11 INFO - 'install', 11:17:11 INFO - 'run-tests'), 11:17:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:11 INFO - 'download_minidump_stackwalk': True, 11:17:11 INFO - 'download_symbols': 'ondemand', 11:17:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:11 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:11 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:11 INFO - 'installer_path': 'installer.exe', 11:17:11 INFO - 'log_level': 'info', 11:17:11 INFO - 'log_name': 'talos', 11:17:11 INFO - 'log_to_console': True, 11:17:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:11 INFO - 'opt_config_files': (), 11:17:11 INFO - 'pip_index': False, 11:17:11 INFO - 'sps_profile': False, 11:17:11 INFO - 'sps_profile_interval': 0, 11:17:11 INFO - 'suite': 'dromaeojs', 11:17:11 INFO - 'system_bits': '32', 11:17:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:11 INFO - 'title': 'talos-linux64-ix-023', 11:17:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:11 INFO - 'use_talos_json': True, 11:17:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:11 INFO - 'work_dir': 'build'} 11:17:11 INFO - [mozharness: 2016-08-22 18:17:11.652527Z] Running clobber step. 11:17:11 INFO - Running pre-action listener: _resource_record_pre_action 11:17:11 INFO - Running main action method: clobber 11:17:11 INFO - rmtree: /builds/slave/test/build 11:17:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:12 INFO - Running post-action listener: _resource_record_post_action 11:17:12 INFO - [mozharness: 2016-08-22 18:17:12.135852Z] Finished clobber step (success) 11:17:12 INFO - [mozharness: 2016-08-22 18:17:12.135952Z] Running read-buildbot-config step. 11:17:12 INFO - Running pre-action listener: _resource_record_pre_action 11:17:12 INFO - Running main action method: read_buildbot_config 11:17:12 INFO - Using buildbot properties: 11:17:12 INFO - { 11:17:12 INFO - "project": "", 11:17:12 INFO - "product": "firefox", 11:17:12 INFO - "script_repo_revision": "production", 11:17:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:17:12 INFO - "repository": "", 11:17:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:17:12 INFO - "buildid": "20160822094813", 11:17:12 INFO - "pgo_build": "False", 11:17:12 INFO - "basedir": "/builds/slave/test", 11:17:12 INFO - "buildnumber": 453, 11:17:12 INFO - "slavename": "talos-linux64-ix-023", 11:17:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:17:12 INFO - "platform": "ubuntu64_hw", 11:17:12 INFO - "scheduler": "tests-autoland-linux64-talos", 11:17:12 INFO - "branch": "autoland", 11:17:12 INFO - "repo_path": "integration/autoland", 11:17:12 INFO - "revision": "d15eeb67d8bff77fdbce4714f9a04f8dec63e576", 11:17:12 INFO - "stage_platform": "linux64", 11:17:12 INFO - "builduid": "da92e60b93434033a0e19423815b9a92", 11:17:12 INFO - "slavebuilddir": "test" 11:17:12 INFO - } 11:17:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:17:12 INFO - Running post-action listener: _resource_record_post_action 11:17:12 INFO - [mozharness: 2016-08-22 18:17:12.138365Z] Finished read-buildbot-config step (success) 11:17:12 INFO - [mozharness: 2016-08-22 18:17:12.138453Z] Running download-and-extract step. 11:17:12 INFO - Running pre-action listener: _resource_record_pre_action 11:17:12 INFO - Running main action method: download_and_extract 11:17:12 INFO - mkdir: /builds/slave/test/build/tests 11:17:12 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')]} 11:17:12 INFO - trying https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:17:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:12 INFO - Downloaded 1361 bytes. 11:17:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:17:12 INFO - Using the following test package requirements: 11:17:12 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:17:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'jsshell-linux-x86_64.zip'], 11:17:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:12 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:12 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')]} 11:17:12 INFO - trying https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:13 INFO - Downloaded 20331073 bytes. 11:17:13 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 11:17:17 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 11:17:17 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')]} 11:17:17 INFO - trying https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:17:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:18 INFO - Downloaded 20331073 bytes. 11:17:18 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 11:17:23 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')]} 11:17:23 INFO - trying https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:24 INFO - Downloaded 14413981 bytes. 11:17:24 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 11:17:24 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')]} 11:17:24 INFO - trying https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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 11:17:25 INFO - Downloaded 55760899 bytes. 11:17:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:25 INFO - mkdir: /builds/slave/test/properties 11:17:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:25 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:25 INFO - Contents: 11:17:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:17:26 INFO - Running post-action listener: _resource_record_post_action 11:17:26 INFO - Running post-action listener: set_extra_try_arguments 11:17:26 INFO - [mozharness: 2016-08-22 18:17:26.115388Z] Finished download-and-extract step (success) 11:17:26 INFO - [mozharness: 2016-08-22 18:17:26.115612Z] Running populate-webroot step. 11:17:26 INFO - Running pre-action listener: _resource_record_pre_action 11:17:26 INFO - Running main action method: populate_webroot 11:17:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:26 INFO - '--tppagecycles', 11:17:26 INFO - '7'], 11:17:26 INFO - 'tests': ['tsvgm']}}, 11:17:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['damp', 'tps']}, 11:17:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'tests': ['damp', 'tps']}, 11:17:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['dromaeo_dom']}, 11:17:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['basic_compositor_video']}, 11:17:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:17:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['a11yr', 11:17:26 INFO - 'ts_paint', 11:17:26 INFO - 'tpaint', 11:17:26 INFO - 'sessionrestore', 11:17:26 INFO - 'sessionrestore_no_auto_restore', 11:17:26 INFO - 'tabpaint']}, 11:17:26 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:26 INFO - 'ts_paint', 11:17:26 INFO - 'tpaint', 11:17:26 INFO - 'sessionrestore', 11:17:26 INFO - 'sessionrestore_no_auto_restore', 11:17:26 INFO - 'tabpaint']}, 11:17:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:17:26 INFO - 'ts_paint', 11:17:26 INFO - 'tpaint', 11:17:26 INFO - 'sessionrestore', 11:17:26 INFO - 'sessionrestore_no_auto_restore', 11:17:26 INFO - 'tabpaint']}, 11:17:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:17:26 INFO - 'ts_paint', 11:17:26 INFO - 'tpaint', 11:17:26 INFO - 'sessionrestore', 11:17:26 INFO - 'sessionrestore_no_auto_restore', 11:17:26 INFO - 'tabpaint']}, 11:17:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['a11yr', 11:17:26 INFO - 'ts_paint', 11:17:26 INFO - 'tpaint', 11:17:26 INFO - 'sessionrestore', 11:17:26 INFO - 'sessionrestore_no_auto_restore', 11:17:26 INFO - 'tabpaint']}, 11:17:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['a11yr', 11:17:26 INFO - 'ts_paint', 11:17:26 INFO - 'tpaint', 11:17:26 INFO - 'sessionrestore', 11:17:26 INFO - 'sessionrestore_no_auto_restore', 11:17:26 INFO - 'tabpaint']}, 11:17:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['tsvgx', 11:17:26 INFO - 'tsvgr_opacity', 11:17:26 INFO - 'tart', 11:17:26 INFO - 'tscrollx', 11:17:26 INFO - 'cart']}, 11:17:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:26 INFO - 'tsvgr_opacity', 11:17:26 INFO - 'tart', 11:17:26 INFO - 'tscrollx', 11:17:26 INFO - 'cart']}, 11:17:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'talos_options': ['--disable-e10s'], 11:17:26 INFO - 'tests': ['tp5o']}, 11:17:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'tests': ['tp5o']}, 11:17:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'talos_options': ['--disable-e10s', 11:17:26 INFO - '--xperf_path', 11:17:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:26 INFO - 'tests': ['tp5n']}, 11:17:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:26 INFO - 'talos_options': ['--xperf_path', 11:17:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:26 INFO - 'tests': ['tp5n']}}, 11:17:26 INFO - 'talos.zip': {'path': '', 11:17:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:26 INFO - Running post-action listener: _resource_record_post_action 11:17:26 INFO - [mozharness: 2016-08-22 18:17:26.133025Z] Finished populate-webroot step (success) 11:17:26 INFO - [mozharness: 2016-08-22 18:17:26.133114Z] Running create-virtualenv step. 11:17:26 INFO - Running pre-action listener: _resource_record_pre_action 11:17:26 INFO - Running main action method: create_virtualenv 11:17:26 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:26 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 11:17:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:26 INFO - Using real prefix '/usr' 11:17:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:28 INFO - Installing pip.................done. 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:28 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 11:17:28 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 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:28 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 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:28 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 11:17:28 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 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:29 INFO - Downloading/unpacking psutil>=3.1.1 11:17:29 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 11:17:29 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 11:17:29 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 11:17:29 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 11:17:29 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 11:17:29 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 11:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:31 INFO - Installing collected packages: psutil 11:17:31 INFO - Running setup.py install for psutil 11:17:31 INFO - building 'psutil._psutil_linux' extension 11:17:31 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 11:17:31 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 11:17:31 INFO - building 'psutil._psutil_posix' extension 11:17:31 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 11:17:31 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 11:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:31 INFO - Successfully installed psutil 11:17:31 INFO - Cleaning up... 11:17:31 INFO - Return code: 0 11:17:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:17:31 INFO - Using env: {'DISPLAY': ':0', 11:17:31 INFO - 'HOME': '/home/cltbld', 11:17:31 INFO - 'LANG': 'en_US.UTF-8', 11:17:31 INFO - 'LANGUAGE': 'en_US:en', 11:17:31 INFO - 'LOGNAME': 'cltbld', 11:17:31 INFO - 'MAIL': '/var/mail/cltbld', 11:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:31 INFO - 'MOZ_NO_REMOTE': '1', 11:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:31 INFO - 'NO_EM_RESTART': '1', 11:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:31 INFO - 'PWD': '/builds/slave/test', 11:17:31 INFO - 'SHELL': '/bin/bash', 11:17:31 INFO - 'SHLVL': '1', 11:17:31 INFO - 'TERM': 'linux', 11:17:31 INFO - 'TMOUT': '86400', 11:17:31 INFO - 'USER': 'cltbld', 11:17:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:31 INFO - '_': '/tools/buildbot/bin/python'} 11:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:33 INFO - Installing collected packages: mozsystemmonitor 11:17:33 INFO - Running setup.py install for mozsystemmonitor 11:17:33 INFO - Successfully installed mozsystemmonitor 11:17:33 INFO - Cleaning up... 11:17:33 INFO - Return code: 0 11:17:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:33 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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:33 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 11:17:33 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 11:17:33 INFO - Using env: {'DISPLAY': ':0', 11:17:33 INFO - 'HOME': '/home/cltbld', 11:17:33 INFO - 'LANG': 'en_US.UTF-8', 11:17:33 INFO - 'LANGUAGE': 'en_US:en', 11:17:33 INFO - 'LOGNAME': 'cltbld', 11:17:33 INFO - 'MAIL': '/var/mail/cltbld', 11:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:33 INFO - 'MOZ_NO_REMOTE': '1', 11:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:33 INFO - 'NO_EM_RESTART': '1', 11:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:33 INFO - 'PWD': '/builds/slave/test', 11:17:33 INFO - 'SHELL': '/bin/bash', 11:17:33 INFO - 'SHLVL': '1', 11:17:33 INFO - 'TERM': 'linux', 11:17:33 INFO - 'TMOUT': '86400', 11:17:33 INFO - 'USER': 'cltbld', 11:17:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:33 INFO - '_': '/tools/buildbot/bin/python'} 11:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:35 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 11:17:35 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 11:17:35 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 11:17:35 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 11:17:35 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 11:17:35 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 11:17:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:36 INFO - warning: no files found matching '*.txt' 11:17:36 INFO - no previously-included directories found matching 'build' 11:17:36 INFO - no previously-included directories found matching 'dist' 11:17:36 INFO - no previously-included directories found matching '.git*' 11:17:36 INFO - Installing collected packages: jsonschema, functools32 11:17:36 INFO - Running setup.py install for functools32 11:17:36 INFO - warning: no files found matching '*.txt' 11:17:36 INFO - no previously-included directories found matching 'build' 11:17:36 INFO - no previously-included directories found matching 'dist' 11:17:36 INFO - no previously-included directories found matching '.git*' 11:17:36 INFO - Successfully installed jsonschema functools32 11:17:36 INFO - Cleaning up... 11:17:36 INFO - Return code: 0 11:17:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:17:36 INFO - Using env: {'DISPLAY': ':0', 11:17:36 INFO - 'HOME': '/home/cltbld', 11:17:36 INFO - 'LANG': 'en_US.UTF-8', 11:17:36 INFO - 'LANGUAGE': 'en_US:en', 11:17:36 INFO - 'LOGNAME': 'cltbld', 11:17:36 INFO - 'MAIL': '/var/mail/cltbld', 11:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:36 INFO - 'MOZ_NO_REMOTE': '1', 11:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:36 INFO - 'NO_EM_RESTART': '1', 11:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:36 INFO - 'PWD': '/builds/slave/test', 11:17:36 INFO - 'SHELL': '/bin/bash', 11:17:36 INFO - 'SHLVL': '1', 11:17:36 INFO - 'TERM': 'linux', 11:17:36 INFO - 'TMOUT': '86400', 11:17:36 INFO - 'USER': 'cltbld', 11:17:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:36 INFO - '_': '/tools/buildbot/bin/python'} 11:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:36 INFO - Cleaning up... 11:17:36 INFO - Return code: 0 11:17:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:17:36 INFO - Using env: {'DISPLAY': ':0', 11:17:36 INFO - 'HOME': '/home/cltbld', 11:17:36 INFO - 'LANG': 'en_US.UTF-8', 11:17:36 INFO - 'LANGUAGE': 'en_US:en', 11:17:36 INFO - 'LOGNAME': 'cltbld', 11:17:36 INFO - 'MAIL': '/var/mail/cltbld', 11:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:36 INFO - 'MOZ_NO_REMOTE': '1', 11:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:36 INFO - 'NO_EM_RESTART': '1', 11:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:36 INFO - 'PWD': '/builds/slave/test', 11:17:36 INFO - 'SHELL': '/bin/bash', 11:17:36 INFO - 'SHLVL': '1', 11:17:36 INFO - 'TERM': 'linux', 11:17:36 INFO - 'TMOUT': '86400', 11:17:36 INFO - 'USER': 'cltbld', 11:17:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:36 INFO - '_': '/tools/buildbot/bin/python'} 11:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:36 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:38 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:39 INFO - Downloading docopt-0.6.1.tar.gz 11:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:39 INFO - Running setup.py install for blobuploader 11:17:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:39 INFO - Running setup.py install for requests 11:17:39 INFO - Running setup.py install for docopt 11:17:40 INFO - Successfully installed blobuploader requests docopt 11:17:40 INFO - Cleaning up... 11:17:40 INFO - Return code: 0 11:17:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:40 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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:40 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 11:17:40 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 11:17:40 INFO - Using env: {'DISPLAY': ':0', 11:17:40 INFO - 'HOME': '/home/cltbld', 11:17:40 INFO - 'LANG': 'en_US.UTF-8', 11:17:40 INFO - 'LANGUAGE': 'en_US:en', 11:17:40 INFO - 'LOGNAME': 'cltbld', 11:17:40 INFO - 'MAIL': '/var/mail/cltbld', 11:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:40 INFO - 'MOZ_NO_REMOTE': '1', 11:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:40 INFO - 'NO_EM_RESTART': '1', 11:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:40 INFO - 'PWD': '/builds/slave/test', 11:17:40 INFO - 'SHELL': '/bin/bash', 11:17:40 INFO - 'SHLVL': '1', 11:17:40 INFO - 'TERM': 'linux', 11:17:40 INFO - 'TMOUT': '86400', 11:17:40 INFO - 'USER': 'cltbld', 11:17:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:40 INFO - '_': '/tools/buildbot/bin/python'} 11:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:40 INFO - Running setup.py (path:/tmp/pip-SlGn6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:40 INFO - Running setup.py (path:/tmp/pip-8nJ1Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:40 INFO - Running setup.py (path:/tmp/pip-07VYub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:40 INFO - Running setup.py (path:/tmp/pip-MWAbnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:40 INFO - Running setup.py (path:/tmp/pip-BI7Hp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:40 INFO - Running setup.py (path:/tmp/pip-cy979s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:40 INFO - Running setup.py (path:/tmp/pip-VWIM0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:40 INFO - Running setup.py (path:/tmp/pip-kk1RvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:40 INFO - Running setup.py (path:/tmp/pip-iREFjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:40 INFO - Running setup.py (path:/tmp/pip-2fdUKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:41 INFO - Running setup.py (path:/tmp/pip-ejYQyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:41 INFO - Running setup.py (path:/tmp/pip-A20n8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:41 INFO - Running setup.py (path:/tmp/pip-L0q_u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:41 INFO - Running setup.py (path:/tmp/pip-WojDQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:41 INFO - Running setup.py (path:/tmp/pip-lnAS5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:41 INFO - Running setup.py (path:/tmp/pip-wBEs33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:41 INFO - Running setup.py (path:/tmp/pip-vlm25p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:41 INFO - Running setup.py install for manifestparser 11:17:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:41 INFO - Running setup.py install for mozcrash 11:17:41 INFO - Running setup.py install for mozdebug 11:17:41 INFO - Running setup.py install for mozdevice 11:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:41 INFO - Running setup.py install for mozfile 11:17:42 INFO - Running setup.py install for mozhttpd 11:17:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Running setup.py install for mozinfo 11:17:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Running setup.py install for mozInstall 11:17:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Running setup.py install for mozleak 11:17:42 INFO - Running setup.py install for mozlog 11:17:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Running setup.py install for moznetwork 11:17:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Running setup.py install for mozprocess 11:17:42 INFO - Running setup.py install for mozprofile 11:17:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:42 INFO - Running setup.py install for mozrunner 11:17:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:43 INFO - Running setup.py install for mozscreenshot 11:17:43 INFO - Running setup.py install for moztest 11:17:43 INFO - Running setup.py install for mozversion 11:17:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:43 INFO - Cleaning up... 11:17:43 INFO - Return code: 0 11:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:43 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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:43 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 11:17:43 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 11:17:43 INFO - Using env: {'DISPLAY': ':0', 11:17:43 INFO - 'HOME': '/home/cltbld', 11:17:43 INFO - 'LANG': 'en_US.UTF-8', 11:17:43 INFO - 'LANGUAGE': 'en_US:en', 11:17:43 INFO - 'LOGNAME': 'cltbld', 11:17:43 INFO - 'MAIL': '/var/mail/cltbld', 11:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:43 INFO - 'MOZ_NO_REMOTE': '1', 11:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:43 INFO - 'NO_EM_RESTART': '1', 11:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:43 INFO - 'PWD': '/builds/slave/test', 11:17:43 INFO - 'SHELL': '/bin/bash', 11:17:43 INFO - 'SHLVL': '1', 11:17:43 INFO - 'TERM': 'linux', 11:17:43 INFO - 'TMOUT': '86400', 11:17:43 INFO - 'USER': 'cltbld', 11:17:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:43 INFO - '_': '/tools/buildbot/bin/python'} 11:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:43 INFO - Running setup.py (path:/tmp/pip-dfjtMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:43 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)) 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:43 INFO - Running setup.py (path:/tmp/pip-SnQWx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:43 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)) 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:43 INFO - Running setup.py (path:/tmp/pip-J5retw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:43 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)) 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:43 INFO - Running setup.py (path:/tmp/pip-ZmcmNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:43 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)) 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:43 INFO - Running setup.py (path:/tmp/pip-cKCQk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:43 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)) 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:43 INFO - Running setup.py (path:/tmp/pip-mS1MA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:44 INFO - Running setup.py (path:/tmp/pip-yRC6P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:44 INFO - Running setup.py (path:/tmp/pip-PbfHc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:44 INFO - Running setup.py (path:/tmp/pip-mfuBw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:44 INFO - Running setup.py (path:/tmp/pip-fVxxhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:44 INFO - Running setup.py (path:/tmp/pip-GBASua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:44 INFO - Running setup.py (path:/tmp/pip-EYIJKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:44 INFO - Running setup.py (path:/tmp/pip-VpHqD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:44 INFO - Running setup.py (path:/tmp/pip-ppfIiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:44 INFO - Running setup.py (path:/tmp/pip-jPSTLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:44 INFO - Running setup.py (path:/tmp/pip-wm0vxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:44 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)) 11:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:44 INFO - Running setup.py (path:/tmp/pip-xPztsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:44 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)) 11:17:44 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)) 11:17:44 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)) 11:17:44 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)) 11:17:44 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)) 11:17:44 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)) 11:17:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:44 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 11:17:44 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 11:17:44 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 11:17:44 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 11:17:44 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 11:17:44 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 11:17:46 INFO - Downloading blessings-1.6.tar.gz 11:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:46 INFO - Installing collected packages: blessings 11:17:46 INFO - Running setup.py install for blessings 11:17:46 INFO - Successfully installed blessings 11:17:46 INFO - Cleaning up... 11:17:46 INFO - Return code: 0 11:17:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:47 INFO - Reading from file tmpfile_stdout 11:17:47 INFO - Current package versions: 11:17:47 INFO - argparse == 1.2.1 11:17:47 INFO - blessings == 1.6 11:17:47 INFO - blobuploader == 1.2.4 11:17:47 INFO - docopt == 0.6.1 11:17:47 INFO - functools32 == 3.2.3-2 11:17:47 INFO - jsonschema == 2.5.1 11:17:47 INFO - manifestparser == 1.1 11:17:47 INFO - mozInstall == 1.12 11:17:47 INFO - mozcrash == 0.17 11:17:47 INFO - mozdebug == 0.1 11:17:47 INFO - mozdevice == 0.48 11:17:47 INFO - mozfile == 1.2 11:17:47 INFO - mozhttpd == 0.7 11:17:47 INFO - mozinfo == 0.9 11:17:47 INFO - mozleak == 0.1 11:17:47 INFO - mozlog == 3.3 11:17:47 INFO - moznetwork == 0.27 11:17:47 INFO - mozprocess == 0.23 11:17:47 INFO - mozprofile == 0.28 11:17:47 INFO - mozrunner == 6.12 11:17:47 INFO - mozscreenshot == 0.1 11:17:47 INFO - mozsystemmonitor == 0.3 11:17:47 INFO - moztest == 0.7 11:17:47 INFO - mozversion == 1.4 11:17:47 INFO - psutil == 3.1.1 11:17:47 INFO - requests == 1.2.3 11:17:47 INFO - wsgiref == 0.1.2 11:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:47 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 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:47 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 11:17:47 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 11:17:47 INFO - Using env: {'DISPLAY': ':0', 11:17:47 INFO - 'HOME': '/home/cltbld', 11:17:47 INFO - 'LANG': 'en_US.UTF-8', 11:17:47 INFO - 'LANGUAGE': 'en_US:en', 11:17:47 INFO - 'LOGNAME': 'cltbld', 11:17:47 INFO - 'MAIL': '/var/mail/cltbld', 11:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:47 INFO - 'MOZ_NO_REMOTE': '1', 11:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:47 INFO - 'NO_EM_RESTART': '1', 11:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:47 INFO - 'PWD': '/builds/slave/test', 11:17:47 INFO - 'SHELL': '/bin/bash', 11:17:47 INFO - 'SHLVL': '1', 11:17:47 INFO - 'TERM': 'linux', 11:17:47 INFO - 'TMOUT': '86400', 11:17:47 INFO - 'USER': 'cltbld', 11:17:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:47 INFO - '_': '/tools/buildbot/bin/python'} 11:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 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)) 11:17:47 INFO - Cleaning up... 11:17:47 INFO - Return code: 0 11:17:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf5349df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a92230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', '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 11:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:17:47 INFO - Using env: {'DISPLAY': ':0', 11:17:47 INFO - 'HOME': '/home/cltbld', 11:17:47 INFO - 'LANG': 'en_US.UTF-8', 11:17:47 INFO - 'LANGUAGE': 'en_US:en', 11:17:47 INFO - 'LOGNAME': 'cltbld', 11:17:47 INFO - 'MAIL': '/var/mail/cltbld', 11:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:47 INFO - 'MOZ_NO_REMOTE': '1', 11:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:47 INFO - 'NO_EM_RESTART': '1', 11:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:47 INFO - 'PWD': '/builds/slave/test', 11:17:47 INFO - 'SHELL': '/bin/bash', 11:17:47 INFO - 'SHLVL': '1', 11:17:47 INFO - 'TERM': 'linux', 11:17:47 INFO - 'TMOUT': '86400', 11:17:47 INFO - 'USER': 'cltbld', 11:17:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:47 INFO - '_': '/tools/buildbot/bin/python'} 11:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:47 INFO - Cleaning up... 11:17:47 INFO - Return code: 0 11:17:47 INFO - Running post-action listener: _resource_record_post_action 11:17:47 INFO - Running post-action listener: _start_resource_monitoring 11:17:47 INFO - Starting resource monitoring. 11:17:47 INFO - [mozharness: 2016-08-22 18:17:47.663573Z] Finished create-virtualenv step (success) 11:17:47 INFO - [mozharness: 2016-08-22 18:17:47.664042Z] Running install step. 11:17:47 INFO - Running pre-action listener: _resource_record_pre_action 11:17:47 INFO - Running main action method: install 11:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:47 INFO - Reading from file tmpfile_stdout 11:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:47 INFO - Reading from file tmpfile_stdout 11:17:47 INFO - Output received: 11:17:47 INFO - Usage: mozinstall [options] installer 11:17:47 INFO - Options: 11:17:47 INFO - -h, --help show this help message and exit 11:17:47 INFO - -d DEST, --destination=DEST 11:17:47 INFO - Directory to install application into. [default: 11:17:47 INFO - "/builds/slave/test"] 11:17:47 INFO - --app=APP Application being installed. [default: firefox] 11:17:47 INFO - mkdir: /builds/slave/test/build/application 11:17:47 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'] 11:17:47 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 11:18:04 INFO - Reading from file tmpfile_stdout 11:18:04 INFO - Output received: 11:18:04 INFO - /builds/slave/test/build/application/firefox/firefox 11:18:04 INFO - Running post-action listener: _resource_record_post_action 11:18:04 INFO - [mozharness: 2016-08-22 18:18:04.090869Z] Finished install step (success) 11:18:04 INFO - [mozharness: 2016-08-22 18:18:04.091117Z] Running run-tests step. 11:18:04 INFO - Running pre-action listener: _resource_record_pre_action 11:18:04 INFO - Running main action method: run_tests 11:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:18:04 INFO - Python 2.7.3 11:18:04 INFO - Return code: 0 11:18:04 INFO - grabbing minidump binary from tooltool 11:18: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')]} 11:18:04 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 0x2a8c090>, '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 0x2a8f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a8fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:18:04 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 11:18:04 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 11:18:04 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 11:18:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:04 INFO - Return code: 0 11:18:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:18:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:18:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:18:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:18:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 11:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 11:18:04 INFO - Using env: {'DISPLAY': ':0', 11:18:04 INFO - 'HOME': '/home/cltbld', 11:18:04 INFO - 'LANG': 'en_US.UTF-8', 11:18:04 INFO - 'LANGUAGE': 'en_US:en', 11:18:04 INFO - 'LOGNAME': 'cltbld', 11:18:04 INFO - 'MAIL': '/var/mail/cltbld', 11:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:04 INFO - 'MOZ_NO_REMOTE': '1', 11:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:04 INFO - 'NO_EM_RESTART': '1', 11:18:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:04 INFO - 'PWD': '/builds/slave/test', 11:18:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:04 INFO - 'SHELL': '/bin/bash', 11:18:04 INFO - 'SHLVL': '1', 11:18:04 INFO - 'TERM': 'linux', 11:18:04 INFO - 'TMOUT': '86400', 11:18:04 INFO - 'USER': 'cltbld', 11:18:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615', 11:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:04 INFO - '_': '/tools/buildbot/bin/python'} 11:18:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 11:18:04 INFO - mozversion application_buildid: 20160822094813 11:18:04 INFO - mozversion application_changeset: d15eeb67d8bff77fdbce4714f9a04f8dec63e576 11:18:04 INFO - mozversion application_display_name: Nightly 11:18:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:04 INFO - mozversion application_name: Firefox 11:18:04 INFO - mozversion application_remotingname: firefox 11:18:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:18:04 INFO - mozversion application_vendor: Mozilla 11:18:04 INFO - mozversion application_version: 51.0a1 11:18:04 INFO - mozversion platform_buildid: 20160822094813 11:18:04 INFO - mozversion platform_changeset: d15eeb67d8bff77fdbce4714f9a04f8dec63e576 11:18:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:18:04 INFO - mozversion platform_version: 51.0a1 11:18:04 INFO - using testdate: 1471889884 11:18:04 INFO - actual date: 1471889884 11:18:04 INFO - starting webserver on 'localhost:36268' 11:18:04 INFO - SUITE-START | Running 2 tests 11:18:04 INFO - TEST-START | dromaeo_css 11:18:04 INFO - operating with platform_type : linux_ 11:18:04 INFO - Initialising browser for dromaeo_css test... 11:18:04 INFO - TEST-INFO | started process 24323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61k9b1/profile http://localhost:36268/getInfo.html) 11:18:08 INFO - PROCESS | 24323 | __metrics Screen width/height:1600/1200 11:18:08 INFO - PROCESS | 24323 | colorDepth:24 11:18:08 INFO - PROCESS | 24323 | Browser inner width/height: 1024/697 11:18:08 INFO - PROCESS | 24323 | __metrics 11:18:09 INFO - PROCESS | 24323 | 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" 11:18:09 INFO - PROCESS | 24323 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:09 INFO - PROCESS | 24323 | console.error: PushService: 11:18:09 INFO - PROCESS | 24323 | stateChangeProcessEnqueue: Error transitioning state 11:18:09 INFO - PROCESS | 24323 | UnknownError 11:18:10 INFO - TEST-INFO | 24323: exit 0 11:18:10 INFO - Browser initialized. 11:18:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:10 INFO - TEST-INFO | started process 24404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61k9b1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:22 INFO - PROCESS | 24404 | RSS: Main: 174862336 11:18:22 INFO - PROCESS | 24404 | 11:19:14 INFO - PROCESS | 24404 | 1471889954483 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] 11:21:26 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36268/tests/dromaeo/cssquery-ext.html) 11:21:27 INFO - PROCESS | 24404 | RSS: Main: 268595200 11:21:27 INFO - PROCESS | 24404 | 11:24:30 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-ext.html (next: http://localhost:36268/tests/dromaeo/cssquery-jquery.html) 11:24:31 INFO - PROCESS | 24404 | RSS: Main: 280444928 11:24:31 INFO - PROCESS | 24404 | 11:27:33 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36268/tests/dromaeo/cssquery-mootools.html) 11:27:34 INFO - PROCESS | 24404 | RSS: Main: 217440256 11:27:34 INFO - PROCESS | 24404 | 11:30:36 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36268/tests/dromaeo/cssquery-prototype.html) 11:30:37 INFO - PROCESS | 24404 | RSS: Main: 219414528 11:30:37 INFO - PROCESS | 24404 | 11:33:40 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36268/tests/dromaeo/cssquery-yui.html) 11:33:41 INFO - PROCESS | 24404 | RSS: Main: 219443200 11:33:41 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-yui.html (next: http://localhost:36268/tests/dromaeo/cssquery-dojo.html) 11:36:44 INFO - PROCESS | 24404 | RSS: Main: 309719040 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | __start_tp_report 11:36:44 INFO - PROCESS | 24404 | _x_x_mozilla_page_load 11:36:44 INFO - PROCESS | 24404 | _x_x_mozilla_page_load_details 11:36:44 INFO - PROCESS | 24404 | |i|pagename|runs| 11:36:44 INFO - PROCESS | 24404 | |0;dojo.html;2586.1465716313614;2594.818362714611;2616.2936007278036;2619.8297110687818;2641.339665083728;4644.535546445354;4695.413073365829;4754.500777418369;4833.419989601249;4834.154023045966;4779.808807647699;4791.305260737191;4825.396825396825;4839.443464001641;4881.194602890519;4415.735055896656;4418.668599855007;4520.706154099973;4539.568740969619;4555.271156614942;4491.281394976804;4523.344115103325;4530.501644819084;4531.705439146462;4566.680332376735;4289.6997210195295;4329.069250111241;4332.155229730204;4446.466424029105;4475.843345482893;4374.147041326943;4378.62781663559;4404.009097952967;4408.118376324715;4416.447944006999;4410.5368936261875;4442.8667139985855;4452.421185245929;4473.932891006638;4520.909581808345;4893.143699852547;4895.339129217546;4895.461499235082;4897.216445368759;4900.828471003498;5003.249512573107;5105.208692652608;5133.948660513384;5164.974175129138;5224.791008359661;5243.711595862226;5245.186996015624;5253.0544501989625;5257.447967963385;5264.236685680593;4656.674032817738;4903.485134060944;4913.852584422473;4916.70499770015;4924.285978533164;5218.556422704037;5223.738813059332;5241.816536421284;5291;5312.76092575835;5069.315642388304;5071.290019397287;5083.694978301313;5085.516875896784;5095.261187127846;4918.262260660929;5178.533931946143;5179.896402071938;5198.532132108128;5225.790968361223;5017;5076.035553244872;5077.822276220315;5157.948420515821;5160.7419629018395;5111.616628752859;5131.332926719502;5132.409772876093;5133.23001549763;5136.332276803992;4291.463567054118;4435.622972047412;4447.6219521341045;4449.9777501112285;4450.732956022649;3769.7361184716806;3839.424086387064;3864.8840534784003;3932.528096628366;3933.6263055009726;4502.864914052584;4523.819047238139;4526.456825181;4526.977365113154;4538.341940418687;5248.816291429782;5263.973680131575;5265.947340526545;5271.578273738091;5272.288241087481;4314.56854314566;4385.846495372647;4428.3800267962515;4429.424174857312;4485.932711009337;4673.532646735299;4702.412198475191;4704.623630109583;4707.976460117678;4708.764561771898;4867.221244600847;4878.658493905393;4880.536349046835;4881.219004959189;4881.389826271716;4920.8769780755765;5080.568151706999;5160.948390516047;5183.274341592256;5252;4816.831410900601;4848.466668666373;4848.490908454562;4851.223804191312;4852.441969173449;5069.391672999263;5072.41667208261;5089.923651145162;5093.719845408538;5095.515925987025;4996.625253105959;5079.3904731430985;5101.56636685871;5130.358705161855;5146.408163061295;5059.822906198266;5070.746462676925;5071.822486212965;5078.644494885322;5080.085584594808;5071.239314102914;5077.974610126926;5081.695098294114;5085.56772674312;5088.338515992898;4811.446683631427;4864.318995340726;4909.877253068702;4915.5330243626795;4972.751362431936;5070.2141168119;5076;5077.568406685473;5082.263071854634;5082.898342033212;4955.72743499111;4961.479044700254;4961.5534601886;4967.577755890789;4969.45336013031 11:36:44 INFO - PROCESS | 24404 | |1;ext.html;532.5819231902955;542.0945376999844;560.5599604310617;574.3997522588894;575.4159528078999;29347.26631834205;39335.40996885049;40674;40755.18489630205;43811.78094109533;40706.59293407065;41293;41306.38040429389;41330.7933460333;41460.79269603655;7413.851722965537;7576.469647124703;7718.421118416141;7727.922720772776;7729.227077292282;7382.224866389032;7453.888191677129;7454;9557.474338911357;9774;9973.800523989516;10026.448545330004;10027.949860250725;10035.942631760508;10039.347442416256;9872.210223182128;9907.356021858628;9934.850977235346;9935.90064099357;9936.105750482418;9552.61789528418;9653.420794752266;9680.128788409076;9687.32188746788;9689.90310096897;38139.80930095332;38417;38473.615263847285;38522.61477385218;38543.614563854564;2751.683556391021;2974.5686875402944;3045.1959152234863;3118.033409643018;3146.7010633989735;29450.11649650514;29736.55395169074;29827.552586711216;30121.69878301233;30943.69056309453;3435.2644059875925;3544.8404821783083;3561.2521370512222;3571.4285714285847;3652.6164752700847;247738;248044;249237;249309;249634.9999999982;43121.78439107785;43194.56805431968;43201.78399108047;43217;43273;32383.67616323854;33339.16547107886;33359;35482.29035419329;35489.82255088708;13156.802647960289;13251.337433128305;13274.668133296746;13293.401796919163;13296.73406531864;10113.59545618167;10182.18542516597;10189.745256368502;10193.490325483695;10201.234907381828;15298.541043768704;15703.528894133195;15775.132367719885;16390.50828475124;17446.47660570185;6340.651264180515;6669.233038200572;6672.83317917056;6672.86654266912;6730.461563074942;772.6831998880432;834.586879494654;888.2982443869271;907.7912080221586;922.9676961306457;27603.447931041268;28892.42215155685;29002.27494312659;29250.41533387868;29441.55837662437;890.6125835261682;899.1682693508609;921.5115988526092;954.1698722111807;984.478226539935;13519.053666243268;13668.248246346546;14039.78940315896;14107.435702571987;14242.359093840802;379645;382897.5130746082;383567;384016;384048;48745;49215;49323.26015109776;49423;49585.50414495881;1192.2786714038054;1196.5154112584416;1224.5958833585073;1226.343906010298;1228.846394200725;25398.619020715072;26668.333291667863;27367.863160684068;27603.620440278493;27852.86073569619;41426.37860432156;42175.7891210542;42185.156296873276;42212.366814497196;42228.57771422246;288070;289125;289428;291049;291729;22346;24414.75585244196;25452.872735636203;25562.744372556037;25897.22308330753;41853.79073104615;41878.371824423266;41939.79030104952;43009;43266.13467730691;35775.46336804898;35885;36029.09927251735;36282;36433.63566364302;35703.82148089243;35789.82105089458;36054.8197259012;36414;36425.81787091154;33020;35247.06208480576;35642;35753.82123089368;36269;27509;29093.12720618385;29265.41469170562;29268;29388.412231755672;23901.521969560858;24411;24772.876135619208;24799;24936.127235546668 11:36:44 INFO - PROCESS | 24404 | |2;jquery.html;346.5512161750534;354.12001177074967;355.67811130926515;361.358588505403;368.0834721543356;16574.33702651894;16722.832771672278;16858.40995565157;16934.49196524106;16971.066591337472;15423.383064677428;15961.760573591406;16146.75779863303;16156.434524791635;16289.429869954554;5000.274960130779;5219.45195754446;5246.554042906358;5252.973735131319;5254.527092561669;3834.8466061357512;4024.9597504025023;5135.58915286778;5229.450907654698;5855.912161317584;6027.517798576126;6124.081387791823;6173.2900716417735;6180.81457556274;6193.256809182904;6144.907826382608;6690.565113267622;6915.343042410963;6944.687489062953;7078.186008608973;6340.714667839959;6682.365175308387;6713.664316784141;6722.260551339349;6722.865542689167;24373.756262437328;24785.25644230676;24803.62794558083;24865.254042378758;24953.251402457954;1870.9812901870944;1890.6880364739939;1918.808119188084;2297.8965946532444;2333.661619065226;13862.237576933265;14949.850501495064;15147.091174529452;15346;15779.447719329883;1874.297138573035;1906.5424298168339;1916.1951980168362;1920.395075551197;1926.2680181531068;78822;81127;81181;81181.9999999994;81394.59302703508;15870.144278581945;15891.682166356608;16058.75911861323;16318.184090795412;16538.83461165397;26061.348466288495;26085.217443476726;26140.477190456084;26146;26346.341341466617;7582.431317651198;7633.961830190813;7720.42096842739;7936.880946785803;7970.163132871081;6222.968885155546;6263.530235232376;6294.496440284766;6401.55189136756;6466.967665161644;7431.739889103856;7723.7682869514;7800.765977020698;7816.648250828726;7835.863799749119;2677;2982.940341193164;3200.9359812803614;3222.715704376475;3254.7070763631386;756.3155344413315;796.4146352430959;834.7787836223406;913.2830727878584;916.706653870755;16847;16856.07291598974;16893.746593801105;17269.654606908043;17834.821651783575;828.4325237212408;843.215809297347;874.8687696845396;899.1477556234179;911.1207684584408;9476.905230947603;9884.308098433185;9890.851637225447;9966.601335946481;9982.500874956368;373471;376412;404492;407449;408372;76984.61507692425;77609;78981.60509197532;79365.20634793577;79474;806.8103995561039;849.163573879728;903.1916434790826;906.2206502407923;908.2007833106956;14925.552233433014;15310.856480092572;16302.836971630131;16476.67046659036;16914.746278806073;38573.8427847165;38955;39132.413013804246;39961.800191000024;42421;53119.20321195263;53584.19623705726;54404.72797635986;55893;55960.44039559552;7272.163701174221;7295;7332.523385979895;7512.699492020258;7561.546307221584;6596.80209593713;8401.957990210254;8516.531590762568;10052.246081544059;12634.178778379375;10059.698209053447;10239.641612543823;10405.739856503647;10662.8400573993;11004.779904402027;4510.210713125124;6918.066061081689;10056.54745536438;10396.58413663445;10546.156307495228;10080.89919100829;10400.167986561208;10656;10686.786264274826;11084.833727494255;6690.966545167243;7243.420526357984;7259.9274007261365;7302.415806735555;7643.923560764321;9758.877729060965;10499.160067194452;10503.264771465923;10574.788504230026;10781.946090269812 11:36:44 INFO - PROCESS | 24404 | |3;mootools.html;1356.3557310277615;1398.7971744097106;1459.5840185547122;1676.6646670665855;1697.185351031504;6775.457963362932;7020.859582808341;7362.226966168556;7943.602819859013;7944.404169687282;7002.5448345857485;7263.128424589044;7281.599512026836;7476.551406915589;7500.13748418932;2084.7602525709585;2112.355731501891;2114.608797372491;2117.375374264588;2119.247667078188;1826.3242600237863;2063.4325560470916;2104.5580428110115;2130.2650585547963;2197.6703494475796;2179.596774596697;2198.4723666320047;2201.4606421426693;2203.724534433196;2205.889705514726;2129.0419311309975;2146.3346362627635;2150.892455377225;2153.881536515491;2158.460384903774;2091.8326533877253;2103.3059090500096;2134.135675051591;2145.002573803189;2149.3014770199593;7800.570968596725;7902.051753789582;7902.683892644287;7905.644246008886;7907.762767116996;4340;4466.754328511931;4467.977660111678;4473.083017981306;4475.0826080653715;2812.4937511247967;2907.1133304342166;2946.8821247150304;2956.1574951138823;2972.4649563078638;868.561376504861;905.3029167540957;918.169057003413;923.5613083785215;929.5027160469184;10526.684199474028;10534.736631584195;10541.15670746346;10556.313839600478;10557.313774604627;3708.666220040155;4011.097503061788;4055.5741647127215;4078.0620457294394;4083.1629515949157;9206.401583897024;9212;9216.95391523038;9217.815643687089;9220.07799220086;4501.459824820977;4510;4511;4512.774361281923;4520.61574766142;4079.938800917989;4100.671946244293;4124.8143833527565;4139.689523285766;4143.772092534879;3532.7703699259464;3631.1466805300734;3636.8363423646;3649.94525082124;3676.4117741161285;1008.6368907193552;1134.6766171641043;1137.5165554639245;1192.368044936168;1194.988050119505;627.0844566932238;705.5837056136904;706.20199174932;719.3310221494061;720.6072690383648;4827.831025914076;4885.6335774817035;4930.827421040246;4970.2793095001025;5045.31888195089;828.0705955124546;833.4457585705559;840.609116760697;866.1208872993916;881.1628952495155;3459.775114617542;3474.7915125092068;3502.9299414011575;3524.8061356625117;3549.0594992327055;9345.439273643604;9588.90411095894;9669.90330096704;9671.226301895831;9701.9029809701;9486.383385080086;9606.327557070937;9645.855312170323;9650.90349096514;9657.90342096584;7221.31397517235;7242.7102915883825;7305.269473052652;7306.4885458017425;7328.816779580553;4944.728039957837;5068.391792984866;5088.974555127349;5155.664881782672;5173.586113110867;8674.132586741276;8891.377603567687;8947.552622368725;8980.86528702057;9004.189622933967;8918.643254270017;9045.185933266037;9100.044495327895;9162.358634895494;9260.518317069236;6465.04492658329;6651.700673469609;6821.2155602106395;6826.112605361272;6831.419329356861;7329.267073292842;7567.243275672609;7585.924140758521;7608.0489938757655;7609.391248700202;6697.196336439463;6717.596944183365;6808.148981377328;6896.896546551906;6897.103376561216;6313.96843015782;6451.48388128958;6529.444997175293;6582.440492558187;6747.325267473213;6072.392760723892;6143.139960405458;6165.475934545434;6168.814935551941;6182.845428864314;4504.954950450585;4556.407667003268;4645.2103142465185;4673.742944137969;4674.368960190331;4394.912101758011;4402.933955990727;4517.6837621366185;4609.147307748078;4682.484926657997 11:36:44 INFO - PROCESS | 24404 | |4;prototype.html;288.90321742216355;289.31721138114045;293.79434395922846;296.3983114278016;297.2183158293688;4825.517448255173;4831.661783675144;4874.488178741234;4877.341558889549;4893.461719210888;4739.857804265877;4812.975935120328;4820.770703470619;4832.975835120819;4850.520591219676;3639.8180090995475;3714.832832522543;3751.512303400554;3802.619738026189;3815.329269511339;3785;3801.8669346572874;3806.6193380661853;3813.1420430403077;3828.4448754930518;3755.3615885299428;3764.661180493755;3768.453574231735;3775.603561626031;3781.6596506314427;3537.451694987281;3640.2537479816574;3743.419769935664;3761.7867987853506;3787.905302367449;3313.8840140595203;3316.270420507509;3322.9335413291597;3322.9501557476656;3334.233126380946;4561.885952851205;4617.769111544443;4637.165310244155;4638.930416043762;4652.976735116336;4147.776405960249;4293.4203882476095;4300.397944287803;4308.504521979981;4319.870403887889;4980.2280646499485;4992.975035124801;4998.500149985009;5031.522005409517;5032.723200223986;3634.5275114235246;3637.527121474218;3639.926221764559;3640.854365825364;3643.4899114124046;5074.264231686385;5259.342582177228;5286.894262114736;5296.496832800916;5296.788128474856;3652.981735091361;3699.167687270343;3702.1670124221832;3722.8510859565854;3725.981370093132;3760.9059773505332;3761.4545890845675;3763.510743603314;3810.3522401191863;3818.8281527331337;4252.362145678173;4267.3598960155605;4304.268274393361;4312.654987600984;4315.4605674290715;4840.080384726891;5020.246962955513;5066.316047333563;5077.796888124433;5085.262636917626;1298.577962162301;1316.2036967634635;1316.8872302904222;1319.6568892088126;1322.5701646964776;787.7164220880478;818.979525511867;833.4832403909614;835.2376485615347;837.2966707965217;4313.245182093121;4315.899445641404;4499;4502.977485112619;4505.954940450619;5202.907389448258;5213.739313034409;5215.2698622192165;5218.739063046908;5230.503102205284;4483.641308695296;4505.707129036602;4513.638908887281;4516.36770852081;4518.063258881687;2625.973740262611;2758.1449750576985;2765.9308517287227;2766.695663477016;2782.1375373634237;4881.341018962395;4887.975560122248;4915.729634870045;4925.990172014728;4927.926081108786;5188.44836025451;5263.34208223972;5348.5186333230195;5353.0899747043095;5364.329458817648;4840.878978025507;4864.562189402971;4900.754962251873;4912.936566642091;4935.3090567320605;5223.6604620701055;5236.947630523646;5239.397469291081;5240.161574148118;5244.580433565229;4856.567312642849;5128.076946149728;5140;5155.422288855572;5172.508611681884;4890.510948905223;4912.729799861042;4916.237983112624;4919.606431485401;4924.556789888784;3749.3438648235906;3776.4901738264984;3821.522309711286;3824.8852534424013;3829.4638750574386;5087;5250.081235783799;5312.654677445954;5319.46805319465;5323.707196104251;5034.874128146826;5036.84889453317;5039.143345631178;5060.3168572242275;5073.59411247092;5000.2999580058095;5016.899662006666;5035.29505869186;5044.991001799582;5053.412077424922;4727.503612120678;4997.575206107522;4998.825041123543;5005.174146265826;5029.622778291569;4860.489648586848;4974.527419895104;5123.359580052494;5131.4868513148385;5152.9742351288005;5011.649184557046;5033.949660503495;5037.19404895215;5048.798048078036;5054.393472783289 11:36:44 INFO - PROCESS | 24404 | |5;yui.html;571.2117278156144;575.2464271803935;591.9200907877436;638.658317799977;645.1322970604535;12132.939335303323;13319.20084794913;13332.733345333087;13346.66633334167;13350.799738003938;12129.636110916665;12783.169094008907;12887.097903146783;12888.355582220875;12916.741665166715;607.4441885674603;745.6160077560061;766.5094339622646;770.8419773946327;771.1209221487509;735.9990413038264;768.4505578511363;769.349899335061;774.1561697749452;774.8682723936944;810.67167797042;810.9959450202741;811.0875265326507;811.7929927868415;814.4217605500102;636.3986033198629;803.048387660624;807.11620775251;808.1514409869613;808.5633757770797;570.7431655754926;586.4604563801313;586.7682265505144;586.9823905282806;587.0548417048549;12583.433745481476;12614.68463288416;12658.430370633343;12665.936670316682;12667.74664506714;11432.542698292058;11564.653060408202;11624.535018599247;11701.18091733579;11738.119641026871;11261;11276.718082048015;11539.365334906577;11623.76752464946;11682.941585292105;3182.6499085100622;3201.487761958099;3265.3959017581824;3371.612264589579;4047.6761859051207;60586;61607.69196154035;62058.68970655163;63454;63538.364616353705;9679.951600241953;9836.262280329003;9837.655682051094;9932.304738668225;10119.13987311072;16670;16711.83288167127;16726.832731672526;16738.079405632565;16744;6219.968900155561;6220.191375121205;6483.805485835433;6719.529632925648;6785.457163426914;3745.157339598623;3756.6431189037;3769.660730534265;3789.2610940866266;4029.37544680575;2749.230215539652;2858.6855445900933;2873.741363277273;2874.2526942994555;2874.4825931332143;500.93237412949514;502.1939786642386;506.0839879817542;509.98980020400126;512.7718165416354;450.0325681463813;534.132035442406;543.4646872830259;550.7659244820935;563.1355868741545;7497.850042999109;7623.9618801905635;7638.312551870358;7753.379729621617;7903.249191326815;514.7349115205672;514.8609875333639;517.5238780322113;519.4545726986725;521.9947800522023;3621.27574485104;3642.1805093853673;3653.671169594696;3741.30785804627;3804.0299723570865;92252.07747922435;103828;103881.88354349382;105002;105497.67013979032;89065.55467222622;90500.54749726209;90925.54537227271;93730;95506;62335;78599.60700196576;79103.20896790958;79651.60174199092;80162.19837801663;7193.172785129568;7213.6032518212005;7399.445041622008;7450;7754.185810489817;35511.46732799062;45785;46866.297005545624;46892.53107469018;47246;62028.379716204065;69235.65382173056;70011.64994175201;71830.64084679753;72402;9115.27077833785;9165.77085572866;9226.261899048195;9230.123138301851;9275.913841031032;10496.895031049897;10827.51276192589;11173.497192626513;11299.604513841976;12212.938935305267;10618.309809862334;11195.552177913118;11571.479283432098;11993.580224692094;12263.509459621871;11188.440577971232;11280.7743845121;11590.94204528972;12261.080418968435;12263.877361226274;10442.53008614599;10469.424181670081;11330.94334528322;11333.886661133283;11348.54605815758;9721.222302215665;9919.752006199902;10124.493775311352;10129.341592796445;10343.63797267092;9161.954190229273;9647;10205.03052210039;10221.013804616057;10234.744131396774 11:36:44 INFO - PROCESS | 24404 | __end_tp_report 11:36:44 INFO - PROCESS | 24404 | __start_cc_report 11:36:44 INFO - PROCESS | 24404 | _x_x_mozilla_cycle_collect,995 11:36:44 INFO - PROCESS | 24404 | __end_cc_report 11:36:44 INFO - PROCESS | 24404 | __startTimestamp1471891004559__endTimestamp 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | ------- Summary: start ------- 11:36:44 INFO - PROCESS | 24404 | Number of tests: 6 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | [#0] dojo.html Cycles:165 Average:4774.73 Median:4900.83 stddev:506.68 (10.3%) stddev-sans-first:478.27 11:36:44 INFO - PROCESS | 24404 | Values: 2586.1 2594.8 2616.3 2619.8 2641.3 4644.5 4695.4 4754.5 4833.4 4834.2 4779.8 4791.3 4825.4 4839.4 4881.2 4415.7 4418.7 4520.7 4539.6 4555.3 4491.3 4523.3 4530.5 4531.7 4566.7 4289.7 4329.1 4332.2 4446.5 4475.8 4374.1 4378.6 4404.0 4408.1 4416.4 4410.5 4442.9 4452.4 4473.9 4520.9 4893.1 4895.3 4895.5 4897.2 4900.8 5003.2 5105.2 5133.9 5165.0 5224.8 5243.7 5245.2 5253.1 5257.4 5264.2 4656.7 4903.5 4913.9 4916.7 4924.3 5218.6 5223.7 5241.8 5291.0 5312.8 5069.3 5071.3 5083.7 5085.5 5095.3 4918.3 5178.5 5179.9 5198.5 5225.8 5017.0 5076.0 5077.8 5157.9 5160.7 5111.6 5131.3 5132.4 5133.2 5136.3 4291.5 4435.6 4447.6 4450.0 4450.7 3769.7 3839.4 3864.9 3932.5 3933.6 4502.9 4523.8 4526.5 4527.0 4538.3 5248.8 5264.0 5265.9 5271.6 5272.3 4314.6 4385.8 4428.4 4429.4 4485.9 4673.5 4702.4 4704.6 4708.0 4708.8 4867.2 4878.7 4880.5 4881.2 4881.4 4920.9 5080.6 5160.9 5183.3 5252.0 4816.8 4848.5 4848.5 4851.2 4852.4 5069.4 5072.4 5089.9 5093.7 5095.5 4996.6 5079.4 5101.6 5130.4 5146.4 5059.8 5070.7 5071.8 5078.6 5080.1 5071.2 5078.0 5081.7 5085.6 5088.3 4811.4 4864.3 4909.9 4915.5 4972.8 5070.2 5076.0 5077.6 5082.3 5082.9 4955.7 4961.5 4961.6 4967.6 4969.5 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | [#1] ext.html Cycles:180 Average:45499.40 Median:35837.41 stddev:82093.73 (229.1%) stddev-sans-first:82254.60 11:36:44 INFO - PROCESS | 24404 | Values: 532.6 542.1 560.6 574.4 575.4 29347.3 39335.4 40674.0 40755.2 43811.8 40706.6 41293.0 41306.4 41330.8 41460.8 7413.9 7576.5 7718.4 7727.9 7729.2 7382.2 7453.9 7454.0 9557.5 9774.0 9973.8 10026.4 10027.9 10035.9 10039.3 9872.2 9907.4 9934.9 9935.9 9936.1 9552.6 9653.4 9680.1 9687.3 9689.9 38139.8 38417.0 38473.6 38522.6 38543.6 2751.7 2974.6 3045.2 3118.0 3146.7 29450.1 29736.6 29827.6 30121.7 30943.7 3435.3 3544.8 3561.3 3571.4 3652.6 247738.0 248044.0 249237.0 249309.0 249635.0 43121.8 43194.6 43201.8 43217.0 43273.0 32383.7 33339.2 33359.0 35482.3 35489.8 13156.8 13251.3 13274.7 13293.4 13296.7 10113.6 10182.2 10189.7 10193.5 10201.2 15298.5 15703.5 15775.1 16390.5 17446.5 6340.7 6669.2 6672.8 6672.9 6730.5 772.7 834.6 888.3 907.8 923.0 27603.4 28892.4 29002.3 29250.4 29441.6 890.6 899.2 921.5 954.2 984.5 13519.1 13668.2 14039.8 14107.4 14242.4 379645.0 382897.5 383567.0 384016.0 384048.0 48745.0 49215.0 49323.3 49423.0 49585.5 1192.3 1196.5 1224.6 1226.3 1228.8 25398.6 26668.3 27367.9 27603.6 27852.9 41426.4 42175.8 42185.2 42212.4 42228.6 288070.0 289125.0 289428.0 291049.0 291729.0 22346.0 24414.8 25452.9 25562.7 25897.2 41853.8 41878.4 41939.8 43009.0 43266.1 35775.5 35885.0 36029.1 36282.0 36433.6 35703.8 35789.8 36054.8 36414.0 36425.8 33020.0 35247.1 35642.0 35753.8 36269.0 27509.0 29093.1 29265.4 29268.0 29388.4 23901.5 24411.0 24772.9 24799.0 24936.1 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | [#2] jquery.html Cycles:180 Average:25852.22 Median:23465.61 stddev:65295.50 (278.3%) stddev-sans-first:65450.59 11:36:44 INFO - PROCESS | 24404 | Values: 346.6 354.1 355.7 361.4 368.1 16574.3 16722.8 16858.4 16934.5 16971.1 15423.4 15961.8 16146.8 16156.4 16289.4 5000.3 5219.5 5246.6 5253.0 5254.5 3834.8 4025.0 5135.6 5229.5 5855.9 6027.5 6124.1 6173.3 6180.8 6193.3 6144.9 6690.6 6915.3 6944.7 7078.2 6340.7 6682.4 6713.7 6722.3 6722.9 24373.8 24785.3 24803.6 24865.3 24953.3 1871.0 1890.7 1918.8 2297.9 2333.7 13862.2 14949.9 15147.1 15346.0 15779.4 1874.3 1906.5 1916.2 1920.4 1926.3 78822.0 81127.0 81181.0 81182.0 81394.6 15870.1 15891.7 16058.8 16318.2 16538.8 26061.3 26085.2 26140.5 26146.0 26346.3 7582.4 7634.0 7720.4 7936.9 7970.2 6223.0 6263.5 6294.5 6401.6 6467.0 7431.7 7723.8 7800.8 7816.6 7835.9 2677.0 2982.9 3200.9 3222.7 3254.7 756.3 796.4 834.8 913.3 916.7 16847.0 16856.1 16893.7 17269.7 17834.8 828.4 843.2 874.9 899.1 911.1 9476.9 9884.3 9890.9 9966.6 9982.5 373471.0 376412.0 404492.0 407449.0 408372.0 76984.6 77609.0 78981.6 79365.2 79474.0 806.8 849.2 903.2 906.2 908.2 14925.6 15310.9 16302.8 16476.7 16914.7 38573.8 38955.0 39132.4 39961.8 42421.0 53119.2 53584.2 54404.7 55893.0 55960.4 7272.2 7295.0 7332.5 7512.7 7561.5 6596.8 8402.0 8516.5 10052.2 12634.2 10059.7 10239.6 10405.7 10662.8 11004.8 4510.2 6918.1 10056.5 10396.6 10546.2 10080.9 10400.2 10656.0 10686.8 11084.8 6691.0 7243.4 7259.9 7302.4 7643.9 9758.9 10499.2 10503.3 10574.8 10781.9 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | [#3] mootools.html Cycles:180 Average:5071.70 Median:5056.86 stddev:2875.78 (56.9%) stddev-sans-first:2870.29 11:36:44 INFO - PROCESS | 24404 | Values: 1356.4 1398.8 1459.6 1676.7 1697.2 6775.5 7020.9 7362.2 7943.6 7944.4 7002.5 7263.1 7281.6 7476.6 7500.1 2084.8 2112.4 2114.6 2117.4 2119.2 1826.3 2063.4 2104.6 2130.3 2197.7 2179.6 2198.5 2201.5 2203.7 2205.9 2129.0 2146.3 2150.9 2153.9 2158.5 2091.8 2103.3 2134.1 2145.0 2149.3 7800.6 7902.1 7902.7 7905.6 7907.8 4340.0 4466.8 4468.0 4473.1 4475.1 2812.5 2907.1 2946.9 2956.2 2972.5 868.6 905.3 918.2 923.6 929.5 10526.7 10534.7 10541.2 10556.3 10557.3 3708.7 4011.1 4055.6 4078.1 4083.2 9206.4 9212.0 9217.0 9217.8 9220.1 4501.5 4510.0 4511.0 4512.8 4520.6 4079.9 4100.7 4124.8 4139.7 4143.8 3532.8 3631.1 3636.8 3649.9 3676.4 1008.6 1134.7 1137.5 1192.4 1195.0 627.1 705.6 706.2 719.3 720.6 4827.8 4885.6 4930.8 4970.3 5045.3 828.1 833.4 840.6 866.1 881.2 3459.8 3474.8 3502.9 3524.8 3549.1 9345.4 9588.9 9669.9 9671.2 9701.9 9486.4 9606.3 9645.9 9650.9 9657.9 7221.3 7242.7 7305.3 7306.5 7328.8 4944.7 5068.4 5089.0 5155.7 5173.6 8674.1 8891.4 8947.6 8980.9 9004.2 8918.6 9045.2 9100.0 9162.4 9260.5 6465.0 6651.7 6821.2 6826.1 6831.4 7329.3 7567.2 7585.9 7608.0 7609.4 6697.2 6717.6 6808.1 6896.9 6897.1 6314.0 6451.5 6529.4 6582.4 6747.3 6072.4 6143.1 6165.5 6168.8 6182.8 4505.0 4556.4 4645.2 4673.7 4674.4 4394.9 4402.9 4517.7 4609.1 4682.5 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | [#4] prototype.html Cycles:180 Average:4206.26 Median:4832.32 stddev:1221.11 (25.3%) stddev-sans-first:1188.61 11:36:44 INFO - PROCESS | 24404 | Values: 288.9 289.3 293.8 296.4 297.2 4825.5 4831.7 4874.5 4877.3 4893.5 4739.9 4813.0 4820.8 4833.0 4850.5 3639.8 3714.8 3751.5 3802.6 3815.3 3785.0 3801.9 3806.6 3813.1 3828.4 3755.4 3764.7 3768.5 3775.6 3781.7 3537.5 3640.3 3743.4 3761.8 3787.9 3313.9 3316.3 3322.9 3323.0 3334.2 4561.9 4617.8 4637.2 4638.9 4653.0 4147.8 4293.4 4300.4 4308.5 4319.9 4980.2 4993.0 4998.5 5031.5 5032.7 3634.5 3637.5 3639.9 3640.9 3643.5 5074.3 5259.3 5286.9 5296.5 5296.8 3653.0 3699.2 3702.2 3722.9 3726.0 3760.9 3761.5 3763.5 3810.4 3818.8 4252.4 4267.4 4304.3 4312.7 4315.5 4840.1 5020.2 5066.3 5077.8 5085.3 1298.6 1316.2 1316.9 1319.7 1322.6 787.7 819.0 833.5 835.2 837.3 4313.2 4315.9 4499.0 4503.0 4506.0 5202.9 5213.7 5215.3 5218.7 5230.5 4483.6 4505.7 4513.6 4516.4 4518.1 2626.0 2758.1 2765.9 2766.7 2782.1 4881.3 4888.0 4915.7 4926.0 4927.9 5188.4 5263.3 5348.5 5353.1 5364.3 4840.9 4864.6 4900.8 4912.9 4935.3 5223.7 5236.9 5239.4 5240.2 5244.6 4856.6 5128.1 5140.0 5155.4 5172.5 4890.5 4912.7 4916.2 4919.6 4924.6 3749.3 3776.5 3821.5 3824.9 3829.5 5087.0 5250.1 5312.7 5319.5 5323.7 5034.9 5036.8 5039.1 5060.3 5073.6 5000.3 5016.9 5035.3 5045.0 5053.4 4727.5 4997.6 4998.8 5005.2 5029.6 4860.5 4974.5 5123.4 5131.5 5153.0 5011.6 5033.9 5037.2 5048.8 5054.4 11:36:44 INFO - PROCESS | 24404 | 11:36:44 INFO - PROCESS | 24404 | [#5] yui.html Cycles:180 Average:18047.31 Median:511.38 stddev:26849.54 (5250.4%) stddev-sans-first:26892.79 11:36:44 INFO - PROCESS | 24404 | Values: 571.2 575.2 591.9 638.7 645.1 12132.9 13319.2 13332.7 13346.7 13350.8 12129.6 12783.2 12887.1 12888.4 12916.7 607.4 745.6 766.5 770.8 771.1 736.0 768.5 769.3 774.2 774.9 810.7 811.0 811.1 811.8 814.4 636.4 803.0 807.1 808.2 808.6 570.7 586.5 586.8 587.0 587.1 12583.4 12614.7 12658.4 12665.9 12667.7 11432.5 11564.7 11624.5 11701.2 11738.1 11261.0 11276.7 11539.4 11623.8 11682.9 3182.6 3201.5 3265.4 3371.6 4047.7 60586.0 61607.7 62058.7 63454.0 63538.4 9680.0 9836.3 9837.7 9932.3 10119.1 16670.0 16711.8 16726.8 16738.1 16744.0 6220.0 6220.2 6483.8 6719.5 6785.5 3745.2 3756.6 3769.7 3789.3 4029.4 2749.2 2858.7 2873.7 2874.3 2874.5 500.9 502.2 506.1 510.0 512.8 450.0 534.1 543.5 550.8 563.1 7497.9 7624.0 7638.3 7753.4 7903.2 514.7 514.9 517.5 519.5 522.0 3621.3 3642.2 3653.7 3741.3 3804.0 92252.1 103828.0 103881.9 105002.0 105497.7 89065.6 90500.5 90925.5 93730.0 95506.0 62335.0 78599.6 79103.2 79651.6 80162.2 7193.2 7213.6 7399.4 7450.0 7754.2 35511.5 45785.0 46866.3 46892.5 47246.0 62028.4 69235.7 70011.6 71830.6 72402.0 9115.3 9165.8 9226.3 9230.1 9275.9 10496.9 10827.5 11173.5 11299.6 12212.9 10618.3 11195.6 11571.5 11993.6 12263.5 11188.4 11280.8 11590.9 12261.1 12263.9 10442.5 10469.4 11330.9 11333.9 11348.5 9721.2 9919.8 10124.5 10129.3 10343.6 9162.0 9647.0 10205.0 10221.0 10234.7 11:36:44 INFO - PROCESS | 24404 | -------- Summary: end -------- 11:36:44 INFO - PROCESS | 24404 | 11:36:45 INFO - TEST-INFO | 24404: exit 0 11:36:45 INFO - TEST-OK | dromaeo_css | took 1121175ms 11:36:45 INFO - TEST-START | kraken 11:36:45 INFO - operating with platform_type : linux_ 11:36:45 INFO - Initialising browser for kraken test... 11:36:45 INFO - TEST-INFO | started process 24703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD92eiy/profile http://localhost:36268/getInfo.html) 11:36:49 INFO - PROCESS | 24703 | __metrics Screen width/height:1600/1200 11:36:49 INFO - PROCESS | 24703 | colorDepth:24 11:36:49 INFO - PROCESS | 24703 | Browser inner width/height: 1024/697 11:36:49 INFO - PROCESS | 24703 | __metrics 11:36:50 INFO - PROCESS | 24703 | 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" 11:36:50 INFO - PROCESS | 24703 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:50 INFO - PROCESS | 24703 | console.error: PushService: 11:36:50 INFO - PROCESS | 24703 | stateChangeProcessEnqueue: Error transitioning state 11:36:50 INFO - PROCESS | 24703 | UnknownError 11:36:51 INFO - TEST-INFO | 24703: exit 0 11:36:51 INFO - Browser initialized. 11:36:51 INFO - Running cycle 1/1 for kraken test... 11:36:51 INFO - TEST-INFO | started process 24786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD92eiy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:03 INFO - PROCESS | 24786 | RSS: Main: 175796224 11:37:03 INFO - PROCESS | 24786 | 11:37:06 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:07 INFO - PROCESS | 24786 | RSS: Main: 244686848 11:37:07 INFO - PROCESS | 24786 | 11:37:10 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-dft) 11:37:10 INFO - PROCESS | 24786 | RSS: Main: 227012608 11:37:10 INFO - PROCESS | 24786 | 11:37:14 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-fft) 11:37:14 INFO - PROCESS | 24786 | RSS: Main: 302727168 11:37:14 INFO - PROCESS | 24786 | 11:37:16 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-oscillator) 11:37:17 INFO - PROCESS | 24786 | RSS: Main: 210661376 11:37:17 INFO - PROCESS | 24786 | 11:37:19 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:20 INFO - PROCESS | 24786 | RSS: Main: 214974464 11:37:20 INFO - PROCESS | 24786 | 11:37:23 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36268/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:24 INFO - PROCESS | 24786 | RSS: Main: 250613760 11:37:24 INFO - PROCESS | 24786 | 11:37:27 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36268/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:28 INFO - PROCESS | 24786 | RSS: Main: 244539392 11:37:28 INFO - PROCESS | 24786 | 11:37:31 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36268/tests/kraken/driver.html?testName=json-parse-financial) 11:37:31 INFO - PROCESS | 24786 | RSS: Main: 248438784 11:37:31 INFO - PROCESS | 24786 | 11:37:33 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:34 INFO - PROCESS | 24786 | RSS: Main: 211800064 11:37:34 INFO - PROCESS | 24786 | 11:37:36 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:36 INFO - PROCESS | 24786 | RSS: Main: 219054080 11:37:36 INFO - PROCESS | 24786 | 11:37:39 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:39 INFO - PROCESS | 24786 | RSS: Main: 223862784 11:37:39 INFO - PROCESS | 24786 | 11:37:42 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:43 INFO - PROCESS | 24786 | RSS: Main: 218648576 11:37:43 INFO - PROCESS | 24786 | 11:37:46 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:46 INFO - PROCESS | 24786 | RSS: Main: 221687808 11:37:46 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36268/tests/kraken/driver.html?testName=ai-astar) 11:37:48 INFO - PROCESS | 24786 | RSS: Main: 272732160 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | __start_tp_report 11:37:48 INFO - PROCESS | 24786 | _x_x_mozilla_page_load 11:37:48 INFO - PROCESS | 24786 | _x_x_mozilla_page_load_details 11:37:48 INFO - PROCESS | 24786 | |i|pagename|runs| 11:37:48 INFO - PROCESS | 24786 | |0;ai-astar;102;114;110;114;113;114;119;115;114;114 11:37:48 INFO - PROCESS | 24786 | |1;audio-beat-detection;150;123;150;182;127;161;151;122;179;121 11:37:48 INFO - PROCESS | 24786 | |2;audio-dft;162;163;164;161;163;161;162;167;162;161 11:37:48 INFO - PROCESS | 24786 | |3;audio-fft;75;76;75;167;78;75;78;114;121;76 11:37:48 INFO - PROCESS | 24786 | |4;audio-oscillator;89;87;156;87;87;87;137;87;87;137 11:37:48 INFO - PROCESS | 24786 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 11:37:48 INFO - PROCESS | 24786 | |6;imaging-darkroom;148;147;146;146;146;146;147;146;146;146 11:37:48 INFO - PROCESS | 24786 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 11:37:48 INFO - PROCESS | 24786 | |8;json-parse-financial;65;64;66;66;67;66;65;66;67;65 11:37:48 INFO - PROCESS | 24786 | |9;json-stringify-tinderbox;67;69;68;68;68;68;68;68;67;67 11:37:48 INFO - PROCESS | 24786 | |10;stanford-crypto-aes;82;89;82;83;90;81;84;83;92;88 11:37:48 INFO - PROCESS | 24786 | |11;stanford-crypto-ccm;136;136;133;134;144;130;134;132;197;134 11:37:48 INFO - PROCESS | 24786 | |12;stanford-crypto-pbkdf2;182;176;179;181;176;174;173;172;179;176 11:37:48 INFO - PROCESS | 24786 | |13;stanford-crypto-sha256-iterative;68;69;70;68;69;68;68;67;70;69 11:37:48 INFO - PROCESS | 24786 | __end_tp_report 11:37:48 INFO - PROCESS | 24786 | __start_cc_report 11:37:48 INFO - PROCESS | 24786 | _x_x_mozilla_cycle_collect,1937 11:37:48 INFO - PROCESS | 24786 | __end_cc_report 11:37:48 INFO - PROCESS | 24786 | __startTimestamp1471891068859__endTimestamp 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | ------- Summary: start ------- 11:37:48 INFO - PROCESS | 24786 | Number of tests: 14 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:4.41 (3.9%) stddev-sans-first:2.32 11:37:48 INFO - PROCESS | 24786 | Values: 102.0 114.0 110.0 114.0 113.0 114.0 119.0 115.0 114.0 114.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:150.50 stddev:22.98 (15.3%) stddev-sans-first:24.35 11:37:48 INFO - PROCESS | 24786 | Values: 150.0 123.0 150.0 182.0 127.0 161.0 151.0 122.0 179.0 121.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 11:37:48 INFO - PROCESS | 24786 | Values: 162.0 163.0 164.0 161.0 163.0 161.0 162.0 167.0 162.0 161.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:31.09 (41.2%) stddev-sans-first:32.25 11:37:48 INFO - PROCESS | 24786 | Values: 75.0 76.0 75.0 167.0 78.0 75.0 78.0 114.0 121.0 76.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:87.00 stddev:27.57 (31.7%) stddev-sans-first:28.70 11:37:48 INFO - PROCESS | 24786 | Values: 89.0 87.0 156.0 87.0 87.0 87.0 137.0 87.0 87.0 137.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:37:48 INFO - PROCESS | 24786 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 11:37:48 INFO - PROCESS | 24786 | Values: 148.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:37:48 INFO - PROCESS | 24786 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 11:37:48 INFO - PROCESS | 24786 | Values: 65.0 64.0 66.0 66.0 67.0 66.0 65.0 66.0 67.0 65.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 11:37:48 INFO - PROCESS | 24786 | Values: 67.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 67.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:3.95 (4.6%) stddev-sans-first:3.99 11:37:48 INFO - PROCESS | 24786 | Values: 82.0 89.0 82.0 83.0 90.0 81.0 84.0 83.0 92.0 88.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:135.00 stddev:20.02 (14.8%) stddev-sans-first:21.15 11:37:48 INFO - PROCESS | 24786 | Values: 136.0 136.0 133.0 134.0 144.0 130.0 134.0 132.0 197.0 134.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.50 stddev:3.36 (1.9%) stddev-sans-first:2.99 11:37:48 INFO - PROCESS | 24786 | Values: 182.0 176.0 179.0 181.0 176.0 174.0 173.0 172.0 179.0 176.0 11:37:48 INFO - PROCESS | 24786 | 11:37:48 INFO - PROCESS | 24786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 11:37:48 INFO - PROCESS | 24786 | Values: 68.0 69.0 70.0 68.0 69.0 68.0 68.0 67.0 70.0 69.0 11:37:48 INFO - PROCESS | 24786 | -------- Summary: end -------- 11:37:48 INFO - PROCESS | 24786 | 11:37:50 INFO - TEST-INFO | 24786: exit 0 11:37:50 INFO - TEST-OK | kraken | took 64750ms 11:37:50 INFO - SUITE-END | took 1185s 11:37:50 INFO - Completed test suite (00:19:46) 11:37:50 INFO - javascript benchmark 11:37:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.1465716313614, 2594.818362714611, 2616.2936007278036, 2619.8297110687818, 2641.339665083728, 4644.535546445354, 4695.413073365829, 4754.500777418369, 4833.419989601249, 4834.154023045966, 4779.808807647699, 4791.305260737191, 4825.396825396825, 4839.443464001641, 4881.194602890519, 4415.735055896656, 4418.668599855007, 4520.706154099973, 4539.568740969619, 4555.271156614942, 4491.281394976804, 4523.344115103325, 4530.501644819084, 4531.705439146462, 4566.680332376735, 4289.6997210195295, 4329.069250111241, 4332.155229730204, 4446.466424029105, 4475.843345482893, 4374.147041326943, 4378.62781663559, 4404.009097952967, 4408.118376324715, 4416.447944006999, 4410.5368936261875, 4442.8667139985855, 4452.421185245929, 4473.932891006638, 4520.909581808345, 4893.143699852547, 4895.339129217546, 4895.461499235082, 4897.216445368759, 4900.828471003498, 5003.249512573107, 5105.208692652608, 5133.948660513384, 5164.974175129138, 5224.791008359661, 5243.711595862226, 5245.186996015624, 5253.0544501989625, 5257.447967963385, 5264.236685680593, 4656.674032817738, 4903.485134060944, 4913.852584422473, 4916.70499770015, 4924.285978533164, 5218.556422704037, 5223.738813059332, 5241.816536421284, 5291.0, 5312.76092575835, 5069.315642388304, 5071.290019397287, 5083.694978301313, 5085.516875896784, 5095.261187127846, 4918.262260660929, 5178.533931946143, 5179.896402071938, 5198.532132108128, 5225.790968361223, 5017.0, 5076.035553244872, 5077.822276220315, 5157.948420515821, 5160.7419629018395, 5111.616628752859, 5131.332926719502, 5132.409772876093, 5133.23001549763, 5136.332276803992, 4291.463567054118, 4435.622972047412, 4447.6219521341045, 4449.9777501112285, 4450.732956022649, 3769.7361184716806, 3839.424086387064, 3864.8840534784003, 3932.528096628366, 3933.6263055009726, 4502.864914052584, 4523.819047238139, 4526.456825181, 4526.977365113154, 4538.341940418687, 5248.816291429782, 5263.973680131575, 5265.947340526545, 5271.578273738091, 5272.288241087481, 4314.56854314566, 4385.846495372647, 4428.3800267962515, 4429.424174857312, 4485.932711009337, 4673.532646735299, 4702.412198475191, 4704.623630109583, 4707.976460117678, 4708.764561771898, 4867.221244600847, 4878.658493905393, 4880.536349046835, 4881.219004959189, 4881.389826271716, 4920.8769780755765, 5080.568151706999, 5160.948390516047, 5183.274341592256, 5252.0, 4816.831410900601, 4848.466668666373, 4848.490908454562, 4851.223804191312, 4852.441969173449, 5069.391672999263, 5072.41667208261, 5089.923651145162, 5093.719845408538, 5095.515925987025, 4996.625253105959, 5079.3904731430985, 5101.56636685871, 5130.358705161855, 5146.408163061295, 5059.822906198266, 5070.746462676925, 5071.822486212965, 5078.644494885322, 5080.085584594808, 5071.239314102914, 5077.974610126926, 5081.695098294114, 5085.56772674312, 5088.338515992898, 4811.446683631427, 4864.318995340726, 4909.877253068702, 4915.5330243626795, 4972.751362431936, 5070.2141168119, 5076.0, 5077.568406685473, 5082.263071854634, 5082.898342033212, 4955.72743499111, 4961.479044700254, 4961.5534601886, 4967.577755890789, 4969.45336013031], "value": 4741.270196551024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.5819231902955, 542.0945376999844, 560.5599604310617, 574.3997522588894, 575.4159528078999, 29347.26631834205, 39335.40996885049, 40674.0, 40755.18489630205, 43811.78094109533, 40706.59293407065, 41293.0, 41306.38040429389, 41330.7933460333, 41460.79269603655, 7413.851722965537, 7576.469647124703, 7718.421118416141, 7727.922720772776, 7729.227077292282, 7382.224866389032, 7453.888191677129, 7454.0, 9557.474338911357, 9774.0, 9973.800523989516, 10026.448545330004, 10027.949860250725, 10035.942631760508, 10039.347442416256, 9872.210223182128, 9907.356021858628, 9934.850977235346, 9935.90064099357, 9936.105750482418, 9552.61789528418, 9653.420794752266, 9680.128788409076, 9687.32188746788, 9689.90310096897, 38139.80930095332, 38417.0, 38473.615263847285, 38522.61477385218, 38543.614563854564, 2751.683556391021, 2974.5686875402944, 3045.1959152234863, 3118.033409643018, 3146.7010633989735, 29450.11649650514, 29736.55395169074, 29827.552586711216, 30121.69878301233, 30943.69056309453, 3435.2644059875925, 3544.8404821783083, 3561.2521370512222, 3571.4285714285847, 3652.6164752700847, 247738.0, 248044.0, 249237.0, 249309.0, 249634.9999999982, 43121.78439107785, 43194.56805431968, 43201.78399108047, 43217.0, 43273.0, 32383.67616323854, 33339.16547107886, 33359.0, 35482.29035419329, 35489.82255088708, 13156.802647960289, 13251.337433128305, 13274.668133296746, 13293.401796919163, 13296.73406531864, 10113.59545618167, 10182.18542516597, 10189.745256368502, 10193.490325483695, 10201.234907381828, 15298.541043768704, 15703.528894133195, 15775.132367719885, 16390.50828475124, 17446.47660570185, 6340.651264180515, 6669.233038200572, 6672.83317917056, 6672.86654266912, 6730.461563074942, 772.6831998880432, 834.586879494654, 888.2982443869271, 907.7912080221586, 922.9676961306457, 27603.447931041268, 28892.42215155685, 29002.27494312659, 29250.41533387868, 29441.55837662437, 890.6125835261682, 899.1682693508609, 921.5115988526092, 954.1698722111807, 984.478226539935, 13519.053666243268, 13668.248246346546, 14039.78940315896, 14107.435702571987, 14242.359093840802, 379645.0, 382897.5130746082, 383567.0, 384016.0, 384048.0, 48745.0, 49215.0, 49323.26015109776, 49423.0, 49585.50414495881, 1192.2786714038054, 1196.5154112584416, 1224.5958833585073, 1226.343906010298, 1228.846394200725, 25398.619020715072, 26668.333291667863, 27367.863160684068, 27603.620440278493, 27852.86073569619, 41426.37860432156, 42175.7891210542, 42185.156296873276, 42212.366814497196, 42228.57771422246, 288070.0, 289125.0, 289428.0, 291049.0, 291729.0, 22346.0, 24414.75585244196, 25452.872735636203, 25562.744372556037, 25897.22308330753, 41853.79073104615, 41878.371824423266, 41939.79030104952, 43009.0, 43266.13467730691, 35775.46336804898, 35885.0, 36029.09927251735, 36282.0, 36433.63566364302, 35703.82148089243, 35789.82105089458, 36054.8197259012, 36414.0, 36425.81787091154, 33020.0, 35247.06208480576, 35642.0, 35753.82123089368, 36269.0, 27509.0, 29093.12720618385, 29265.41469170562, 29268.0, 29388.412231755672, 23901.521969560858, 24411.0, 24772.876135619208, 24799.0, 24936.127235546668], "value": 17186.56858185692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5512161750534, 354.12001177074967, 355.67811130926515, 361.358588505403, 368.0834721543356, 16574.33702651894, 16722.832771672278, 16858.40995565157, 16934.49196524106, 16971.066591337472, 15423.383064677428, 15961.760573591406, 16146.75779863303, 16156.434524791635, 16289.429869954554, 5000.274960130779, 5219.45195754446, 5246.554042906358, 5252.973735131319, 5254.527092561669, 3834.8466061357512, 4024.9597504025023, 5135.58915286778, 5229.450907654698, 5855.912161317584, 6027.517798576126, 6124.081387791823, 6173.2900716417735, 6180.81457556274, 6193.256809182904, 6144.907826382608, 6690.565113267622, 6915.343042410963, 6944.687489062953, 7078.186008608973, 6340.714667839959, 6682.365175308387, 6713.664316784141, 6722.260551339349, 6722.865542689167, 24373.756262437328, 24785.25644230676, 24803.62794558083, 24865.254042378758, 24953.251402457954, 1870.9812901870944, 1890.6880364739939, 1918.808119188084, 2297.8965946532444, 2333.661619065226, 13862.237576933265, 14949.850501495064, 15147.091174529452, 15346.0, 15779.447719329883, 1874.297138573035, 1906.5424298168339, 1916.1951980168362, 1920.395075551197, 1926.2680181531068, 78822.0, 81127.0, 81181.0, 81181.9999999994, 81394.59302703508, 15870.144278581945, 15891.682166356608, 16058.75911861323, 16318.184090795412, 16538.83461165397, 26061.348466288495, 26085.217443476726, 26140.477190456084, 26146.0, 26346.341341466617, 7582.431317651198, 7633.961830190813, 7720.42096842739, 7936.880946785803, 7970.163132871081, 6222.968885155546, 6263.530235232376, 6294.496440284766, 6401.55189136756, 6466.967665161644, 7431.739889103856, 7723.7682869514, 7800.765977020698, 7816.648250828726, 7835.863799749119, 2677.0, 2982.940341193164, 3200.9359812803614, 3222.715704376475, 3254.7070763631386, 756.3155344413315, 796.4146352430959, 834.7787836223406, 913.2830727878584, 916.706653870755, 16847.0, 16856.07291598974, 16893.746593801105, 17269.654606908043, 17834.821651783575, 828.4325237212408, 843.215809297347, 874.8687696845396, 899.1477556234179, 911.1207684584408, 9476.905230947603, 9884.308098433185, 9890.851637225447, 9966.601335946481, 9982.500874956368, 373471.0, 376412.0, 404492.0, 407449.0, 408372.0, 76984.61507692425, 77609.0, 78981.60509197532, 79365.20634793577, 79474.0, 806.8103995561039, 849.163573879728, 903.1916434790826, 906.2206502407923, 908.2007833106956, 14925.552233433014, 15310.856480092572, 16302.836971630131, 16476.67046659036, 16914.746278806073, 38573.8427847165, 38955.0, 39132.413013804246, 39961.800191000024, 42421.0, 53119.20321195263, 53584.19623705726, 54404.72797635986, 55893.0, 55960.44039559552, 7272.163701174221, 7295.0, 7332.523385979895, 7512.699492020258, 7561.546307221584, 6596.80209593713, 8401.957990210254, 8516.531590762568, 10052.246081544059, 12634.178778379375, 10059.698209053447, 10239.641612543823, 10405.739856503647, 10662.8400573993, 11004.779904402027, 4510.210713125124, 6918.066061081689, 10056.54745536438, 10396.58413663445, 10546.156307495228, 10080.89919100829, 10400.167986561208, 10656.0, 10686.786264274826, 11084.833727494255, 6690.966545167243, 7243.420526357984, 7259.9274007261365, 7302.415806735555, 7643.923560764321, 9758.877729060965, 10499.160067194452, 10503.264771465923, 10574.788504230026, 10781.946090269812], "value": 8991.898221279598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.3557310277615, 1398.7971744097106, 1459.5840185547122, 1676.6646670665855, 1697.185351031504, 6775.457963362932, 7020.859582808341, 7362.226966168556, 7943.602819859013, 7944.404169687282, 7002.5448345857485, 7263.128424589044, 7281.599512026836, 7476.551406915589, 7500.13748418932, 2084.7602525709585, 2112.355731501891, 2114.608797372491, 2117.375374264588, 2119.247667078188, 1826.3242600237863, 2063.4325560470916, 2104.5580428110115, 2130.2650585547963, 2197.6703494475796, 2179.596774596697, 2198.4723666320047, 2201.4606421426693, 2203.724534433196, 2205.889705514726, 2129.0419311309975, 2146.3346362627635, 2150.892455377225, 2153.881536515491, 2158.460384903774, 2091.8326533877253, 2103.3059090500096, 2134.135675051591, 2145.002573803189, 2149.3014770199593, 7800.570968596725, 7902.051753789582, 7902.683892644287, 7905.644246008886, 7907.762767116996, 4340.0, 4466.754328511931, 4467.977660111678, 4473.083017981306, 4475.0826080653715, 2812.4937511247967, 2907.1133304342166, 2946.8821247150304, 2956.1574951138823, 2972.4649563078638, 868.561376504861, 905.3029167540957, 918.169057003413, 923.5613083785215, 929.5027160469184, 10526.684199474028, 10534.736631584195, 10541.15670746346, 10556.313839600478, 10557.313774604627, 3708.666220040155, 4011.097503061788, 4055.5741647127215, 4078.0620457294394, 4083.1629515949157, 9206.401583897024, 9212.0, 9216.95391523038, 9217.815643687089, 9220.07799220086, 4501.459824820977, 4510.0, 4511.0, 4512.774361281923, 4520.61574766142, 4079.938800917989, 4100.671946244293, 4124.8143833527565, 4139.689523285766, 4143.772092534879, 3532.7703699259464, 3631.1466805300734, 3636.8363423646, 3649.94525082124, 3676.4117741161285, 1008.6368907193552, 1134.6766171641043, 1137.5165554639245, 1192.368044936168, 1194.988050119505, 627.0844566932238, 705.5837056136904, 706.20199174932, 719.3310221494061, 720.6072690383648, 4827.831025914076, 4885.6335774817035, 4930.827421040246, 4970.2793095001025, 5045.31888195089, 828.0705955124546, 833.4457585705559, 840.609116760697, 866.1208872993916, 881.1628952495155, 3459.775114617542, 3474.7915125092068, 3502.9299414011575, 3524.8061356625117, 3549.0594992327055, 9345.439273643604, 9588.90411095894, 9669.90330096704, 9671.226301895831, 9701.9029809701, 9486.383385080086, 9606.327557070937, 9645.855312170323, 9650.90349096514, 9657.90342096584, 7221.31397517235, 7242.7102915883825, 7305.269473052652, 7306.4885458017425, 7328.816779580553, 4944.728039957837, 5068.391792984866, 5088.974555127349, 5155.664881782672, 5173.586113110867, 8674.132586741276, 8891.377603567687, 8947.552622368725, 8980.86528702057, 9004.189622933967, 8918.643254270017, 9045.185933266037, 9100.044495327895, 9162.358634895494, 9260.518317069236, 6465.04492658329, 6651.700673469609, 6821.2155602106395, 6826.112605361272, 6831.419329356861, 7329.267073292842, 7567.243275672609, 7585.924140758521, 7608.0489938757655, 7609.391248700202, 6697.196336439463, 6717.596944183365, 6808.148981377328, 6896.896546551906, 6897.103376561216, 6313.96843015782, 6451.48388128958, 6529.444997175293, 6582.440492558187, 6747.325267473213, 6072.392760723892, 6143.139960405458, 6165.475934545434, 6168.814935551941, 6182.845428864314, 4504.954950450585, 4556.407667003268, 4645.2103142465185, 4673.742944137969, 4674.368960190331, 4394.912101758011, 4402.933955990727, 4517.6837621366185, 4609.147307748078, 4682.484926657997], "value": 4059.785805009269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.90321742216355, 289.31721138114045, 293.79434395922846, 296.3983114278016, 297.2183158293688, 4825.517448255173, 4831.661783675144, 4874.488178741234, 4877.341558889549, 4893.461719210888, 4739.857804265877, 4812.975935120328, 4820.770703470619, 4832.975835120819, 4850.520591219676, 3639.8180090995475, 3714.832832522543, 3751.512303400554, 3802.619738026189, 3815.329269511339, 3785.0, 3801.8669346572874, 3806.6193380661853, 3813.1420430403077, 3828.4448754930518, 3755.3615885299428, 3764.661180493755, 3768.453574231735, 3775.603561626031, 3781.6596506314427, 3537.451694987281, 3640.2537479816574, 3743.419769935664, 3761.7867987853506, 3787.905302367449, 3313.8840140595203, 3316.270420507509, 3322.9335413291597, 3322.9501557476656, 3334.233126380946, 4561.885952851205, 4617.769111544443, 4637.165310244155, 4638.930416043762, 4652.976735116336, 4147.776405960249, 4293.4203882476095, 4300.397944287803, 4308.504521979981, 4319.870403887889, 4980.2280646499485, 4992.975035124801, 4998.500149985009, 5031.522005409517, 5032.723200223986, 3634.5275114235246, 3637.527121474218, 3639.926221764559, 3640.854365825364, 3643.4899114124046, 5074.264231686385, 5259.342582177228, 5286.894262114736, 5296.496832800916, 5296.788128474856, 3652.981735091361, 3699.167687270343, 3702.1670124221832, 3722.8510859565854, 3725.981370093132, 3760.9059773505332, 3761.4545890845675, 3763.510743603314, 3810.3522401191863, 3818.8281527331337, 4252.362145678173, 4267.3598960155605, 4304.268274393361, 4312.654987600984, 4315.4605674290715, 4840.080384726891, 5020.246962955513, 5066.316047333563, 5077.796888124433, 5085.262636917626, 1298.577962162301, 1316.2036967634635, 1316.8872302904222, 1319.6568892088126, 1322.5701646964776, 787.7164220880478, 818.979525511867, 833.4832403909614, 835.2376485615347, 837.2966707965217, 4313.245182093121, 4315.899445641404, 4499.0, 4502.977485112619, 4505.954940450619, 5202.907389448258, 5213.739313034409, 5215.2698622192165, 5218.739063046908, 5230.503102205284, 4483.641308695296, 4505.707129036602, 4513.638908887281, 4516.36770852081, 4518.063258881687, 2625.973740262611, 2758.1449750576985, 2765.9308517287227, 2766.695663477016, 2782.1375373634237, 4881.341018962395, 4887.975560122248, 4915.729634870045, 4925.990172014728, 4927.926081108786, 5188.44836025451, 5263.34208223972, 5348.5186333230195, 5353.0899747043095, 5364.329458817648, 4840.878978025507, 4864.562189402971, 4900.754962251873, 4912.936566642091, 4935.3090567320605, 5223.6604620701055, 5236.947630523646, 5239.397469291081, 5240.161574148118, 5244.580433565229, 4856.567312642849, 5128.076946149728, 5140.0, 5155.422288855572, 5172.508611681884, 4890.510948905223, 4912.729799861042, 4916.237983112624, 4919.606431485401, 4924.556789888784, 3749.3438648235906, 3776.4901738264984, 3821.522309711286, 3824.8852534424013, 3829.4638750574386, 5087.0, 5250.081235783799, 5312.654677445954, 5319.46805319465, 5323.707196104251, 5034.874128146826, 5036.84889453317, 5039.143345631178, 5060.3168572242275, 5073.59411247092, 5000.2999580058095, 5016.899662006666, 5035.29505869186, 5044.991001799582, 5053.412077424922, 4727.503612120678, 4997.575206107522, 4998.825041123543, 5005.174146265826, 5029.622778291569, 4860.489648586848, 4974.527419895104, 5123.359580052494, 5131.4868513148385, 5152.9742351288005, 5011.649184557046, 5033.949660503495, 5037.19404895215, 5048.798048078036, 5054.393472783289], "value": 3813.6804009446605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.2117278156144, 575.2464271803935, 591.9200907877436, 638.658317799977, 645.1322970604535, 12132.939335303323, 13319.20084794913, 13332.733345333087, 13346.66633334167, 13350.799738003938, 12129.636110916665, 12783.169094008907, 12887.097903146783, 12888.355582220875, 12916.741665166715, 607.4441885674603, 745.6160077560061, 766.5094339622646, 770.8419773946327, 771.1209221487509, 735.9990413038264, 768.4505578511363, 769.349899335061, 774.1561697749452, 774.8682723936944, 810.67167797042, 810.9959450202741, 811.0875265326507, 811.7929927868415, 814.4217605500102, 636.3986033198629, 803.048387660624, 807.11620775251, 808.1514409869613, 808.5633757770797, 570.7431655754926, 586.4604563801313, 586.7682265505144, 586.9823905282806, 587.0548417048549, 12583.433745481476, 12614.68463288416, 12658.430370633343, 12665.936670316682, 12667.74664506714, 11432.542698292058, 11564.653060408202, 11624.535018599247, 11701.18091733579, 11738.119641026871, 11261.0, 11276.718082048015, 11539.365334906577, 11623.76752464946, 11682.941585292105, 3182.6499085100622, 3201.487761958099, 3265.3959017581824, 3371.612264589579, 4047.6761859051207, 60586.0, 61607.69196154035, 62058.68970655163, 63454.0, 63538.364616353705, 9679.951600241953, 9836.262280329003, 9837.655682051094, 9932.304738668225, 10119.13987311072, 16670.0, 16711.83288167127, 16726.832731672526, 16738.079405632565, 16744.0, 6219.968900155561, 6220.191375121205, 6483.805485835433, 6719.529632925648, 6785.457163426914, 3745.157339598623, 3756.6431189037, 3769.660730534265, 3789.2610940866266, 4029.37544680575, 2749.230215539652, 2858.6855445900933, 2873.741363277273, 2874.2526942994555, 2874.4825931332143, 500.93237412949514, 502.1939786642386, 506.0839879817542, 509.98980020400126, 512.7718165416354, 450.0325681463813, 534.132035442406, 543.4646872830259, 550.7659244820935, 563.1355868741545, 7497.850042999109, 7623.9618801905635, 7638.312551870358, 7753.379729621617, 7903.249191326815, 514.7349115205672, 514.8609875333639, 517.5238780322113, 519.4545726986725, 521.9947800522023, 3621.27574485104, 3642.1805093853673, 3653.671169594696, 3741.30785804627, 3804.0299723570865, 92252.07747922435, 103828.0, 103881.88354349382, 105002.0, 105497.67013979032, 89065.55467222622, 90500.54749726209, 90925.54537227271, 93730.0, 95506.0, 62335.0, 78599.60700196576, 79103.20896790958, 79651.60174199092, 80162.19837801663, 7193.172785129568, 7213.6032518212005, 7399.445041622008, 7450.0, 7754.185810489817, 35511.46732799062, 45785.0, 46866.297005545624, 46892.53107469018, 47246.0, 62028.379716204065, 69235.65382173056, 70011.64994175201, 71830.64084679753, 72402.0, 9115.27077833785, 9165.77085572866, 9226.261899048195, 9230.123138301851, 9275.913841031032, 10496.895031049897, 10827.51276192589, 11173.497192626513, 11299.604513841976, 12212.938935305267, 10618.309809862334, 11195.552177913118, 11571.479283432098, 11993.580224692094, 12263.509459621871, 11188.440577971232, 11280.7743845121, 11590.94204528972, 12261.080418968435, 12263.877361226274, 10442.53008614599, 10469.424181670081, 11330.94334528322, 11333.886661133283, 11348.54605815758, 9721.222302215665, 9919.752006199902, 10124.493775311352, 10129.341592796445, 10343.63797267092, 9161.954190229273, 9647.0, 10205.03052210039, 10221.013804616057, 10234.744131396774], "value": 6360.586623279255, "unit": "score"}], "name": "dromaeo_css", "value": 6452.406424706029, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 110.0, 114.0, 113.0, 114.0, 119.0, 115.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 150.0, 182.0, 127.0, 161.0, 151.0, 122.0, 179.0, 121.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 161.0, 163.0, 161.0, 162.0, 167.0, 162.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 167.0, 78.0, 75.0, 78.0, 114.0, 121.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 156.0, 87.0, 87.0, 87.0, 137.0, 87.0, 87.0, 137.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 89.0, 82.0, 83.0, 90.0, 81.0, 84.0, 83.0, 92.0, 88.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 133.0, 134.0, 144.0, 130.0, 134.0, 132.0, 197.0, 134.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 179.0, 181.0, 176.0, 174.0, 173.0, 172.0, 179.0, 176.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 68.0, 67.0, 70.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1583.3, "alertThreshold": 2.0}]} 11:37:50 INFO - Return code: 0 11:37:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:50 INFO - # TBPL SUCCESS # 11:37:50 INFO - Running post-action listener: _resource_record_post_action 11:37:50 INFO - [mozharness: 2016-08-22 18:37:50.678630Z] Finished run-tests step (success) 11:37:50 INFO - Running post-run listener: _resource_record_post_run 11:37:50 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414461952; Read time: 16; Write time: 327616 11:37:50 INFO - TinderboxPrint: CPU usage
13.2% 11:37:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:37:50 INFO - TinderboxPrint: I/O write bytes / time
414,461,952 / 327,616 11:37:50 INFO - TinderboxPrint: CPU idle
8,319.8 (86.7%) 11:37:50 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 11:37:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 121307136; Read time: 0; Write time: 117488 11:37:50 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292540416; Read time: 0; Write time: 210128 11:37:51 INFO - Running post-run listener: _upload_blobber_files 11:37:51 INFO - Blob upload gear active. 11:37:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:51 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 11:37:51 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37:51 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:52 INFO - (blobuploader) - INFO - Done attempting. 11:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:53 INFO - (blobuploader) - INFO - Done attempting. 11:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:58 INFO - (blobuploader) - INFO - Done attempting. 11:37:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:58 INFO - Return code: 0 11:37:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd69a205f3e0a49ef6c159501516f77f9c3e96f9e41f950c3a471e7313addd831642a1a9c9411e1ab33d8a5822acac60cc94cbb5f6580a6c67091316e1ee0a14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef85edce93b726ae6b7348274858c184b68d955a6551362eb2c6be8e4f85e4c721cd9594516db1e830c33458a7837c068e107444b812548a267068508295e4ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3fb8cd4e5f6cb2bda6e71d498bd894dd5e40721ed67b6bda21b1e1f7ab17f27ed22d65facc5dcd0823cc34fa4922eabdeaa12541031c837c9ad70319dd18e260"} 11:37:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:58 INFO - Contents: 11:37:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd69a205f3e0a49ef6c159501516f77f9c3e96f9e41f950c3a471e7313addd831642a1a9c9411e1ab33d8a5822acac60cc94cbb5f6580a6c67091316e1ee0a14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef85edce93b726ae6b7348274858c184b68d955a6551362eb2c6be8e4f85e4c721cd9594516db1e830c33458a7837c068e107444b812548a267068508295e4ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3fb8cd4e5f6cb2bda6e71d498bd894dd5e40721ed67b6bda21b1e1f7ab17f27ed22d65facc5dcd0823cc34fa4922eabdeaa12541031c837c9ad70319dd18e260"} 11:37:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:58 INFO - Copying logs to upload dir... 11:37:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.374585 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-22 11:37:58.578959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 11:37:58.582367) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fd69a205f3e0a49ef6c159501516f77f9c3e96f9e41f950c3a471e7313addd831642a1a9c9411e1ab33d8a5822acac60cc94cbb5f6580a6c67091316e1ee0a14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef85edce93b726ae6b7348274858c184b68d955a6551362eb2c6be8e4f85e4c721cd9594516db1e830c33458a7837c068e107444b812548a267068508295e4ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3fb8cd4e5f6cb2bda6e71d498bd894dd5e40721ed67b6bda21b1e1f7ab17f27ed22d65facc5dcd0823cc34fa4922eabdeaa12541031c837c9ad70319dd18e260"} build_url:https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/Llmbny2lR2yi9zU0ERBi-A/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/Autoland-Non-PGO/sha512/fd69a205f3e0a49ef6c159501516f77f9c3e96f9e41f950c3a471e7313addd831642a1a9c9411e1ab33d8a5822acac60cc94cbb5f6580a6c67091316e1ee0a14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ef85edce93b726ae6b7348274858c184b68d955a6551362eb2c6be8e4f85e4c721cd9594516db1e830c33458a7837c068e107444b812548a267068508295e4ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3fb8cd4e5f6cb2bda6e71d498bd894dd5e40721ed67b6bda21b1e1f7ab17f27ed22d65facc5dcd0823cc34fa4922eabdeaa12541031c837c9ad70319dd18e260"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 11:37:58.611231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:37:58.611907) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471889829.885900-1547142615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 11:37:58.693402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 11:37:58.693705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 11:37:58.693994) ========= ========= Total master_lag: 0.16 =========