builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1471021070.87 results: success (0) buildid: 20160812082517 builduid: 7758c8fbd481408b9adeaad3a89a155e revision: b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:50.873178) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:50.873601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:50.874093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:50.898465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:50.898733) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 09:57:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-08-12 09:57:51 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090950 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.003096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.003387) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.052902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.053282) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba --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 b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba --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=2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 09:57:51,523 truncating revision to first 12 chars 2016-08-12 09:57:51,523 Setting DEBUG logging. 2016-08-12 09:57:51,523 attempt 1/10 2016-08-12 09:57:51,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b4e9c7e20cf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 09:57:51,815 unpacking tar archive at: autoland-b4e9c7e20cf8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.716707) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.717013) ========= script_repo_revision: b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.717402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.717665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 09:57:51.726786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-12 09:57:51.727093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:52 INFO - MultiFileLogger online at 20160812 09:57:52 in /builds/slave/test 09:57:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:57:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:52 INFO - {'append_to_log': False, 09:57:52 INFO - 'base_work_dir': '/builds/slave/test', 09:57:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:57:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:52 INFO - 'branch': 'Autoland-Non-PGO', 09:57:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:52 INFO - 'config_files': ('talos/linux_config.py',), 09:57:52 INFO - 'default_actions': ('clobber', 09:57:52 INFO - 'read-buildbot-config', 09:57:52 INFO - 'download-and-extract', 09:57:52 INFO - 'populate-webroot', 09:57:52 INFO - 'create-virtualenv', 09:57:52 INFO - 'install', 09:57:52 INFO - 'run-tests'), 09:57:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:52 INFO - 'download_minidump_stackwalk': True, 09:57:52 INFO - 'download_symbols': 'ondemand', 09:57:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:52 INFO - 'installer_path': 'installer.exe', 09:57:52 INFO - 'log_level': 'info', 09:57:52 INFO - 'log_name': 'talos', 09:57:52 INFO - 'log_to_console': True, 09:57:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:52 INFO - 'opt_config_files': (), 09:57:52 INFO - 'pip_index': False, 09:57:52 INFO - 'sps_profile': False, 09:57:52 INFO - 'sps_profile_interval': 0, 09:57:52 INFO - 'suite': 'dromaeojs-e10s', 09:57:52 INFO - 'system_bits': '32', 09:57:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:52 INFO - 'title': 'talos-linux64-ix-012', 09:57:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:52 INFO - 'use_talos_json': True, 09:57:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:52 INFO - 'work_dir': 'build'} 09:57:52 INFO - [mozharness: 2016-08-12 16:57:52.286309Z] Running clobber step. 09:57:52 INFO - Running pre-action listener: _resource_record_pre_action 09:57:52 INFO - Running main action method: clobber 09:57:52 INFO - rmtree: /builds/slave/test/build 09:57:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:53 INFO - Running post-action listener: _resource_record_post_action 09:57:53 INFO - [mozharness: 2016-08-12 16:57:53.270868Z] Finished clobber step (success) 09:57:53 INFO - [mozharness: 2016-08-12 16:57:53.270966Z] Running read-buildbot-config step. 09:57:53 INFO - Running pre-action listener: _resource_record_pre_action 09:57:53 INFO - Running main action method: read_buildbot_config 09:57:53 INFO - Using buildbot properties: 09:57:53 INFO - { 09:57:53 INFO - "project": "", 09:57:53 INFO - "product": "firefox", 09:57:53 INFO - "script_repo_revision": "production", 09:57:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:57:53 INFO - "repository": "", 09:57:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 09:57:53 INFO - "buildid": "20160812082517", 09:57:53 INFO - "pgo_build": "False", 09:57:53 INFO - "basedir": "/builds/slave/test", 09:57:53 INFO - "buildnumber": 291, 09:57:53 INFO - "slavename": "talos-linux64-ix-012", 09:57:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:57:53 INFO - "platform": "ubuntu64_hw", 09:57:53 INFO - "scheduler": "tests-autoland-linux64-talos", 09:57:53 INFO - "branch": "autoland", 09:57:53 INFO - "repo_path": "integration/autoland", 09:57:53 INFO - "revision": "b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba", 09:57:53 INFO - "stage_platform": "linux64", 09:57:53 INFO - "builduid": "7758c8fbd481408b9adeaad3a89a155e", 09:57:53 INFO - "slavebuilddir": "test" 09:57:53 INFO - } 09:57:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:57:53 INFO - Running post-action listener: _resource_record_post_action 09:57:53 INFO - [mozharness: 2016-08-12 16:57:53.273364Z] Finished read-buildbot-config step (success) 09:57:53 INFO - [mozharness: 2016-08-12 16:57:53.273452Z] Running download-and-extract step. 09:57:53 INFO - Running pre-action listener: _resource_record_pre_action 09:57:53 INFO - Running main action method: download_and_extract 09:57:53 INFO - mkdir: /builds/slave/test/build/tests 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - trying https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:57:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:57:53 INFO - Downloaded 1361 bytes. 09:57:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:57:53 INFO - Using the following test package requirements: 09:57:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:57:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'jsshell-linux-x86_64.zip'], 09:57:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:53 INFO - trying https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:57:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:57:54 INFO - Downloaded 20262800 bytes. 09:57:54 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 09:57:58 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 09:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:58 INFO - trying https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:57:58 INFO - Downloading https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:57:59 INFO - Downloaded 20262800 bytes. 09:57:59 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 09:58: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')]} 09:58:04 INFO - trying https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:58:04 INFO - Downloading https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:58:05 INFO - Downloaded 14413719 bytes. 09:58:05 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 09:58:05 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')]} 09:58:05 INFO - trying https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:58:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/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 09:58:08 INFO - Downloaded 55651992 bytes. 09:58:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:58:08 INFO - mkdir: /builds/slave/test/properties 09:58:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:08 INFO - Contents: 09:58:08 INFO - build_url:https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:58:40 INFO - Running post-action listener: _resource_record_post_action 09:58:40 INFO - Running post-action listener: set_extra_try_arguments 09:58:40 INFO - [mozharness: 2016-08-12 16:58:40.615063Z] Finished download-and-extract step (success) 09:58:40 INFO - [mozharness: 2016-08-12 16:58:40.615291Z] Running populate-webroot step. 09:58:40 INFO - Running pre-action listener: _resource_record_pre_action 09:58:40 INFO - Running main action method: populate_webroot 09:58:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:40 INFO - '--tppagecycles', 09:58:40 INFO - '7'], 09:58:40 INFO - 'tests': ['tsvgm']}}, 09:58:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['damp', 'tps']}, 09:58:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'tests': ['damp', 'tps']}, 09:58:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['dromaeo_dom']}, 09:58:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['basic_compositor_video']}, 09:58:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['a11yr', 09:58:40 INFO - 'ts_paint', 09:58:40 INFO - 'tpaint', 09:58:40 INFO - 'sessionrestore', 09:58:40 INFO - 'sessionrestore_no_auto_restore', 09:58:40 INFO - 'tabpaint']}, 09:58:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:40 INFO - 'ts_paint', 09:58:40 INFO - 'tpaint', 09:58:40 INFO - 'sessionrestore', 09:58:40 INFO - 'sessionrestore_no_auto_restore', 09:58:40 INFO - 'tabpaint']}, 09:58:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:40 INFO - 'ts_paint', 09:58:40 INFO - 'tpaint', 09:58:40 INFO - 'sessionrestore', 09:58:40 INFO - 'sessionrestore_no_auto_restore', 09:58:40 INFO - 'tabpaint']}, 09:58:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:40 INFO - 'ts_paint', 09:58:40 INFO - 'tpaint', 09:58:40 INFO - 'sessionrestore', 09:58:40 INFO - 'sessionrestore_no_auto_restore', 09:58:40 INFO - 'tabpaint']}, 09:58:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['a11yr', 09:58:40 INFO - 'ts_paint', 09:58:40 INFO - 'tpaint', 09:58:40 INFO - 'sessionrestore', 09:58:40 INFO - 'sessionrestore_no_auto_restore', 09:58:40 INFO - 'tabpaint']}, 09:58:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['a11yr', 09:58:40 INFO - 'ts_paint', 09:58:40 INFO - 'tpaint', 09:58:40 INFO - 'sessionrestore', 09:58:40 INFO - 'sessionrestore_no_auto_restore', 09:58:40 INFO - 'tabpaint']}, 09:58:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['tsvgx', 09:58:40 INFO - 'tsvgr_opacity', 09:58:40 INFO - 'tart', 09:58:40 INFO - 'tscrollx', 09:58:40 INFO - 'cart']}, 09:58:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:40 INFO - 'tsvgr_opacity', 09:58:40 INFO - 'tart', 09:58:40 INFO - 'tscrollx', 09:58:40 INFO - 'cart']}, 09:58:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'talos_options': ['--disable-e10s'], 09:58:40 INFO - 'tests': ['tp5o']}, 09:58:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'tests': ['tp5o']}, 09:58:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'talos_options': ['--disable-e10s', 09:58:40 INFO - '--xperf_path', 09:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:40 INFO - 'tests': ['tp5n']}, 09:58:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:40 INFO - 'talos_options': ['--xperf_path', 09:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:40 INFO - 'tests': ['tp5n']}}, 09:58:40 INFO - 'talos.zip': {'path': '', 09:58:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:40 INFO - Running post-action listener: _resource_record_post_action 09:58:40 INFO - [mozharness: 2016-08-12 16:58:40.632598Z] Finished populate-webroot step (success) 09:58:40 INFO - [mozharness: 2016-08-12 16:58:40.632687Z] Running create-virtualenv step. 09:58:40 INFO - Running pre-action listener: _resource_record_pre_action 09:58:40 INFO - Running main action method: create_virtualenv 09:58:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:58:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:40 INFO - Using real prefix '/usr' 09:58:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:43 INFO - Installing pip.................done. 09:58:43 INFO - Return code: 0 09:58:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:43 INFO - Using env: {'DISPLAY': ':0', 09:58:43 INFO - 'HOME': '/home/cltbld', 09:58:43 INFO - 'LANG': 'en_US.UTF-8', 09:58:43 INFO - 'LANGUAGE': 'en_US:en', 09:58:43 INFO - 'LOGNAME': 'cltbld', 09:58:43 INFO - 'MAIL': '/var/mail/cltbld', 09:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:43 INFO - 'MOZ_NO_REMOTE': '1', 09:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:43 INFO - 'NO_EM_RESTART': '1', 09:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:43 INFO - 'PWD': '/builds/slave/test', 09:58:43 INFO - 'SHELL': '/bin/bash', 09:58:43 INFO - 'SHLVL': '1', 09:58:43 INFO - 'TERM': 'linux', 09:58:43 INFO - 'TMOUT': '86400', 09:58:43 INFO - 'USER': 'cltbld', 09:58:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:43 INFO - '_': '/tools/buildbot/bin/python'} 09:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:58:43 INFO - Cleaning up... 09:58:43 INFO - Return code: 0 09:58:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:58:43 INFO - Using env: {'DISPLAY': ':0', 09:58:43 INFO - 'HOME': '/home/cltbld', 09:58:43 INFO - 'LANG': 'en_US.UTF-8', 09:58:43 INFO - 'LANGUAGE': 'en_US:en', 09:58:43 INFO - 'LOGNAME': 'cltbld', 09:58:43 INFO - 'MAIL': '/var/mail/cltbld', 09:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:43 INFO - 'MOZ_NO_REMOTE': '1', 09:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:43 INFO - 'NO_EM_RESTART': '1', 09:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:43 INFO - 'PWD': '/builds/slave/test', 09:58:43 INFO - 'SHELL': '/bin/bash', 09:58:43 INFO - 'SHLVL': '1', 09:58:43 INFO - 'TERM': 'linux', 09:58:43 INFO - 'TMOUT': '86400', 09:58:43 INFO - 'USER': 'cltbld', 09:58:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:43 INFO - '_': '/tools/buildbot/bin/python'} 09:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:43 INFO - Downloading/unpacking psutil>=3.1.1 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:45 INFO - Installing collected packages: psutil 09:58:45 INFO - Running setup.py install for psutil 09:58:45 INFO - building 'psutil._psutil_linux' extension 09:58:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:58:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:58:45 INFO - building 'psutil._psutil_posix' extension 09:58:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:58:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:58:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:46 INFO - Successfully installed psutil 09:58:46 INFO - Cleaning up... 09:58:46 INFO - Return code: 0 09:58:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:58:46 INFO - Using env: {'DISPLAY': ':0', 09:58:46 INFO - 'HOME': '/home/cltbld', 09:58:46 INFO - 'LANG': 'en_US.UTF-8', 09:58:46 INFO - 'LANGUAGE': 'en_US:en', 09:58:46 INFO - 'LOGNAME': 'cltbld', 09:58:46 INFO - 'MAIL': '/var/mail/cltbld', 09:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:46 INFO - 'MOZ_NO_REMOTE': '1', 09:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:46 INFO - 'NO_EM_RESTART': '1', 09:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:46 INFO - 'PWD': '/builds/slave/test', 09:58:46 INFO - 'SHELL': '/bin/bash', 09:58:46 INFO - 'SHLVL': '1', 09:58:46 INFO - 'TERM': 'linux', 09:58:46 INFO - 'TMOUT': '86400', 09:58:46 INFO - 'USER': 'cltbld', 09:58:46 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:46 INFO - '_': '/tools/buildbot/bin/python'} 09:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:48 INFO - Installing collected packages: mozsystemmonitor 09:58:48 INFO - Running setup.py install for mozsystemmonitor 09:58:48 INFO - Successfully installed mozsystemmonitor 09:58:48 INFO - Cleaning up... 09:58:48 INFO - Return code: 0 09:58:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:58:48 INFO - Using env: {'DISPLAY': ':0', 09:58:48 INFO - 'HOME': '/home/cltbld', 09:58:48 INFO - 'LANG': 'en_US.UTF-8', 09:58:48 INFO - 'LANGUAGE': 'en_US:en', 09:58:48 INFO - 'LOGNAME': 'cltbld', 09:58:48 INFO - 'MAIL': '/var/mail/cltbld', 09:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:48 INFO - 'MOZ_NO_REMOTE': '1', 09:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:48 INFO - 'NO_EM_RESTART': '1', 09:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:48 INFO - 'PWD': '/builds/slave/test', 09:58:48 INFO - 'SHELL': '/bin/bash', 09:58:48 INFO - 'SHLVL': '1', 09:58:48 INFO - 'TERM': 'linux', 09:58:48 INFO - 'TMOUT': '86400', 09:58:48 INFO - 'USER': 'cltbld', 09:58:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:48 INFO - '_': '/tools/buildbot/bin/python'} 09:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:48 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:50 INFO - warning: no files found matching '*.txt' 09:58:50 INFO - no previously-included directories found matching 'build' 09:58:50 INFO - no previously-included directories found matching 'dist' 09:58:50 INFO - no previously-included directories found matching '.git*' 09:58:50 INFO - Installing collected packages: jsonschema, functools32 09:58:50 INFO - Running setup.py install for functools32 09:58:50 INFO - warning: no files found matching '*.txt' 09:58:50 INFO - no previously-included directories found matching 'build' 09:58:50 INFO - no previously-included directories found matching 'dist' 09:58:50 INFO - no previously-included directories found matching '.git*' 09:58:50 INFO - Successfully installed jsonschema functools32 09:58:50 INFO - Cleaning up... 09:58:51 INFO - Return code: 0 09:58:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:58:51 INFO - Using env: {'DISPLAY': ':0', 09:58:51 INFO - 'HOME': '/home/cltbld', 09:58:51 INFO - 'LANG': 'en_US.UTF-8', 09:58:51 INFO - 'LANGUAGE': 'en_US:en', 09:58:51 INFO - 'LOGNAME': 'cltbld', 09:58:51 INFO - 'MAIL': '/var/mail/cltbld', 09:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:51 INFO - 'MOZ_NO_REMOTE': '1', 09:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:51 INFO - 'NO_EM_RESTART': '1', 09:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:51 INFO - 'PWD': '/builds/slave/test', 09:58:51 INFO - 'SHELL': '/bin/bash', 09:58:51 INFO - 'SHLVL': '1', 09:58:51 INFO - 'TERM': 'linux', 09:58:51 INFO - 'TMOUT': '86400', 09:58:51 INFO - 'USER': 'cltbld', 09:58:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:51 INFO - '_': '/tools/buildbot/bin/python'} 09:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:51 INFO - Cleaning up... 09:58:51 INFO - Return code: 0 09:58:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:58:51 INFO - Using env: {'DISPLAY': ':0', 09:58:51 INFO - 'HOME': '/home/cltbld', 09:58:51 INFO - 'LANG': 'en_US.UTF-8', 09:58:51 INFO - 'LANGUAGE': 'en_US:en', 09:58:51 INFO - 'LOGNAME': 'cltbld', 09:58:51 INFO - 'MAIL': '/var/mail/cltbld', 09:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:51 INFO - 'MOZ_NO_REMOTE': '1', 09:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:51 INFO - 'NO_EM_RESTART': '1', 09:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:51 INFO - 'PWD': '/builds/slave/test', 09:58:51 INFO - 'SHELL': '/bin/bash', 09:58:51 INFO - 'SHLVL': '1', 09:58:51 INFO - 'TERM': 'linux', 09:58:51 INFO - 'TMOUT': '86400', 09:58:51 INFO - 'USER': 'cltbld', 09:58:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:51 INFO - '_': '/tools/buildbot/bin/python'} 09:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - Downloading docopt-0.6.1.tar.gz 09:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:54 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:54 INFO - Running setup.py install for blobuploader 09:58:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:54 INFO - Running setup.py install for requests 09:58:54 INFO - Running setup.py install for docopt 09:58:54 INFO - Successfully installed blobuploader requests docopt 09:58:54 INFO - Cleaning up... 09:58:54 INFO - Return code: 0 09:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:54 INFO - Using env: {'DISPLAY': ':0', 09:58:54 INFO - 'HOME': '/home/cltbld', 09:58:54 INFO - 'LANG': 'en_US.UTF-8', 09:58:54 INFO - 'LANGUAGE': 'en_US:en', 09:58:54 INFO - 'LOGNAME': 'cltbld', 09:58:54 INFO - 'MAIL': '/var/mail/cltbld', 09:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:54 INFO - 'MOZ_NO_REMOTE': '1', 09:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:54 INFO - 'NO_EM_RESTART': '1', 09:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:54 INFO - 'PWD': '/builds/slave/test', 09:58:54 INFO - 'SHELL': '/bin/bash', 09:58:54 INFO - 'SHLVL': '1', 09:58:54 INFO - 'TERM': 'linux', 09:58:54 INFO - 'TMOUT': '86400', 09:58:54 INFO - 'USER': 'cltbld', 09:58:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:54 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:55 INFO - Running setup.py (path:/tmp/pip-bBEPo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:55 INFO - Running setup.py (path:/tmp/pip-GexNe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:55 INFO - Running setup.py (path:/tmp/pip-Gosgw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:55 INFO - Running setup.py (path:/tmp/pip-eCOhRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:55 INFO - Running setup.py (path:/tmp/pip-35CGiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:55 INFO - Running setup.py (path:/tmp/pip-2zv8cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:55 INFO - Running setup.py (path:/tmp/pip-Ogw5Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:55 INFO - Running setup.py (path:/tmp/pip-ChIldi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:55 INFO - Running setup.py (path:/tmp/pip-nvVB4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:55 INFO - Running setup.py (path:/tmp/pip-nHDLtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:55 INFO - Running setup.py (path:/tmp/pip-JV1C3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:55 INFO - Running setup.py (path:/tmp/pip-bdnAw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:55 INFO - Running setup.py (path:/tmp/pip-S7wg30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:56 INFO - Running setup.py (path:/tmp/pip-XbJ_Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:56 INFO - Running setup.py (path:/tmp/pip-UBnBxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:56 INFO - Running setup.py (path:/tmp/pip-fa9_Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:56 INFO - Running setup.py (path:/tmp/pip-Nxq2m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:56 INFO - Running setup.py install for manifestparser 09:58:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:56 INFO - Running setup.py install for mozcrash 09:58:56 INFO - Running setup.py install for mozdebug 09:58:56 INFO - Running setup.py install for mozdevice 09:58:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:56 INFO - Running setup.py install for mozfile 09:58:56 INFO - Running setup.py install for mozhttpd 09:58:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:56 INFO - Running setup.py install for mozinfo 09:58:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Running setup.py install for mozInstall 09:58:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Running setup.py install for mozleak 09:58:57 INFO - Running setup.py install for mozlog 09:58:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Running setup.py install for moznetwork 09:58:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Running setup.py install for mozprocess 09:58:57 INFO - Running setup.py install for mozprofile 09:58:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Running setup.py install for mozrunner 09:58:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:57 INFO - Running setup.py install for mozscreenshot 09:58:57 INFO - Running setup.py install for moztest 09:58:58 INFO - Running setup.py install for mozversion 09:58:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:58 INFO - Cleaning up... 09:58:58 INFO - Return code: 0 09:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:58:58 INFO - Using env: {'DISPLAY': ':0', 09:58:58 INFO - 'HOME': '/home/cltbld', 09:58:58 INFO - 'LANG': 'en_US.UTF-8', 09:58:58 INFO - 'LANGUAGE': 'en_US:en', 09:58:58 INFO - 'LOGNAME': 'cltbld', 09:58:58 INFO - 'MAIL': '/var/mail/cltbld', 09:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:58 INFO - 'MOZ_NO_REMOTE': '1', 09:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:58 INFO - 'NO_EM_RESTART': '1', 09:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:58 INFO - 'PWD': '/builds/slave/test', 09:58:58 INFO - 'SHELL': '/bin/bash', 09:58:58 INFO - 'SHLVL': '1', 09:58:58 INFO - 'TERM': 'linux', 09:58:58 INFO - 'TMOUT': '86400', 09:58:58 INFO - 'USER': 'cltbld', 09:58:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:58 INFO - '_': '/tools/buildbot/bin/python'} 09:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:58 INFO - Running setup.py (path:/tmp/pip-W_ejuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:58 INFO - Running setup.py (path:/tmp/pip-51hKyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:58 INFO - Running setup.py (path:/tmp/pip-H1KnOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:58 INFO - Running setup.py (path:/tmp/pip-SSZO79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:58 INFO - Running setup.py (path:/tmp/pip-GkLPaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:58 INFO - Running setup.py (path:/tmp/pip-M6QKfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:58 INFO - Running setup.py (path:/tmp/pip-d4GyGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:58 INFO - Running setup.py (path:/tmp/pip-RKYuk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:58 INFO - Running setup.py (path:/tmp/pip-2_pRb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:59 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)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:59 INFO - Running setup.py (path:/tmp/pip-74vd0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:59 INFO - Running setup.py (path:/tmp/pip-bAU_Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:59 INFO - Running setup.py (path:/tmp/pip-uffdVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:59 INFO - Running setup.py (path:/tmp/pip-3DqxwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:59 INFO - Running setup.py (path:/tmp/pip-ks4HM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:59 INFO - Running setup.py (path:/tmp/pip-pirCI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:59 INFO - Running setup.py (path:/tmp/pip-3hbHkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:59 INFO - Running setup.py (path:/tmp/pip-EM90Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:01 INFO - Downloading blessings-1.6.tar.gz 09:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:01 INFO - Installing collected packages: blessings 09:59:01 INFO - Running setup.py install for blessings 09:59:01 INFO - Successfully installed blessings 09:59:01 INFO - Cleaning up... 09:59:01 INFO - Return code: 0 09:59:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:01 INFO - Reading from file tmpfile_stdout 09:59:01 INFO - Current package versions: 09:59:01 INFO - argparse == 1.2.1 09:59:01 INFO - blessings == 1.6 09:59:01 INFO - blobuploader == 1.2.4 09:59:01 INFO - docopt == 0.6.1 09:59:01 INFO - functools32 == 3.2.3-2 09:59:01 INFO - jsonschema == 2.5.1 09:59:01 INFO - manifestparser == 1.1 09:59:01 INFO - mozInstall == 1.12 09:59:01 INFO - mozcrash == 0.17 09:59:01 INFO - mozdebug == 0.1 09:59:01 INFO - mozdevice == 0.48 09:59:01 INFO - mozfile == 1.2 09:59:01 INFO - mozhttpd == 0.7 09:59:01 INFO - mozinfo == 0.9 09:59:01 INFO - mozleak == 0.1 09:59:01 INFO - mozlog == 3.3 09:59:01 INFO - moznetwork == 0.27 09:59:01 INFO - mozprocess == 0.23 09:59:01 INFO - mozprofile == 0.28 09:59:01 INFO - mozrunner == 6.12 09:59:01 INFO - mozscreenshot == 0.1 09:59:01 INFO - mozsystemmonitor == 0.3 09:59:01 INFO - moztest == 0.7 09:59:01 INFO - mozversion == 1.4 09:59:01 INFO - psutil == 3.1.1 09:59:01 INFO - requests == 1.2.3 09:59:01 INFO - wsgiref == 0.1.2 09:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:59:01 INFO - Using env: {'DISPLAY': ':0', 09:59:01 INFO - 'HOME': '/home/cltbld', 09:59:01 INFO - 'LANG': 'en_US.UTF-8', 09:59:01 INFO - 'LANGUAGE': 'en_US:en', 09:59:01 INFO - 'LOGNAME': 'cltbld', 09:59:01 INFO - 'MAIL': '/var/mail/cltbld', 09:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:01 INFO - 'MOZ_NO_REMOTE': '1', 09:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:01 INFO - 'NO_EM_RESTART': '1', 09:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:01 INFO - 'PWD': '/builds/slave/test', 09:59:01 INFO - 'SHELL': '/bin/bash', 09:59:01 INFO - 'SHLVL': '1', 09:59:01 INFO - 'TERM': 'linux', 09:59:01 INFO - 'TMOUT': '86400', 09:59:01 INFO - 'USER': 'cltbld', 09:59:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:01 INFO - '_': '/tools/buildbot/bin/python'} 09:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:59:02 INFO - Cleaning up... 09:59:02 INFO - Return code: 0 09:59:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1d14bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', '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 09:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:59:02 INFO - Using env: {'DISPLAY': ':0', 09:59:02 INFO - 'HOME': '/home/cltbld', 09:59:02 INFO - 'LANG': 'en_US.UTF-8', 09:59:02 INFO - 'LANGUAGE': 'en_US:en', 09:59:02 INFO - 'LOGNAME': 'cltbld', 09:59:02 INFO - 'MAIL': '/var/mail/cltbld', 09:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:02 INFO - 'MOZ_NO_REMOTE': '1', 09:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:02 INFO - 'NO_EM_RESTART': '1', 09:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:02 INFO - 'PWD': '/builds/slave/test', 09:59:02 INFO - 'SHELL': '/bin/bash', 09:59:02 INFO - 'SHLVL': '1', 09:59:02 INFO - 'TERM': 'linux', 09:59:02 INFO - 'TMOUT': '86400', 09:59:02 INFO - 'USER': 'cltbld', 09:59:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:02 INFO - '_': '/tools/buildbot/bin/python'} 09:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:02 INFO - Cleaning up... 09:59:02 INFO - Return code: 0 09:59:02 INFO - Running post-action listener: _resource_record_post_action 09:59:02 INFO - Running post-action listener: _start_resource_monitoring 09:59:02 INFO - Starting resource monitoring. 09:59:02 INFO - [mozharness: 2016-08-12 16:59:02.441621Z] Finished create-virtualenv step (success) 09:59:02 INFO - [mozharness: 2016-08-12 16:59:02.442148Z] Running install step. 09:59:02 INFO - Running pre-action listener: _resource_record_pre_action 09:59:02 INFO - Running main action method: install 09:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:02 INFO - Reading from file tmpfile_stdout 09:59:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:02 INFO - Reading from file tmpfile_stdout 09:59:02 INFO - Output received: 09:59:02 INFO - Usage: mozinstall [options] installer 09:59:02 INFO - Options: 09:59:02 INFO - -h, --help show this help message and exit 09:59:02 INFO - -d DEST, --destination=DEST 09:59:02 INFO - Directory to install application into. [default: 09:59:02 INFO - "/builds/slave/test"] 09:59:02 INFO - --app=APP Application being installed. [default: firefox] 09:59:02 INFO - mkdir: /builds/slave/test/build/application 09:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:59:18 INFO - Reading from file tmpfile_stdout 09:59:18 INFO - Output received: 09:59:18 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:18 INFO - Running post-action listener: _resource_record_post_action 09:59:18 INFO - [mozharness: 2016-08-12 16:59:18.767451Z] Finished install step (success) 09:59:18 INFO - [mozharness: 2016-08-12 16:59:18.767785Z] Running run-tests step. 09:59:18 INFO - Running pre-action listener: _resource_record_pre_action 09:59:18 INFO - Running main action method: run_tests 09:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:18 INFO - Python 2.7.3 09:59:18 INFO - Return code: 0 09:59:18 INFO - grabbing minidump binary from tooltool 09:59:18 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')]} 09:59:18 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 0x1b05d20>, '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 0x1b06c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b070b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:18 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 09:59:18 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 09:59:18 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 09:59:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:18 INFO - Return code: 0 09:59:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:59:18 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:59:18 INFO - Using env: {'DISPLAY': ':0', 09:59:18 INFO - 'HOME': '/home/cltbld', 09:59:18 INFO - 'LANG': 'en_US.UTF-8', 09:59:18 INFO - 'LANGUAGE': 'en_US:en', 09:59:18 INFO - 'LOGNAME': 'cltbld', 09:59:18 INFO - 'MAIL': '/var/mail/cltbld', 09:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:18 INFO - 'MOZ_NO_REMOTE': '1', 09:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:18 INFO - 'NO_EM_RESTART': '1', 09:59:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:18 INFO - 'PWD': '/builds/slave/test', 09:59:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:18 INFO - 'SHELL': '/bin/bash', 09:59:18 INFO - 'SHLVL': '1', 09:59:18 INFO - 'TERM': 'linux', 09:59:18 INFO - 'TMOUT': '86400', 09:59:18 INFO - 'USER': 'cltbld', 09:59:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372', 09:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:18 INFO - '_': '/tools/buildbot/bin/python'} 09:59:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:59:19 INFO - mozversion application_buildid: 20160812082517 09:59:19 INFO - mozversion application_changeset: b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba 09:59:19 INFO - mozversion application_display_name: Nightly 09:59:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:19 INFO - mozversion application_name: Firefox 09:59:19 INFO - mozversion application_remotingname: firefox 09:59:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:59:19 INFO - mozversion application_vendor: Mozilla 09:59:19 INFO - mozversion application_version: 51.0a1 09:59:19 INFO - mozversion platform_buildid: 20160812082517 09:59:19 INFO - mozversion platform_changeset: b4e9c7e20cf8d7adfb15df7cc4bc4fc84fccc8ba 09:59:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:59:19 INFO - mozversion platform_version: 51.0a1 09:59:19 INFO - using testdate: 1471021159 09:59:19 INFO - actual date: 1471021159 09:59:19 INFO - starting webserver on 'localhost:44592' 09:59:19 INFO - SUITE-START | Running 2 tests 09:59:19 INFO - TEST-START | dromaeo_css 09:59:19 INFO - operating with platform_type : linux_ 09:59:19 INFO - Initialising browser for dromaeo_css test... 09:59:19 INFO - TEST-INFO | started process 17644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB1wkaH/profile http://localhost:44592/getInfo.html) 09:59:23 INFO - PROCESS | 17644 | __metrics Screen width/height:1600/1200 09:59:23 INFO - PROCESS | 17644 | colorDepth:24 09:59:23 INFO - PROCESS | 17644 | Browser inner width/height: 1024/697 09:59:23 INFO - PROCESS | 17644 | __metrics 09:59:23 ERROR - PROCESS | 17644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:59:24 INFO - TEST-INFO | 17644: exit 0 09:59:24 INFO - Browser initialized. 09:59:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:24 INFO - TEST-INFO | started process 17765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB1wkaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:36 INFO - PROCESS | 17765 | RSS: Main: 163557376 09:59:36 INFO - PROCESS | 17765 | 10:00:26 INFO - PROCESS | 17765 | 1471021226363 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] 10:02:37 INFO - PROCESS | 17765 | Cycle 1(1): loaded http://localhost:44592/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44592/tests/dromaeo/cssquery-ext.html) 10:02:39 INFO - PROCESS | 17765 | RSS: Main: 165634048 10:02:39 INFO - PROCESS | 17765 | 10:05:41 INFO - PROCESS | 17765 | Cycle 1(1): loaded http://localhost:44592/tests/dromaeo/cssquery-ext.html (next: http://localhost:44592/tests/dromaeo/cssquery-jquery.html) 10:05:42 INFO - PROCESS | 17765 | RSS: Main: 164425728 10:05:42 INFO - PROCESS | 17765 | 10:08:44 INFO - PROCESS | 17765 | Cycle 1(1): loaded http://localhost:44592/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44592/tests/dromaeo/cssquery-mootools.html) 10:08:44 INFO - PROCESS | 17765 | RSS: Main: 169238528 10:08:44 INFO - PROCESS | 17765 | 10:11:46 INFO - PROCESS | 17765 | Cycle 1(1): loaded http://localhost:44592/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44592/tests/dromaeo/cssquery-prototype.html) 10:11:47 INFO - PROCESS | 17765 | RSS: Main: 163565568 10:11:47 INFO - PROCESS | 17765 | 10:14:50 INFO - PROCESS | 17765 | Cycle 1(1): loaded http://localhost:44592/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44592/tests/dromaeo/cssquery-yui.html) 10:14:50 INFO - PROCESS | 17765 | RSS: Main: 165535744 10:14:50 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | Cycle 1(1): loaded http://localhost:44592/tests/dromaeo/cssquery-yui.html (next: http://localhost:44592/tests/dromaeo/cssquery-dojo.html) 10:17:53 INFO - PROCESS | 17765 | RSS: Main: 168759296 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | __start_tp_report 10:17:53 INFO - PROCESS | 17765 | _x_x_mozilla_page_load 10:17:53 INFO - PROCESS | 17765 | _x_x_mozilla_page_load_details 10:17:53 INFO - PROCESS | 17765 | |i|pagename|runs| 10:17:53 INFO - PROCESS | 17765 | |0;dojo.html;2640.709521952585;2666.41338905441;2689.193242027391;2690.058479532164;2715.389037466569;4564.9543504564945;4754.548317909797;4797.784099715513;4817.542333478314;4838.9032219355595;4611.446626404828;4661.65037622178;4671.4627817800965;4676.181668208067;4678;4361.71648842825;4399.384086227915;4408.911821763563;4426;4443.533428989958;4386.561343865604;4405;4413.867583972486;4448.266036104039;4465.129299786543;129.61098519227568;4362.847300344472;4431.601155895953;4435.467743870756;4472.284434490482;4336.479622445327;4345.84789532368;4348.108637729258;4394.362817391492;4405.735655860659;4317.266064768965;4355.956440435587;4370.38814565961;4388.166248412823;4424.446944131983;4741.5495527924795;4742.1227072991605;4745.3593764842;4749.548792864673;4834.105690447279;5153;5163;5168.043911876315;5181.922271165936;5216.60875434344;5152.871178220575;5205.843824685266;5207.140821764404;5208.5051920067535;5216.061109000379;4607.9308810367875;4725.929111063337;4733.5503127202865;4762.78567464465;4806.975965120152;5245.580353571705;5253.185756207794;5261.0793111205385;5266.21006848968;5272.103742363807;5038.244263360525;5043.722595257296;5044.268581055726;5066.240063990357;5087.491250874957;5003.5997120230295;5089.211172268304;5095.796168153232;5116.334876466036;5155.149400348901;5109.923351149736;5122.282880396748;5129;5130.461301563282;5145.125328694131;5083.313752643346;5112.9744351278005;5113.15632920564;5123.743812809419;5161.303224064778;4136.462259906253;4288.056627541936;4322.502912165079;4330.155619654201;4384.6273066789045;3789.5831458539537;3798.525184351956;3799.905002374963;3834.4440056191697;3853.9979605302824;4474;4485.484169320504;4487.41663583732;4504.864854054384;4529.773511324421;5011.323471331397;5103.795848166106;5127.897442051138;5161.27742116104;5238.083335416287;4477.126960242721;4479.283314669702;4486.102779444124;4493.775311234425;4546.227141385973;4612.146752850734;4612.5156858530045;4629.629629629621;4633.0733853229485;4633.976830115827;4631.050634619962;4797.64017698674;4893.266010098514;4898.314236006961;4909.0672772173175;5121.436641969455;5159.134641679795;5162.664426812245;5166.070107380558;5184.118699821115;4818.156822555969;4857.319975203545;4860.95139048605;4862.902741945212;4915.483874193158;4814.325994360723;4990.226514890198;5039.395272567315;5081.136206844772;5124.231365295235;5162.199859021857;5168.612354073534;5173.1722924331925;5175.301334319819;5185.818496352609;5034.421041580265;5037.697738135724;5041.395032596112;5042.722650254272;5065.670731402447;4844.539768721966;4976;4983.426905905867;5012.097822391858;5105.7191854448365;4935.876603084952;4962.354893863775;4976.2038073908;4977.9502204978935;4982.078315511642;5080.263361812443;5080.644354895122;5081.8475445736685;5082.898342033065;5086.415062267739;4709.529047095263;4867.829625963074;4879.56083952446;4890.608751299958;4945.7527123644395 10:17:53 INFO - PROCESS | 17765 | |1;ext.html;551.8592758846494;557.4258513730857;564.3340857787808;569.3480964295882;583.1282233061569;35174.64825351746;40067.599324006755;40138.79930600343;40191.39712904301;40249;39802.20395592094;40039.39940900889;40337.59662403375;40483.59516404835;40576.59423405765;7473.252674732524;7566.054243219598;7573.318401343878;7613.505122167069;7625.6568454419685;7720.266574675396;7774.611269436506;7783.338416234598;7797.0643522777345;7809.101953275361;7785.065792104955;7800.648970796299;7808.453408261395;7810.609469526529;7815.804604884895;7648.885266721004;7761.068671759369;7770.3006729394065;7778;7785.260400261966;7659.425543084291;7684.269994350528;7728.18854020331;7766.301032907009;7771.883421748678;35920;36129.819350903075;36217.81891090554;36247.63752362495;36301;3093.8298393588343;3205.2307446212976;3368.730501559894;3370.25854312051;3571.321448924722;27466.862665686742;29045.56431653527;29390.70609293901;29411.11766647004;29443.70556294431;3286.65490123536;3361.428557145291;3435.879744208966;3440.3119376124873;3455.1016735648914;258733;259340;259462;260949;260956;30913;32254;32269.838650806596;51318.48681513212;51764.48235517597;33000;33594.832025839714;33618.32763344768;33668.83165584156;33788.155296117795;13711;13852.861471385157;13883.305834708426;13957.930210348883;13963.511277105456;11506.94246528762;11512.88487115135;11520.078393728481;11561.942190288995;11651.88348116508;7765.883511747328;7815.609219539;7831.138574756772;7889.408294377945;7912.723054693058;3068.9232769180503;3069.1099581121225;3115.7351625111664;3134.2947836736553;3158.6841315868687;867.9826403471895;870.3602851903846;902.2195800632405;953.1612181280567;954.8854137503544;27954.72045279562;28166.2958426041;28725.138245852657;29097.563536546968;29117.417651646847;913.7715571107224;951.6241084771476;1001.0340021878922;1004.8894621591619;1005.2305897253021;14438.422463101359;15267.3893044277;15354.462593809163;15419.151946642818;15618.141002244985;377437;382090;382568;382877;383013;50188;50311.24533132006;50870;50894.491055088976;50952.23571646428;1133.8355938388888;1165.6386520178942;1166.2361153444508;1178.2223732336618;1179.262960649594;26681.866590666923;27883.581746274227;28237.57643635306;28358.149255522367;28825;42687.719368419;42824.78587607042;42841.57158428376;43228.8385580726;43380;325533;329152;329588;329951;330218;25271.74728252694;25414.745852541237;25553.744462555882;25606.615900761877;25785.484290313714;41245;41433;41879.7906010468;42002;42901.356479653456;36745.29668595006;36869.63130368662;37332.2533549322;37700;38292;36075.639243608275;36287;36315.45526817047;36325.45511817378;36447.81776091103;35422;35479.467807982386;35650.64349356577;35978.28043439064;36356.636433636384;30892.382152357277;33360.83319583387;33445.49831752477;33469.16327091842;33476.665233347354;25228.369290767143;25616;25642.23073307804;25808.483830323665;26083.347916302246 10:17:53 INFO - PROCESS | 17765 | |2;jquery.html;351.15021647612775;361.24860290595564;362.78051778673904;370.9369407200776;380.1750202061526;15789.447369342075;16740.49778506645;17250.223739931702;17404.56488587786;17422.47732568025;15149.318280677368;15605.297761600727;15627.374905003815;15687.137207453585;15793.210339483037;5071.568916642081;5215.921761173586;5217.973910130444;5247.658902171365;5255.08036093682;3716.9442458363146;5180.093483640367;5226.05930932432;5681.318241810968;5951.553633477485;6019.428154325332;6043.486303664172;6054.697265136748;6055.909161362583;6058.515318774509;5001.799928002875;5265.8946821063555;5290.682559046431;5359.303290572239;6006.819795406123;5068.746562671889;5149.356330458692;5175.249588809602;5196.714180720059;5239.371275446971;12319.322437265946;12424;16900.830991690047;19970;20469.18123275067;1902.8192321729414;1967.645823751724;2020.8585399022074;2107.79975902289;2426.599611064172;9207;9207.98712141664;9298.442093474345;9302.534873256378;9385.15533601979;1709.265016043101;1731.8008429030697;1764.5853224492234;1765.3556451894965;1784.295203394652;60511.69744151295;66188.3381166187;66619.66690166567;67228;69487.3051269491;9569.28230382724;9661.903380966241;9943;9971.850422243671;10277.9486102569;13492.797608035888;13545.1195672281;13575;13619.250941198132;13673.863261367458;6910.481713871379;6978.825529361807;7056.54132481387;7166.211716711157;7352;6608.306127856602;6729.932700673028;6793.490488213404;6806.965965170142;6940.583564986016;4202.810873510699;4297.978510107492;4308.332208507686;4316.805743741539;4404.691671582958;1650.339864054364;1670.590705277215;1744.5115367697065;1780.9554761131076;1854.6290741851683;834.5326617094447;847.2374862623565;871.8997315308694;884.7655371326475;908.3596064774318;16069.919650401907;16749.24628391725;17335.27850666442;17525;17650.823491764917;861.8621020636668;878.2227728460358;900.1898291537668;905.307439808547;934.3926447808842;9489.762755931019;9817.460039697742;9829.754256143653;9913.950430247802;9997.80004399908;405444;410357;432218;433450;434433;64128.358716413175;74401;75062.62468687621;76856.61571692106;79042.20957790464;855.3677785130883;885;902.0438335364535;907.6006557114848;909.713440266314;15154.545363639108;15369;15842.68314633724;15910.363585456453;15983.760243596587;33833;35936.58602432765;36154.66144062729;36989.445158323186;38616.42075368928;48017;52220.73889630527;53306.73346633242;54080;54552;7187.8562428752175;7441.4418918582405;7597.3162415382885;7639.236076392316;7741.6839137347915;10739.677809665722;12469.75060498803;12557.372131393577;12751.107422480338;12921.418536166084;9999.400035997864;10181.490925453845;10327.535260913126;10628.468576571295;10803.081738052353;10761.730956726144;10811.13510919109;10876.836847447454;10888.727781805519;11098.833517497082;9917.504124793588;10332.328398654063;10332.948335258276;10891.346519208873;10936.890631093587;7387.4459415545125;7458.582869254824;7504.174540800616;7537.54774713497;7871.881921771063;7618.69525218985;9839.655612053544;9938.10557049869;10645.733856653645;10842.945785271339 10:17:53 INFO - PROCESS | 17765 | |3;mootools.html;1338.437856100438;1392.937317820698;1461.802656641353;1684.9805867450184;1716.5107944235888;6483.222013358391;7298.416126709857;7397.889031664529;7881.527108373494;7886.369090472763;7484.738034168805;7734.265244801735;7747.883781743264;7750.418718596114;7778.183290754474;2138.1340557074373;2155.3103007037753;2165.65349544073;2179.923702670407;2182.9890850545803;2119.565489074736;2144.8391370647264;2161.859479133859;2167;2171.381156370435;2148.130007347027;2169.240765731997;2170.934871953844;2189.397915573214;2194.4952660888007;2107.799759022898;2131.3392848217027;2138.550904310097;2143.399848042535;2146.720926279589;2097;2119.682047692843;2135.711678923341;2143.0784762552253;2144.345974477784;7608.657610407489;7632.389408847279;7639.618019099078;7648.961755191244;7673.232676732282;4366.192254432908;4436.64506839452;4454.621357184643;4460.598546130864;4484.551544845522;2793.455276221138;2838.545832666784;2848.700886406918;2850.50116229659;2851.458222937635;919.6551293265026;953.912430640342;973.474323865112;976.4385478349906;978.7455261631956;9814.46020468874;9821.950890245504;9823.803523929482;9831.459269740162;9869.11177993984;3936.724429289922;4019.8392064317686;4184.456020717348;4248.915021699549;4266.850660226877;8587.527685977206;8590.82818343642;8604.354673399395;8609.870851937227;8626.913730862736;4522.977385113053;4530.886727831765;4533.387992620954;4537.659675524283;4553.567411095941;3391.067456449496;4108.8356465741035;4155.189738001121;4159.376093585925;4223.873283801491;3511.2626348466597;3579.570451545779;3628.727845411605;3655.5247817784048;3691.7600355976774;1171.3323405658864;1181.9940900295444;1193.7075416522835;1202.0263586494966;1204.7831390349645;814.6659869453496;839.3243439031638;851.2338894994431;853.9573021348908;873.2315562305258;5000.649954503223;5281.313429254173;5387.299651045418;5460.754266058037;5518.944810551843;407.8164825828389;414.40581956949114;420.49540551337907;421.77856625271977;424.3083773449258;3692.132348898007;3789.981050094732;3840.423936409561;3864.652181303696;3875.476810630585;9065.59204835784;9511.239100871913;9524.8571271431;9551.617935282511;9555.9044409555;9416.764580885396;9442.90557094434;9448;9478.194353479894;9528.809423811485;7038.92961070393;7056.964715176391;7072.681729322193;7115.395191408685;7134.750283740148;5275.815346462856;5332.920006199987;5443.319585051869;5487.4238204987905;5603.55171586264;8355.707550235713;8670.869936951078;8671.872656554608;8846.115388461103;8869.600867961086;8593.355498337774;8918.286537077149;8918.509481978554;8928.15182557656;9046.683366082156;5888.499477544457;6241.063840423973;6357.3006969234275;6592.143021407378;6771.492138089761;7036.718531258897;7092.61693969671;7108.431325494052;7112.644367781693;7142.107236595426;6175.722092505758;6195.287541932736;6220.72006759706;6227.252729672468;6445.548811583144;6175.197224360804;6176.66028368444;6196;6198.1012753149635;6205.596636218631;5708.315002199763;5826.067829147316;5836.824895253149;5842.620229685057;5848.122781582797;4056.634902858757;4082.7142100053898;4116.5060192777055;4121.752694838319;4239.745615263094;4313.590208930146;4321.827126915014;4331.263685173465;4431.977840110779;4508 10:17:53 INFO - PROCESS | 17765 | |4;prototype.html;285.7456863391581;286.15726684912926;287.4638798640536;287.8244270994692;292.36556672021715;4948.480409556999;4979.427365852928;5003.498950314909;5036.445990940998;5080.390353157622;4944.851654450372;4962.627802914778;4962.975185124069;4992.850214493571;5017.068428654967;3618.7828730276137;3785.71607129465;3880.9611903881023;3905.33609286422;3931.2727145478034;3865.4974853269036;3872.283627528916;3880.417937309412;3886.6307700768525;3915.9426954722207;3891.6692081173132;3896.27918835015;3902.4731661225655;3906.824192911326;3909.1009067914397;3745.3258413485833;3883.0874744435037;3905.1018265798743;3910.983144382467;3917.3144699677587;3354.698077173042;3367.696907278332;3374.780639258465;3383.6954674079207;3387.458006718913;4781.521847815226;4830.492798256203;4834.178189707758;4845.491223421525;4861.197902346144;4425.2477078896345;4436.290193569013;4454.483216982395;4455.059660623972;4470.508244093147;5017.774200161001;5159;5197.66215196011;5213.530782229617;5251.4485978972425;3674.173311005029;3674.650908163747;3677.1358730698266;3690.0959264979983;3690.852365905361;5434.456554344573;5456.345238571357;5463.2244520530585;5479.287692599976;5492.231087647732;3702.61122582125;3760.4547340636;3802.2205447883116;3811.085339518551;3812.504374431306;3840.2703486338064;3842.423636454498;3847.6537111659527;3856.190200057963;3859.710521710883;4419.248727716232;4421.712588681726;4427.468703755506;4434.290513517822;4453.1316393303;5038.2190760432195;5275.419703832576;5293.629445938825;5297.337832770903;5304.575633949275;1308.1366298243113;1323.973520529584;1329.7606430842347;1333.4399552188104;1336.1982810313928;805.6253841963515;838.4153949036327;839.9370047246481;840.1724301562956;847.4533925618065;4058.289799285113;4072.3687828386646;4405.867823965286;4524.9863810603965;4654.511276316006;5443.863903402367;5448.863778405493;5460.781568737286;5463.48096930791;5483.7806487740845;4648.651351148677;4649.976750116228;4652.325412815123;4654.371659825948;4701.2242979908615;2791.720827917233;2837.957430638542;2840.5881147233536;2850.330172409482;2850.558163484663;5050.873728156826;5069.44236134025;5079.314292570456;5096.719680417613;5106.821261255913;5417.160340147283;5514.172874068841;5516.448355164532;5565.193047008162;5568.575326174374;5007.824726134568;5024.497550244946;5065.645404821627;5067.341245638191;5082.966813274646;5342.8931421372135;5370.570354371719;5374.973125134349;5378;5395.3525576931015;5114.207297868837;5276.234945932895;5287.180487024363;5297.602679798953;5310.336207974004;5058.342415485963;5065.4174769900455;5070.569001634903;5085.779412940941;5091.821786237464;3765.623437656322;3774.943015955537;3795.392737162151;3810.561785394715;3817.751846129993;5269.446708095748;5315.681059136464;5421.213923980922;5432.022235997559;5493.670379777226;5180.678926873623;5191.195364718475;5203.777112378512;5219.76511057011;5221.503957124219;5206.557442617269;5237.188235823453;5237.528622424;5240.895182096413;5277.20841873722;4986.326845875906;5098.6752909972165;5106.540411362995;5183.9414745300455;5237.764300606558;4980.825671101494;5245.197232006764;5247.775540689781;5262.736943133544;5269.077911365573;4969.180085285887;5140.3831540215415;5147.16905701855;5173.870653233549;5184.896302074013 10:17:53 INFO - PROCESS | 17765 | |5;yui.html;619.8698273362594;637.5600835423558;667.3628723457157;678.2132726037797;718.5114122396768;12343.444544995475;12476.688082797935;12502.81245781314;12551.12142150051;13507.527236546723;13541.390637421315;13674.111182773138;13714.794278085838;13740.312984350792;13753.862461375384;618.3352895637186;764.7399884039426;785.5247575216997;786.996065019677;787.322902304018;768.4083255892959;803.1085495100434;807.8747794091926;807.8868958345836;809.2150613904532;828.0436096308742;833.4499230507867;834.5493433545878;836.6318819719335;838.9790255243637;838.8573942429801;841.381584535369;841.970531031414;842.8651415773447;845.1041895590632;611.9388061193889;614.671150934248;615.4460985113434;615.5598746895946;616.8087892753216;13626.591202263948;13677.384517696728;13679.110857794212;13685.521006764815;13712.65718357039;13377.53178638743;13609.863901360959;14081;14240.857591424057;14254.928725356307;10711.196660250434;10737.570497180104;10769.569217231301;10781.353118812896;10841.512131954081;3313.6023677158655;3330.600327960636;3391.2708767614836;3409.3692666856464;3416.7779094359034;65989.3401065988;66508.66745666241;66538.66730666364;67745.32254677439;68380.6580967092;10495.317804342692;10609.162912875352;10697.946510267398;10973.286736362112;10990.285631433931;20109.09509072095;20131.094100765502;20165.09257083435;20201.393958180983;20269.797302027087;6885.827854303582;6957.095577574883;7084.539504932266;7095.9290407096305;7149.9285007149265;3537.363274610595;3680.9263814723554;3754.5869954305003;3765;3860.007739861262;2812.2406950123354;2930.7801914856473;2934.3544420227518;2956.793024488265;2969.0944261999866;499.7451299837109;507.4114027727818;507.5406756885025;516.1689679615815;518.2356024863296;508.379776672459;518.7276679743165;520.3885434614313;570.2985328046526;604.5798170271619;8614.87077693835;8725.258353039935;8784.912150878537;9020.729378118667;9136.81726365469;504.4274748160864;555.9353837401412;589.5195415736162;631.1321932343028;646.424682032991;3749;4301.698881078357;4344.652427805831;4350.934735978963;4367.847125350598;53189;53914.19128713072;73558.26441735514;101799;107111.46444267729;82854.17145828465;83011;87137.56431217803;87273.56363218144;87584;73624;77329.61335193401;78448.607756962;79911.60044199742;80809.59595202105;7656.846863062819;7830.647620856961;7902.209779022051;8009.559474228973;8271.51001986992;43869;43957.56042439662;44199.558004419545;44643;45675.771621141685;64507.677461612395;68328;69169.65415172892;69221;70808;10524.579016839547;10554.630587929692;10575.15398768112;10577.471126443801;11013.118950483782;11354.091672666002;11474.77050459003;11647;11647.941760291144;11740.589079382522;11176.497057632589;11201.887981120084;11384.37385943781;11416.029637480908;11749.353785541878;10995.395253261147;11028.172887033345;11109.888901110886;11150.888491114985;11492.712682183012;10971.945140274567;11111.111111111253;11261.549538018387;11357.829632555684;11554.248973816675;9246.214071803703;9447.24422046221;9627.422354658744;9759.951200243953;9769.267304952014;9305.488198149167;9517.286203534624;9733.909257128234;9787.16809071237;9952.850707239253 10:17:53 INFO - PROCESS | 17765 | __end_tp_report 10:17:53 INFO - PROCESS | 17765 | __start_cc_report 10:17:53 INFO - PROCESS | 17765 | _x_x_mozilla_cycle_collect,399 10:17:53 INFO - PROCESS | 17765 | __end_cc_report 10:17:53 INFO - PROCESS | 17765 | __startTimestamp1471022273866__endTimestamp 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | ------- Summary: start ------- 10:17:53 INFO - PROCESS | 17765 | Number of tests: 6 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | [#0] dojo.html Cycles:165 Average:4714.21 Median:4860.95 stddev:615.89 (12.7%) stddev-sans-first:595.91 10:17:53 INFO - PROCESS | 17765 | Values: 2640.7 2666.4 2689.2 2690.1 2715.4 4565.0 4754.5 4797.8 4817.5 4838.9 4611.4 4661.7 4671.5 4676.2 4678.0 4361.7 4399.4 4408.9 4426.0 4443.5 4386.6 4405.0 4413.9 4448.3 4465.1 129.6 4362.8 4431.6 4435.5 4472.3 4336.5 4345.8 4348.1 4394.4 4405.7 4317.3 4356.0 4370.4 4388.2 4424.4 4741.5 4742.1 4745.4 4749.5 4834.1 5153.0 5163.0 5168.0 5181.9 5216.6 5152.9 5205.8 5207.1 5208.5 5216.1 4607.9 4725.9 4733.6 4762.8 4807.0 5245.6 5253.2 5261.1 5266.2 5272.1 5038.2 5043.7 5044.3 5066.2 5087.5 5003.6 5089.2 5095.8 5116.3 5155.1 5109.9 5122.3 5129.0 5130.5 5145.1 5083.3 5113.0 5113.2 5123.7 5161.3 4136.5 4288.1 4322.5 4330.2 4384.6 3789.6 3798.5 3799.9 3834.4 3854.0 4474.0 4485.5 4487.4 4504.9 4529.8 5011.3 5103.8 5127.9 5161.3 5238.1 4477.1 4479.3 4486.1 4493.8 4546.2 4612.1 4612.5 4629.6 4633.1 4634.0 4631.1 4797.6 4893.3 4898.3 4909.1 5121.4 5159.1 5162.7 5166.1 5184.1 4818.2 4857.3 4861.0 4862.9 4915.5 4814.3 4990.2 5039.4 5081.1 5124.2 5162.2 5168.6 5173.2 5175.3 5185.8 5034.4 5037.7 5041.4 5042.7 5065.7 4844.5 4976.0 4983.4 5012.1 5105.7 4935.9 4962.4 4976.2 4978.0 4982.1 5080.3 5080.6 5081.8 5082.9 5086.4 4709.5 4867.8 4879.6 4890.6 4945.8 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | [#1] ext.html Cycles:180 Average:46511.48 Median:35949.14 stddev:86306.94 (240.1%) stddev-sans-first:86480.07 10:17:53 INFO - PROCESS | 17765 | Values: 551.9 557.4 564.3 569.3 583.1 35174.6 40067.6 40138.8 40191.4 40249.0 39802.2 40039.4 40337.6 40483.6 40576.6 7473.3 7566.1 7573.3 7613.5 7625.7 7720.3 7774.6 7783.3 7797.1 7809.1 7785.1 7800.6 7808.5 7810.6 7815.8 7648.9 7761.1 7770.3 7778.0 7785.3 7659.4 7684.3 7728.2 7766.3 7771.9 35920.0 36129.8 36217.8 36247.6 36301.0 3093.8 3205.2 3368.7 3370.3 3571.3 27466.9 29045.6 29390.7 29411.1 29443.7 3286.7 3361.4 3435.9 3440.3 3455.1 258733.0 259340.0 259462.0 260949.0 260956.0 30913.0 32254.0 32269.8 51318.5 51764.5 33000.0 33594.8 33618.3 33668.8 33788.2 13711.0 13852.9 13883.3 13957.9 13963.5 11506.9 11512.9 11520.1 11561.9 11651.9 7765.9 7815.6 7831.1 7889.4 7912.7 3068.9 3069.1 3115.7 3134.3 3158.7 868.0 870.4 902.2 953.2 954.9 27954.7 28166.3 28725.1 29097.6 29117.4 913.8 951.6 1001.0 1004.9 1005.2 14438.4 15267.4 15354.5 15419.2 15618.1 377437.0 382090.0 382568.0 382877.0 383013.0 50188.0 50311.2 50870.0 50894.5 50952.2 1133.8 1165.6 1166.2 1178.2 1179.3 26681.9 27883.6 28237.6 28358.1 28825.0 42687.7 42824.8 42841.6 43228.8 43380.0 325533.0 329152.0 329588.0 329951.0 330218.0 25271.7 25414.7 25553.7 25606.6 25785.5 41245.0 41433.0 41879.8 42002.0 42901.4 36745.3 36869.6 37332.3 37700.0 38292.0 36075.6 36287.0 36315.5 36325.5 36447.8 35422.0 35479.5 35650.6 35978.3 36356.6 30892.4 33360.8 33445.5 33469.2 33476.7 25228.4 25616.0 25642.2 25808.5 26083.3 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | [#2] jquery.html Cycles:180 Average:24961.98 Median:5110.46 stddev:69620.44 (1362.3%) stddev-sans-first:69791.22 10:17:53 INFO - PROCESS | 17765 | Values: 351.2 361.2 362.8 370.9 380.2 15789.4 16740.5 17250.2 17404.6 17422.5 15149.3 15605.3 15627.4 15687.1 15793.2 5071.6 5215.9 5218.0 5247.7 5255.1 3716.9 5180.1 5226.1 5681.3 5951.6 6019.4 6043.5 6054.7 6055.9 6058.5 5001.8 5265.9 5290.7 5359.3 6006.8 5068.7 5149.4 5175.2 5196.7 5239.4 12319.3 12424.0 16900.8 19970.0 20469.2 1902.8 1967.6 2020.9 2107.8 2426.6 9207.0 9208.0 9298.4 9302.5 9385.2 1709.3 1731.8 1764.6 1765.4 1784.3 60511.7 66188.3 66619.7 67228.0 69487.3 9569.3 9661.9 9943.0 9971.9 10277.9 13492.8 13545.1 13575.0 13619.3 13673.9 6910.5 6978.8 7056.5 7166.2 7352.0 6608.3 6729.9 6793.5 6807.0 6940.6 4202.8 4298.0 4308.3 4316.8 4404.7 1650.3 1670.6 1744.5 1781.0 1854.6 834.5 847.2 871.9 884.8 908.4 16069.9 16749.2 17335.3 17525.0 17650.8 861.9 878.2 900.2 905.3 934.4 9489.8 9817.5 9829.8 9914.0 9997.8 405444.0 410357.0 432218.0 433450.0 434433.0 64128.4 74401.0 75062.6 76856.6 79042.2 855.4 885.0 902.0 907.6 909.7 15154.5 15369.0 15842.7 15910.4 15983.8 33833.0 35936.6 36154.7 36989.4 38616.4 48017.0 52220.7 53306.7 54080.0 54552.0 7187.9 7441.4 7597.3 7639.2 7741.7 10739.7 12469.8 12557.4 12751.1 12921.4 9999.4 10181.5 10327.5 10628.5 10803.1 10761.7 10811.1 10876.8 10888.7 11098.8 9917.5 10332.3 10332.9 10891.3 10936.9 7387.4 7458.6 7504.2 7537.5 7871.9 7618.7 9839.7 9938.1 10645.7 10842.9 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | [#3] mootools.html Cycles:180 Average:4965.84 Median:5452.04 stddev:2761.49 (50.7%) stddev-sans-first:2755.78 10:17:53 INFO - PROCESS | 17765 | Values: 1338.4 1392.9 1461.8 1685.0 1716.5 6483.2 7298.4 7397.9 7881.5 7886.4 7484.7 7734.3 7747.9 7750.4 7778.2 2138.1 2155.3 2165.7 2179.9 2183.0 2119.6 2144.8 2161.9 2167.0 2171.4 2148.1 2169.2 2170.9 2189.4 2194.5 2107.8 2131.3 2138.6 2143.4 2146.7 2097.0 2119.7 2135.7 2143.1 2144.3 7608.7 7632.4 7639.6 7649.0 7673.2 4366.2 4436.6 4454.6 4460.6 4484.6 2793.5 2838.5 2848.7 2850.5 2851.5 919.7 953.9 973.5 976.4 978.7 9814.5 9822.0 9823.8 9831.5 9869.1 3936.7 4019.8 4184.5 4248.9 4266.9 8587.5 8590.8 8604.4 8609.9 8626.9 4523.0 4530.9 4533.4 4537.7 4553.6 3391.1 4108.8 4155.2 4159.4 4223.9 3511.3 3579.6 3628.7 3655.5 3691.8 1171.3 1182.0 1193.7 1202.0 1204.8 814.7 839.3 851.2 854.0 873.2 5000.6 5281.3 5387.3 5460.8 5518.9 407.8 414.4 420.5 421.8 424.3 3692.1 3790.0 3840.4 3864.7 3875.5 9065.6 9511.2 9524.9 9551.6 9555.9 9416.8 9442.9 9448.0 9478.2 9528.8 7038.9 7057.0 7072.7 7115.4 7134.8 5275.8 5332.9 5443.3 5487.4 5603.6 8355.7 8670.9 8671.9 8846.1 8869.6 8593.4 8918.3 8918.5 8928.2 9046.7 5888.5 6241.1 6357.3 6592.1 6771.5 7036.7 7092.6 7108.4 7112.6 7142.1 6175.7 6195.3 6220.7 6227.3 6445.5 6175.2 6176.7 6196.0 6198.1 6205.6 5708.3 5826.1 5836.8 5842.6 5848.1 4056.6 4082.7 4116.5 4121.8 4239.7 4313.6 4321.8 4331.3 4432.0 4508.0 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | [#4] prototype.html Cycles:180 Average:4330.62 Median:4980.13 stddev:1273.31 (25.6%) stddev-sans-first:1240.16 10:17:53 INFO - PROCESS | 17765 | Values: 285.7 286.2 287.5 287.8 292.4 4948.5 4979.4 5003.5 5036.4 5080.4 4944.9 4962.6 4963.0 4992.9 5017.1 3618.8 3785.7 3881.0 3905.3 3931.3 3865.5 3872.3 3880.4 3886.6 3915.9 3891.7 3896.3 3902.5 3906.8 3909.1 3745.3 3883.1 3905.1 3911.0 3917.3 3354.7 3367.7 3374.8 3383.7 3387.5 4781.5 4830.5 4834.2 4845.5 4861.2 4425.2 4436.3 4454.5 4455.1 4470.5 5017.8 5159.0 5197.7 5213.5 5251.4 3674.2 3674.7 3677.1 3690.1 3690.9 5434.5 5456.3 5463.2 5479.3 5492.2 3702.6 3760.5 3802.2 3811.1 3812.5 3840.3 3842.4 3847.7 3856.2 3859.7 4419.2 4421.7 4427.5 4434.3 4453.1 5038.2 5275.4 5293.6 5297.3 5304.6 1308.1 1324.0 1329.8 1333.4 1336.2 805.6 838.4 839.9 840.2 847.5 4058.3 4072.4 4405.9 4525.0 4654.5 5443.9 5448.9 5460.8 5463.5 5483.8 4648.7 4650.0 4652.3 4654.4 4701.2 2791.7 2838.0 2840.6 2850.3 2850.6 5050.9 5069.4 5079.3 5096.7 5106.8 5417.2 5514.2 5516.4 5565.2 5568.6 5007.8 5024.5 5065.6 5067.3 5083.0 5342.9 5370.6 5375.0 5378.0 5395.4 5114.2 5276.2 5287.2 5297.6 5310.3 5058.3 5065.4 5070.6 5085.8 5091.8 3765.6 3774.9 3795.4 3810.6 3817.8 5269.4 5315.7 5421.2 5432.0 5493.7 5180.7 5191.2 5203.8 5219.8 5221.5 5206.6 5237.2 5237.5 5240.9 5277.2 4986.3 5098.7 5106.5 5183.9 5237.8 4980.8 5245.2 5247.8 5262.7 5269.1 4969.2 5140.4 5147.2 5173.9 5184.9 10:17:53 INFO - PROCESS | 17765 | 10:17:53 INFO - PROCESS | 17765 | [#5] yui.html Cycles:180 Average:17680.95 Median:507.96 stddev:24984.55 (4918.6%) stddev-sans-first:25021.80 10:17:53 INFO - PROCESS | 17765 | Values: 619.9 637.6 667.4 678.2 718.5 12343.4 12476.7 12502.8 12551.1 13507.5 13541.4 13674.1 13714.8 13740.3 13753.9 618.3 764.7 785.5 787.0 787.3 768.4 803.1 807.9 807.9 809.2 828.0 833.4 834.5 836.6 839.0 838.9 841.4 842.0 842.9 845.1 611.9 614.7 615.4 615.6 616.8 13626.6 13677.4 13679.1 13685.5 13712.7 13377.5 13609.9 14081.0 14240.9 14254.9 10711.2 10737.6 10769.6 10781.4 10841.5 3313.6 3330.6 3391.3 3409.4 3416.8 65989.3 66508.7 66538.7 67745.3 68380.7 10495.3 10609.2 10697.9 10973.3 10990.3 20109.1 20131.1 20165.1 20201.4 20269.8 6885.8 6957.1 7084.5 7095.9 7149.9 3537.4 3680.9 3754.6 3765.0 3860.0 2812.2 2930.8 2934.4 2956.8 2969.1 499.7 507.4 507.5 516.2 518.2 508.4 518.7 520.4 570.3 604.6 8614.9 8725.3 8784.9 9020.7 9136.8 504.4 555.9 589.5 631.1 646.4 3749.0 4301.7 4344.7 4350.9 4367.8 53189.0 53914.2 73558.3 101799.0 107111.5 82854.2 83011.0 87137.6 87273.6 87584.0 73624.0 77329.6 78448.6 79911.6 80809.6 7656.8 7830.6 7902.2 8009.6 8271.5 43869.0 43957.6 44199.6 44643.0 45675.8 64507.7 68328.0 69169.7 69221.0 70808.0 10524.6 10554.6 10575.2 10577.5 11013.1 11354.1 11474.8 11647.0 11647.9 11740.6 11176.5 11201.9 11384.4 11416.0 11749.4 10995.4 11028.2 11109.9 11150.9 11492.7 10971.9 11111.1 11261.5 11357.8 11554.2 9246.2 9447.2 9627.4 9760.0 9769.3 9305.5 9517.3 9733.9 9787.2 9952.9 10:17:53 INFO - PROCESS | 17765 | -------- Summary: end -------- 10:17:53 INFO - PROCESS | 17765 | 10:17:54 INFO - TEST-INFO | 17765: exit 0 10:17:54 INFO - TEST-OK | dromaeo_css | took 1115639ms 10:17:54 INFO - TEST-START | kraken 10:17:54 INFO - operating with platform_type : linux_ 10:17:54 INFO - Initialising browser for kraken test... 10:17:54 INFO - TEST-INFO | started process 18123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZnZyTS/profile http://localhost:44592/getInfo.html) 10:17:59 INFO - PROCESS | 18123 | __metrics Screen width/height:1600/1200 10:17:59 INFO - PROCESS | 18123 | colorDepth:24 10:17:59 INFO - PROCESS | 18123 | Browser inner width/height: 1024/697 10:17:59 INFO - PROCESS | 18123 | __metrics 10:17:59 ERROR - PROCESS | 18123 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 10:18:00 INFO - TEST-INFO | 18123: exit 0 10:18:00 INFO - Browser initialized. 10:18:00 INFO - Running cycle 1/1 for kraken test... 10:18:00 INFO - TEST-INFO | started process 18242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZnZyTS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:12 INFO - PROCESS | 18242 | RSS: Main: 163422208 10:18:12 INFO - PROCESS | 18242 | 10:18:15 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44592/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:16 INFO - PROCESS | 18242 | RSS: Main: 168771584 10:18:16 INFO - PROCESS | 18242 | 10:18:18 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44592/tests/kraken/driver.html?testName=audio-dft) 10:18:19 INFO - PROCESS | 18242 | RSS: Main: 167698432 10:18:19 INFO - PROCESS | 18242 | 10:18:22 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44592/tests/kraken/driver.html?testName=audio-fft) 10:18:23 INFO - PROCESS | 18242 | RSS: Main: 164093952 10:18:23 INFO - PROCESS | 18242 | 10:18:25 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44592/tests/kraken/driver.html?testName=audio-oscillator) 10:18:25 INFO - PROCESS | 18242 | RSS: Main: 164798464 10:18:25 INFO - PROCESS | 18242 | 10:18:28 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44592/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:28 INFO - PROCESS | 18242 | RSS: Main: 165302272 10:18:28 INFO - PROCESS | 18242 | 10:18:32 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44592/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:32 INFO - PROCESS | 18242 | RSS: Main: 165376000 10:18:32 INFO - PROCESS | 18242 | 10:18:36 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44592/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:36 INFO - PROCESS | 18242 | RSS: Main: 162283520 10:18:36 INFO - PROCESS | 18242 | 10:18:39 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44592/tests/kraken/driver.html?testName=json-parse-financial) 10:18:40 INFO - PROCESS | 18242 | RSS: Main: 164089856 10:18:40 INFO - PROCESS | 18242 | 10:18:42 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44592/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:42 INFO - PROCESS | 18242 | RSS: Main: 164429824 10:18:42 INFO - PROCESS | 18242 | 10:18:44 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:45 INFO - PROCESS | 18242 | RSS: Main: 164474880 10:18:45 INFO - PROCESS | 18242 | 10:18:47 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:48 INFO - PROCESS | 18242 | RSS: Main: 164929536 10:18:48 INFO - PROCESS | 18242 | 10:18:51 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:51 INFO - PROCESS | 18242 | RSS: Main: 165462016 10:18:51 INFO - PROCESS | 18242 | 10:18:54 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:55 INFO - PROCESS | 18242 | RSS: Main: 165203968 10:18:55 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | Cycle 1(1): loaded http://localhost:44592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44592/tests/kraken/driver.html?testName=ai-astar) 10:18:57 INFO - PROCESS | 18242 | RSS: Main: 165875712 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | __start_tp_report 10:18:57 INFO - PROCESS | 18242 | _x_x_mozilla_page_load 10:18:57 INFO - PROCESS | 18242 | _x_x_mozilla_page_load_details 10:18:57 INFO - PROCESS | 18242 | |i|pagename|runs| 10:18:57 INFO - PROCESS | 18242 | |0;ai-astar;106;116;109;119;116;116;117;116;117;115 10:18:57 INFO - PROCESS | 18242 | |1;audio-beat-detection;146;122;145;201;123;157;152;123;189;124 10:18:57 INFO - PROCESS | 18242 | |2;audio-dft;165;163;165;171;164;165;163;163;162;162 10:18:57 INFO - PROCESS | 18242 | |3;audio-fft;75;83;83;167;77;77;77;76;161;78 10:18:57 INFO - PROCESS | 18242 | |4;audio-oscillator;86;86;154;86;86;87;142;86;88;138 10:18:57 INFO - PROCESS | 18242 | |5;imaging-gaussian-blur;117;118;118;118;118;119;119;119;119;118 10:18:57 INFO - PROCESS | 18242 | |6;imaging-darkroom;148;148;148;148;149;148;147;148;148;148 10:18:57 INFO - PROCESS | 18242 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;96;96 10:18:57 INFO - PROCESS | 18242 | |8;json-parse-financial;65;65;64;65;65;63;63;65;65;66 10:18:57 INFO - PROCESS | 18242 | |9;json-stringify-tinderbox;66;66;66;66;67;65;66;69;67;66 10:18:57 INFO - PROCESS | 18242 | |10;stanford-crypto-aes;81;84;82;81;82;81;81;80;85;81 10:18:57 INFO - PROCESS | 18242 | |11;stanford-crypto-ccm;138;152;133;135;134;144;135;140;157;139 10:18:57 INFO - PROCESS | 18242 | |12;stanford-crypto-pbkdf2;168;175;172;169;173;170;173;170;171;171 10:18:57 INFO - PROCESS | 18242 | |13;stanford-crypto-sha256-iterative;71;71;69;68;69;68;70;67;73;69 10:18:57 INFO - PROCESS | 18242 | __end_tp_report 10:18:57 INFO - PROCESS | 18242 | __start_cc_report 10:18:57 INFO - PROCESS | 18242 | _x_x_mozilla_cycle_collect,934 10:18:57 INFO - PROCESS | 18242 | __end_cc_report 10:18:57 INFO - PROCESS | 18242 | __startTimestamp1471022337334__endTimestamp 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | ------- Summary: start ------- 10:18:57 INFO - PROCESS | 18242 | Number of tests: 14 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#0] ai-astar Cycles:10 Average:114.70 Median:116.00 stddev:4.00 (3.4%) stddev-sans-first:2.74 10:18:57 INFO - PROCESS | 18242 | Values: 106.0 116.0 109.0 119.0 116.0 116.0 117.0 116.0 117.0 115.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:149.00 stddev:28.09 (18.9%) stddev-sans-first:29.78 10:18:57 INFO - PROCESS | 18242 | Values: 146.0 122.0 145.0 201.0 123.0 157.0 152.0 123.0 189.0 124.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.63 (1.6%) stddev-sans-first:2.77 10:18:57 INFO - PROCESS | 18242 | Values: 165.0 163.0 165.0 171.0 164.0 165.0 163.0 163.0 162.0 162.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#3] audio-fft Cycles:10 Average:95.40 Median:77.00 stddev:36.28 (47.1%) stddev-sans-first:37.73 10:18:57 INFO - PROCESS | 18242 | Values: 75.0 83.0 83.0 167.0 77.0 77.0 77.0 76.0 161.0 78.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:86.00 stddev:28.41 (33.0%) stddev-sans-first:29.39 10:18:57 INFO - PROCESS | 18242 | Values: 86.0 86.0 154.0 86.0 86.0 87.0 142.0 86.0 88.0 138.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 10:18:57 INFO - PROCESS | 18242 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 119.0 119.0 119.0 118.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 10:18:57 INFO - PROCESS | 18242 | Values: 148.0 148.0 148.0 148.0 149.0 148.0 147.0 148.0 148.0 148.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:18:57 INFO - PROCESS | 18242 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 10:18:57 INFO - PROCESS | 18242 | Values: 65.0 65.0 64.0 65.0 65.0 63.0 63.0 65.0 65.0 66.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 10:18:57 INFO - PROCESS | 18242 | Values: 66.0 66.0 66.0 66.0 67.0 65.0 66.0 69.0 67.0 66.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:1.55 (1.9%) stddev-sans-first:1.62 10:18:57 INFO - PROCESS | 18242 | Values: 81.0 84.0 82.0 81.0 82.0 81.0 81.0 80.0 85.0 81.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.50 stddev:8.06 (5.8%) stddev-sans-first:8.49 10:18:57 INFO - PROCESS | 18242 | Values: 138.0 152.0 133.0 135.0 134.0 144.0 135.0 140.0 157.0 139.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:2.10 (1.2%) stddev-sans-first:1.88 10:18:57 INFO - PROCESS | 18242 | Values: 168.0 175.0 172.0 169.0 173.0 170.0 173.0 170.0 171.0 171.0 10:18:57 INFO - PROCESS | 18242 | 10:18:57 INFO - PROCESS | 18242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.78 (2.6%) stddev-sans-first:1.80 10:18:57 INFO - PROCESS | 18242 | Values: 71.0 71.0 69.0 68.0 69.0 68.0 70.0 67.0 73.0 69.0 10:18:57 INFO - PROCESS | 18242 | -------- Summary: end -------- 10:18:57 INFO - PROCESS | 18242 | 10:18:58 INFO - TEST-INFO | 18242: exit 0 10:18:58 INFO - TEST-OK | kraken | took 63751ms 10:18:58 INFO - SUITE-END | took 1179s 10:18:58 INFO - Completed test suite (00:19:39) 10:18:58 INFO - javascript benchmark 10:18:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6328.194660478109, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.709521952585, 2666.41338905441, 2689.193242027391, 2690.058479532164, 2715.389037466569, 4564.9543504564945, 4754.548317909797, 4797.784099715513, 4817.542333478314, 4838.9032219355595, 4611.446626404828, 4661.65037622178, 4671.4627817800965, 4676.181668208067, 4678.0, 4361.71648842825, 4399.384086227915, 4408.911821763563, 4426.0, 4443.533428989958, 4386.561343865604, 4405.0, 4413.867583972486, 4448.266036104039, 4465.129299786543, 129.61098519227568, 4362.847300344472, 4431.601155895953, 4435.467743870756, 4472.284434490482, 4336.479622445327, 4345.84789532368, 4348.108637729258, 4394.362817391492, 4405.735655860659, 4317.266064768965, 4355.956440435587, 4370.38814565961, 4388.166248412823, 4424.446944131983, 4741.5495527924795, 4742.1227072991605, 4745.3593764842, 4749.548792864673, 4834.105690447279, 5153.0, 5163.0, 5168.043911876315, 5181.922271165936, 5216.60875434344, 5152.871178220575, 5205.843824685266, 5207.140821764404, 5208.5051920067535, 5216.061109000379, 4607.9308810367875, 4725.929111063337, 4733.5503127202865, 4762.78567464465, 4806.975965120152, 5245.580353571705, 5253.185756207794, 5261.0793111205385, 5266.21006848968, 5272.103742363807, 5038.244263360525, 5043.722595257296, 5044.268581055726, 5066.240063990357, 5087.491250874957, 5003.5997120230295, 5089.211172268304, 5095.796168153232, 5116.334876466036, 5155.149400348901, 5109.923351149736, 5122.282880396748, 5129.0, 5130.461301563282, 5145.125328694131, 5083.313752643346, 5112.9744351278005, 5113.15632920564, 5123.743812809419, 5161.303224064778, 4136.462259906253, 4288.056627541936, 4322.502912165079, 4330.155619654201, 4384.6273066789045, 3789.5831458539537, 3798.525184351956, 3799.905002374963, 3834.4440056191697, 3853.9979605302824, 4474.0, 4485.484169320504, 4487.41663583732, 4504.864854054384, 4529.773511324421, 5011.323471331397, 5103.795848166106, 5127.897442051138, 5161.27742116104, 5238.083335416287, 4477.126960242721, 4479.283314669702, 4486.102779444124, 4493.775311234425, 4546.227141385973, 4612.146752850734, 4612.5156858530045, 4629.629629629621, 4633.0733853229485, 4633.976830115827, 4631.050634619962, 4797.64017698674, 4893.266010098514, 4898.314236006961, 4909.0672772173175, 5121.436641969455, 5159.134641679795, 5162.664426812245, 5166.070107380558, 5184.118699821115, 4818.156822555969, 4857.319975203545, 4860.95139048605, 4862.902741945212, 4915.483874193158, 4814.325994360723, 4990.226514890198, 5039.395272567315, 5081.136206844772, 5124.231365295235, 5162.199859021857, 5168.612354073534, 5173.1722924331925, 5175.301334319819, 5185.818496352609, 5034.421041580265, 5037.697738135724, 5041.395032596112, 5042.722650254272, 5065.670731402447, 4844.539768721966, 4976.0, 4983.426905905867, 5012.097822391858, 5105.7191854448365, 4935.876603084952, 4962.354893863775, 4976.2038073908, 4977.9502204978935, 4982.078315511642, 5080.263361812443, 5080.644354895122, 5081.8475445736685, 5082.898342033065, 5086.415062267739, 4709.529047095263, 4867.829625963074, 4879.56083952446, 4890.608751299958, 4945.7527123644395], "value": 4677.477976511415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.8592758846494, 557.4258513730857, 564.3340857787808, 569.3480964295882, 583.1282233061569, 35174.64825351746, 40067.599324006755, 40138.79930600343, 40191.39712904301, 40249.0, 39802.20395592094, 40039.39940900889, 40337.59662403375, 40483.59516404835, 40576.59423405765, 7473.252674732524, 7566.054243219598, 7573.318401343878, 7613.505122167069, 7625.6568454419685, 7720.266574675396, 7774.611269436506, 7783.338416234598, 7797.0643522777345, 7809.101953275361, 7785.065792104955, 7800.648970796299, 7808.453408261395, 7810.609469526529, 7815.804604884895, 7648.885266721004, 7761.068671759369, 7770.3006729394065, 7778.0, 7785.260400261966, 7659.425543084291, 7684.269994350528, 7728.18854020331, 7766.301032907009, 7771.883421748678, 35920.0, 36129.819350903075, 36217.81891090554, 36247.63752362495, 36301.0, 3093.8298393588343, 3205.2307446212976, 3368.730501559894, 3370.25854312051, 3571.321448924722, 27466.862665686742, 29045.56431653527, 29390.70609293901, 29411.11766647004, 29443.70556294431, 3286.65490123536, 3361.428557145291, 3435.879744208966, 3440.3119376124873, 3455.1016735648914, 258733.0, 259340.0, 259462.0, 260949.0, 260956.0, 30913.0, 32254.0, 32269.838650806596, 51318.48681513212, 51764.48235517597, 33000.0, 33594.832025839714, 33618.32763344768, 33668.83165584156, 33788.155296117795, 13711.0, 13852.861471385157, 13883.305834708426, 13957.930210348883, 13963.511277105456, 11506.94246528762, 11512.88487115135, 11520.078393728481, 11561.942190288995, 11651.88348116508, 7765.883511747328, 7815.609219539, 7831.138574756772, 7889.408294377945, 7912.723054693058, 3068.9232769180503, 3069.1099581121225, 3115.7351625111664, 3134.2947836736553, 3158.6841315868687, 867.9826403471895, 870.3602851903846, 902.2195800632405, 953.1612181280567, 954.8854137503544, 27954.72045279562, 28166.2958426041, 28725.138245852657, 29097.563536546968, 29117.417651646847, 913.7715571107224, 951.6241084771476, 1001.0340021878922, 1004.8894621591619, 1005.2305897253021, 14438.422463101359, 15267.3893044277, 15354.462593809163, 15419.151946642818, 15618.141002244985, 377437.0, 382090.0, 382568.0, 382877.0, 383013.0, 50188.0, 50311.24533132006, 50870.0, 50894.491055088976, 50952.23571646428, 1133.8355938388888, 1165.6386520178942, 1166.2361153444508, 1178.2223732336618, 1179.262960649594, 26681.866590666923, 27883.581746274227, 28237.57643635306, 28358.149255522367, 28825.0, 42687.719368419, 42824.78587607042, 42841.57158428376, 43228.8385580726, 43380.0, 325533.0, 329152.0, 329588.0, 329951.0, 330218.0, 25271.74728252694, 25414.745852541237, 25553.744462555882, 25606.615900761877, 25785.484290313714, 41245.0, 41433.0, 41879.7906010468, 42002.0, 42901.356479653456, 36745.29668595006, 36869.63130368662, 37332.2533549322, 37700.0, 38292.0, 36075.639243608275, 36287.0, 36315.45526817047, 36325.45511817378, 36447.81776091103, 35422.0, 35479.467807982386, 35650.64349356577, 35978.28043439064, 36356.636433636384, 30892.382152357277, 33360.83319583387, 33445.49831752477, 33469.16327091842, 33476.665233347354, 25228.369290767143, 25616.0, 25642.23073307804, 25808.483830323665, 26083.347916302246], "value": 16441.38519385037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.15021647612775, 361.24860290595564, 362.78051778673904, 370.9369407200776, 380.1750202061526, 15789.447369342075, 16740.49778506645, 17250.223739931702, 17404.56488587786, 17422.47732568025, 15149.318280677368, 15605.297761600727, 15627.374905003815, 15687.137207453585, 15793.210339483037, 5071.568916642081, 5215.921761173586, 5217.973910130444, 5247.658902171365, 5255.08036093682, 3716.9442458363146, 5180.093483640367, 5226.05930932432, 5681.318241810968, 5951.553633477485, 6019.428154325332, 6043.486303664172, 6054.697265136748, 6055.909161362583, 6058.515318774509, 5001.799928002875, 5265.8946821063555, 5290.682559046431, 5359.303290572239, 6006.819795406123, 5068.746562671889, 5149.356330458692, 5175.249588809602, 5196.714180720059, 5239.371275446971, 12319.322437265946, 12424.0, 16900.830991690047, 19970.0, 20469.18123275067, 1902.8192321729414, 1967.645823751724, 2020.8585399022074, 2107.79975902289, 2426.599611064172, 9207.0, 9207.98712141664, 9298.442093474345, 9302.534873256378, 9385.15533601979, 1709.265016043101, 1731.8008429030697, 1764.5853224492234, 1765.3556451894965, 1784.295203394652, 60511.69744151295, 66188.3381166187, 66619.66690166567, 67228.0, 69487.3051269491, 9569.28230382724, 9661.903380966241, 9943.0, 9971.850422243671, 10277.9486102569, 13492.797608035888, 13545.1195672281, 13575.0, 13619.250941198132, 13673.863261367458, 6910.481713871379, 6978.825529361807, 7056.54132481387, 7166.211716711157, 7352.0, 6608.306127856602, 6729.932700673028, 6793.490488213404, 6806.965965170142, 6940.583564986016, 4202.810873510699, 4297.978510107492, 4308.332208507686, 4316.805743741539, 4404.691671582958, 1650.339864054364, 1670.590705277215, 1744.5115367697065, 1780.9554761131076, 1854.6290741851683, 834.5326617094447, 847.2374862623565, 871.8997315308694, 884.7655371326475, 908.3596064774318, 16069.919650401907, 16749.24628391725, 17335.27850666442, 17525.0, 17650.823491764917, 861.8621020636668, 878.2227728460358, 900.1898291537668, 905.307439808547, 934.3926447808842, 9489.762755931019, 9817.460039697742, 9829.754256143653, 9913.950430247802, 9997.80004399908, 405444.0, 410357.0, 432218.0, 433450.0, 434433.0, 64128.358716413175, 74401.0, 75062.62468687621, 76856.61571692106, 79042.20957790464, 855.3677785130883, 885.0, 902.0438335364535, 907.6006557114848, 909.713440266314, 15154.545363639108, 15369.0, 15842.68314633724, 15910.363585456453, 15983.760243596587, 33833.0, 35936.58602432765, 36154.66144062729, 36989.445158323186, 38616.42075368928, 48017.0, 52220.73889630527, 53306.73346633242, 54080.0, 54552.0, 7187.8562428752175, 7441.4418918582405, 7597.3162415382885, 7639.236076392316, 7741.6839137347915, 10739.677809665722, 12469.75060498803, 12557.372131393577, 12751.107422480338, 12921.418536166084, 9999.400035997864, 10181.490925453845, 10327.535260913126, 10628.468576571295, 10803.081738052353, 10761.730956726144, 10811.13510919109, 10876.836847447454, 10888.727781805519, 11098.833517497082, 9917.504124793588, 10332.328398654063, 10332.948335258276, 10891.346519208873, 10936.890631093587, 7387.4459415545125, 7458.582869254824, 7504.174540800616, 7537.54774713497, 7871.881921771063, 7618.69525218985, 9839.655612053544, 9938.10557049869, 10645.733856653645, 10842.945785271339], "value": 8165.909641042412, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.437856100438, 1392.937317820698, 1461.802656641353, 1684.9805867450184, 1716.5107944235888, 6483.222013358391, 7298.416126709857, 7397.889031664529, 7881.527108373494, 7886.369090472763, 7484.738034168805, 7734.265244801735, 7747.883781743264, 7750.418718596114, 7778.183290754474, 2138.1340557074373, 2155.3103007037753, 2165.65349544073, 2179.923702670407, 2182.9890850545803, 2119.565489074736, 2144.8391370647264, 2161.859479133859, 2167.0, 2171.381156370435, 2148.130007347027, 2169.240765731997, 2170.934871953844, 2189.397915573214, 2194.4952660888007, 2107.799759022898, 2131.3392848217027, 2138.550904310097, 2143.399848042535, 2146.720926279589, 2097.0, 2119.682047692843, 2135.711678923341, 2143.0784762552253, 2144.345974477784, 7608.657610407489, 7632.389408847279, 7639.618019099078, 7648.961755191244, 7673.232676732282, 4366.192254432908, 4436.64506839452, 4454.621357184643, 4460.598546130864, 4484.551544845522, 2793.455276221138, 2838.545832666784, 2848.700886406918, 2850.50116229659, 2851.458222937635, 919.6551293265026, 953.912430640342, 973.474323865112, 976.4385478349906, 978.7455261631956, 9814.46020468874, 9821.950890245504, 9823.803523929482, 9831.459269740162, 9869.11177993984, 3936.724429289922, 4019.8392064317686, 4184.456020717348, 4248.915021699549, 4266.850660226877, 8587.527685977206, 8590.82818343642, 8604.354673399395, 8609.870851937227, 8626.913730862736, 4522.977385113053, 4530.886727831765, 4533.387992620954, 4537.659675524283, 4553.567411095941, 3391.067456449496, 4108.8356465741035, 4155.189738001121, 4159.376093585925, 4223.873283801491, 3511.2626348466597, 3579.570451545779, 3628.727845411605, 3655.5247817784048, 3691.7600355976774, 1171.3323405658864, 1181.9940900295444, 1193.7075416522835, 1202.0263586494966, 1204.7831390349645, 814.6659869453496, 839.3243439031638, 851.2338894994431, 853.9573021348908, 873.2315562305258, 5000.649954503223, 5281.313429254173, 5387.299651045418, 5460.754266058037, 5518.944810551843, 407.8164825828389, 414.40581956949114, 420.49540551337907, 421.77856625271977, 424.3083773449258, 3692.132348898007, 3789.981050094732, 3840.423936409561, 3864.652181303696, 3875.476810630585, 9065.59204835784, 9511.239100871913, 9524.8571271431, 9551.617935282511, 9555.9044409555, 9416.764580885396, 9442.90557094434, 9448.0, 9478.194353479894, 9528.809423811485, 7038.92961070393, 7056.964715176391, 7072.681729322193, 7115.395191408685, 7134.750283740148, 5275.815346462856, 5332.920006199987, 5443.319585051869, 5487.4238204987905, 5603.55171586264, 8355.707550235713, 8670.869936951078, 8671.872656554608, 8846.115388461103, 8869.600867961086, 8593.355498337774, 8918.286537077149, 8918.509481978554, 8928.15182557656, 9046.683366082156, 5888.499477544457, 6241.063840423973, 6357.3006969234275, 6592.143021407378, 6771.492138089761, 7036.718531258897, 7092.61693969671, 7108.431325494052, 7112.644367781693, 7142.107236595426, 6175.722092505758, 6195.287541932736, 6220.72006759706, 6227.252729672468, 6445.548811583144, 6175.197224360804, 6176.66028368444, 6196.0, 6198.1012753149635, 6205.596636218631, 5708.315002199763, 5826.067829147316, 5836.824895253149, 5842.620229685057, 5848.122781582797, 4056.634902858757, 4082.7142100053898, 4116.5060192777055, 4121.752694838319, 4239.745615263094, 4313.590208930146, 4321.827126915014, 4331.263685173465, 4431.977840110779, 4508.0], "value": 3967.7547172300074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7456863391581, 286.15726684912926, 287.4638798640536, 287.8244270994692, 292.36556672021715, 4948.480409556999, 4979.427365852928, 5003.498950314909, 5036.445990940998, 5080.390353157622, 4944.851654450372, 4962.627802914778, 4962.975185124069, 4992.850214493571, 5017.068428654967, 3618.7828730276137, 3785.71607129465, 3880.9611903881023, 3905.33609286422, 3931.2727145478034, 3865.4974853269036, 3872.283627528916, 3880.417937309412, 3886.6307700768525, 3915.9426954722207, 3891.6692081173132, 3896.27918835015, 3902.4731661225655, 3906.824192911326, 3909.1009067914397, 3745.3258413485833, 3883.0874744435037, 3905.1018265798743, 3910.983144382467, 3917.3144699677587, 3354.698077173042, 3367.696907278332, 3374.780639258465, 3383.6954674079207, 3387.458006718913, 4781.521847815226, 4830.492798256203, 4834.178189707758, 4845.491223421525, 4861.197902346144, 4425.2477078896345, 4436.290193569013, 4454.483216982395, 4455.059660623972, 4470.508244093147, 5017.774200161001, 5159.0, 5197.66215196011, 5213.530782229617, 5251.4485978972425, 3674.173311005029, 3674.650908163747, 3677.1358730698266, 3690.0959264979983, 3690.852365905361, 5434.456554344573, 5456.345238571357, 5463.2244520530585, 5479.287692599976, 5492.231087647732, 3702.61122582125, 3760.4547340636, 3802.2205447883116, 3811.085339518551, 3812.504374431306, 3840.2703486338064, 3842.423636454498, 3847.6537111659527, 3856.190200057963, 3859.710521710883, 4419.248727716232, 4421.712588681726, 4427.468703755506, 4434.290513517822, 4453.1316393303, 5038.2190760432195, 5275.419703832576, 5293.629445938825, 5297.337832770903, 5304.575633949275, 1308.1366298243113, 1323.973520529584, 1329.7606430842347, 1333.4399552188104, 1336.1982810313928, 805.6253841963515, 838.4153949036327, 839.9370047246481, 840.1724301562956, 847.4533925618065, 4058.289799285113, 4072.3687828386646, 4405.867823965286, 4524.9863810603965, 4654.511276316006, 5443.863903402367, 5448.863778405493, 5460.781568737286, 5463.48096930791, 5483.7806487740845, 4648.651351148677, 4649.976750116228, 4652.325412815123, 4654.371659825948, 4701.2242979908615, 2791.720827917233, 2837.957430638542, 2840.5881147233536, 2850.330172409482, 2850.558163484663, 5050.873728156826, 5069.44236134025, 5079.314292570456, 5096.719680417613, 5106.821261255913, 5417.160340147283, 5514.172874068841, 5516.448355164532, 5565.193047008162, 5568.575326174374, 5007.824726134568, 5024.497550244946, 5065.645404821627, 5067.341245638191, 5082.966813274646, 5342.8931421372135, 5370.570354371719, 5374.973125134349, 5378.0, 5395.3525576931015, 5114.207297868837, 5276.234945932895, 5287.180487024363, 5297.602679798953, 5310.336207974004, 5058.342415485963, 5065.4174769900455, 5070.569001634903, 5085.779412940941, 5091.821786237464, 3765.623437656322, 3774.943015955537, 3795.392737162151, 3810.561785394715, 3817.751846129993, 5269.446708095748, 5315.681059136464, 5421.213923980922, 5432.022235997559, 5493.670379777226, 5180.678926873623, 5191.195364718475, 5203.777112378512, 5219.76511057011, 5221.503957124219, 5206.557442617269, 5237.188235823453, 5237.528622424, 5240.895182096413, 5277.20841873722, 4986.326845875906, 5098.6752909972165, 5106.540411362995, 5183.9414745300455, 5237.764300606558, 4980.825671101494, 5245.197232006764, 5247.775540689781, 5262.736943133544, 5269.077911365573, 4969.180085285887, 5140.3831540215415, 5147.16905701855, 5173.870653233549, 5184.896302074013], "value": 3916.0194207635454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.8698273362594, 637.5600835423558, 667.3628723457157, 678.2132726037797, 718.5114122396768, 12343.444544995475, 12476.688082797935, 12502.81245781314, 12551.12142150051, 13507.527236546723, 13541.390637421315, 13674.111182773138, 13714.794278085838, 13740.312984350792, 13753.862461375384, 618.3352895637186, 764.7399884039426, 785.5247575216997, 786.996065019677, 787.322902304018, 768.4083255892959, 803.1085495100434, 807.8747794091926, 807.8868958345836, 809.2150613904532, 828.0436096308742, 833.4499230507867, 834.5493433545878, 836.6318819719335, 838.9790255243637, 838.8573942429801, 841.381584535369, 841.970531031414, 842.8651415773447, 845.1041895590632, 611.9388061193889, 614.671150934248, 615.4460985113434, 615.5598746895946, 616.8087892753216, 13626.591202263948, 13677.384517696728, 13679.110857794212, 13685.521006764815, 13712.65718357039, 13377.53178638743, 13609.863901360959, 14081.0, 14240.857591424057, 14254.928725356307, 10711.196660250434, 10737.570497180104, 10769.569217231301, 10781.353118812896, 10841.512131954081, 3313.6023677158655, 3330.600327960636, 3391.2708767614836, 3409.3692666856464, 3416.7779094359034, 65989.3401065988, 66508.66745666241, 66538.66730666364, 67745.32254677439, 68380.6580967092, 10495.317804342692, 10609.162912875352, 10697.946510267398, 10973.286736362112, 10990.285631433931, 20109.09509072095, 20131.094100765502, 20165.09257083435, 20201.393958180983, 20269.797302027087, 6885.827854303582, 6957.095577574883, 7084.539504932266, 7095.9290407096305, 7149.9285007149265, 3537.363274610595, 3680.9263814723554, 3754.5869954305003, 3765.0, 3860.007739861262, 2812.2406950123354, 2930.7801914856473, 2934.3544420227518, 2956.793024488265, 2969.0944261999866, 499.7451299837109, 507.4114027727818, 507.5406756885025, 516.1689679615815, 518.2356024863296, 508.379776672459, 518.7276679743165, 520.3885434614313, 570.2985328046526, 604.5798170271619, 8614.87077693835, 8725.258353039935, 8784.912150878537, 9020.729378118667, 9136.81726365469, 504.4274748160864, 555.9353837401412, 589.5195415736162, 631.1321932343028, 646.424682032991, 3749.0, 4301.698881078357, 4344.652427805831, 4350.934735978963, 4367.847125350598, 53189.0, 53914.19128713072, 73558.26441735514, 101799.0, 107111.46444267729, 82854.17145828465, 83011.0, 87137.56431217803, 87273.56363218144, 87584.0, 73624.0, 77329.61335193401, 78448.607756962, 79911.60044199742, 80809.59595202105, 7656.846863062819, 7830.647620856961, 7902.209779022051, 8009.559474228973, 8271.51001986992, 43869.0, 43957.56042439662, 44199.558004419545, 44643.0, 45675.771621141685, 64507.677461612395, 68328.0, 69169.65415172892, 69221.0, 70808.0, 10524.579016839547, 10554.630587929692, 10575.15398768112, 10577.471126443801, 11013.118950483782, 11354.091672666002, 11474.77050459003, 11647.0, 11647.941760291144, 11740.589079382522, 11176.497057632589, 11201.887981120084, 11384.37385943781, 11416.029637480908, 11749.353785541878, 10995.395253261147, 11028.172887033345, 11109.888901110886, 11150.888491114985, 11492.712682183012, 10971.945140274567, 11111.111111111253, 11261.549538018387, 11357.829632555684, 11554.248973816675, 9246.214071803703, 9447.24422046221, 9627.422354658744, 9759.951200243953, 9769.267304952014, 9305.488198149167, 9517.286203534624, 9733.909257128234, 9787.16809071237, 9952.850707239253], "value": 6580.9348071141485, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 109.0, 119.0, 116.0, 116.0, 117.0, 116.0, 117.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 145.0, 201.0, 123.0, 157.0, 152.0, 123.0, 189.0, 124.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 171.0, 164.0, 165.0, 163.0, 163.0, 162.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 83.0, 167.0, 77.0, 77.0, 77.0, 76.0, 161.0, 78.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 154.0, 86.0, 86.0, 87.0, 142.0, 86.0, 88.0, 138.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 119.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 63.0, 63.0, 65.0, 65.0, 66.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 69.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 82.0, 81.0, 82.0, 81.0, 81.0, 80.0, 85.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 152.0, 133.0, 135.0, 134.0, 144.0, 135.0, 140.0, 157.0, 139.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 175.0, 172.0, 169.0, 173.0, 170.0, 173.0, 170.0, 171.0, 171.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 69.0, 68.0, 69.0, 68.0, 70.0, 67.0, 73.0, 69.0], "value": 69.5, "unit": "score"}]}]} 10:18:58 INFO - Return code: 0 10:18:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:58 ERROR - # TBPL SUCCESS # 10:18:58 INFO - Running post-action listener: _resource_record_post_action 10:18:58 INFO - [mozharness: 2016-08-12 17:18:58.659182Z] Finished run-tests step (success) 10:18:58 INFO - Running post-run listener: _resource_record_post_run 10:18:58 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 297902080; Read time: 36; Write time: 134888 10:18:58 INFO - TinderboxPrint: CPU usage
13.3% 10:18:58 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 36 10:18:58 INFO - TinderboxPrint: I/O write bytes / time
297,902,080 / 134,888 10:18:58 INFO - TinderboxPrint: CPU idle
8,272.5 (86.7%) 10:18:58 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 10:18:58 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15388672; Read time: 0; Write time: 3304 10:18:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282513408; Read time: 24; Write time: 131584 10:18:59 INFO - Running post-run listener: _upload_blobber_files 10:18:59 INFO - Blob upload gear active. 10:18:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:18:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:00 INFO - (blobuploader) - INFO - Done attempting. 10:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:05 INFO - (blobuploader) - INFO - Done attempting. 10:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:05 INFO - (blobuploader) - INFO - Done attempting. 10:19:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:05 INFO - Return code: 0 10:19:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2e9c67e04b7a04ee0f44ee1cd1c113b17e7115b1f9cbe3590db977a790468fdf6a184a109a37dfb1e109cbc6b18b50270fcd3407a5d904a48ffdecb813dbb309", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/613baaabed8d94b7cde7caf3d3ca772e9b6bd64da546de30d289461716b04083d3bc6b23a90458bb690cfbded67341ea4972f1fa625e200dcdef48f8c3578aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f85f4779c6499b72c7d898a9289638c1597cd1b78ede38ac009a8e3e01c9538fd9e5d924ce3771ee4038a4f45cf5d56cdb9761c83856d620169daab3353e0d9"} 10:19:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:05 INFO - Contents: 10:19:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2e9c67e04b7a04ee0f44ee1cd1c113b17e7115b1f9cbe3590db977a790468fdf6a184a109a37dfb1e109cbc6b18b50270fcd3407a5d904a48ffdecb813dbb309", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/613baaabed8d94b7cde7caf3d3ca772e9b6bd64da546de30d289461716b04083d3bc6b23a90458bb690cfbded67341ea4972f1fa625e200dcdef48f8c3578aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f85f4779c6499b72c7d898a9289638c1597cd1b78ede38ac009a8e3e01c9538fd9e5d924ce3771ee4038a4f45cf5d56cdb9761c83856d620169daab3353e0d9"} 10:19:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:05 INFO - Copying logs to upload dir... 10:19:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.882730 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-12 10:19:05.623383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 10:19:05.626606) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2e9c67e04b7a04ee0f44ee1cd1c113b17e7115b1f9cbe3590db977a790468fdf6a184a109a37dfb1e109cbc6b18b50270fcd3407a5d904a48ffdecb813dbb309", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/613baaabed8d94b7cde7caf3d3ca772e9b6bd64da546de30d289461716b04083d3bc6b23a90458bb690cfbded67341ea4972f1fa625e200dcdef48f8c3578aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f85f4779c6499b72c7d898a9289638c1597cd1b78ede38ac009a8e3e01c9538fd9e5d924ce3771ee4038a4f45cf5d56cdb9761c83856d620169daab3353e0d9"} build_url:https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/KcgNB-_rSDGtdoS_AVo0Vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2e9c67e04b7a04ee0f44ee1cd1c113b17e7115b1f9cbe3590db977a790468fdf6a184a109a37dfb1e109cbc6b18b50270fcd3407a5d904a48ffdecb813dbb309", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/613baaabed8d94b7cde7caf3d3ca772e9b6bd64da546de30d289461716b04083d3bc6b23a90458bb690cfbded67341ea4972f1fa625e200dcdef48f8c3578aea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1f85f4779c6499b72c7d898a9289638c1597cd1b78ede38ac009a8e3e01c9538fd9e5d924ce3771ee4038a4f45cf5d56cdb9761c83856d620169daab3353e0d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 10:19:05.651712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:19:05.652015) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1471020675.193839-2128230372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 10:19:05.736221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 10:19:05.736555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 10:19:05.736856) ========= ========= Total master_lag: 0.17 =========