builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1470933600.1 results: success (0) buildid: 20160811083421 builduid: e9fd15ef2d09425da3487342feeaabac revision: 26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.097689) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.098933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.099590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.117113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.117472) ========= 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=836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 09:40:00-- 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% 38.6M=0s 2016-08-11 09:40:00 (38.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.245644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.245961) ========= 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=836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:00.297528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 09:40:00.298331) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f --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 26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f --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=836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 09:40:00,580 truncating revision to first 12 chars 2016-08-11 09:40:00,580 Setting DEBUG logging. 2016-08-11 09:40:00,580 attempt 1/10 2016-08-11 09:40:00,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/26e7c3afcbad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 09:40:01,896 unpacking tar archive at: autoland-26e7c3afcbad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.659225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 09:40:01.971834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:01.972146) ========= script_repo_revision: 26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:01.972563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:01.972831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 09:40:01.984666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-11 09:40:01.985104) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:40:02 INFO - MultiFileLogger online at 20160811 09:40:02 in /builds/slave/test 09:40:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:40:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:40:02 INFO - {'append_to_log': False, 09:40:02 INFO - 'base_work_dir': '/builds/slave/test', 09:40:02 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:40:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:40:02 INFO - 'branch': 'Autoland-Non-PGO', 09:40:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:40:02 INFO - 'config_files': ('talos/linux_config.py',), 09:40:02 INFO - 'default_actions': ('clobber', 09:40:02 INFO - 'read-buildbot-config', 09:40:02 INFO - 'download-and-extract', 09:40:02 INFO - 'populate-webroot', 09:40:02 INFO - 'create-virtualenv', 09:40:02 INFO - 'install', 09:40:02 INFO - 'run-tests'), 09:40:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:40:02 INFO - 'download_minidump_stackwalk': True, 09:40:02 INFO - 'download_symbols': 'ondemand', 09:40:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:40:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:40:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:40:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:40:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:40:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:40:02 INFO - 'installer_path': 'installer.exe', 09:40:02 INFO - 'log_level': 'info', 09:40:02 INFO - 'log_name': 'talos', 09:40:02 INFO - 'log_to_console': True, 09:40:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:40:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:40:02 INFO - 'opt_config_files': (), 09:40:02 INFO - 'pip_index': False, 09:40:02 INFO - 'sps_profile': False, 09:40:02 INFO - 'sps_profile_interval': 0, 09:40:02 INFO - 'suite': 'dromaeojs', 09:40:02 INFO - 'system_bits': '32', 09:40:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:40:02 INFO - 'title': 'talos-linux64-ix-028', 09:40:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:40:02 INFO - 'use_talos_json': True, 09:40:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:40:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:40:02 INFO - 'work_dir': 'build'} 09:40:02 INFO - [mozharness: 2016-08-11 16:40:02.351639Z] Running clobber step. 09:40:02 INFO - Running pre-action listener: _resource_record_pre_action 09:40:02 INFO - Running main action method: clobber 09:40:02 INFO - rmtree: /builds/slave/test/build 09:40:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:40:02 INFO - Running post-action listener: _resource_record_post_action 09:40:02 INFO - [mozharness: 2016-08-11 16:40:02.814339Z] Finished clobber step (success) 09:40:02 INFO - [mozharness: 2016-08-11 16:40:02.814440Z] Running read-buildbot-config step. 09:40:02 INFO - Running pre-action listener: _resource_record_pre_action 09:40:02 INFO - Running main action method: read_buildbot_config 09:40:02 INFO - Using buildbot properties: 09:40:02 INFO - { 09:40:02 INFO - "project": "", 09:40:02 INFO - "product": "firefox", 09:40:02 INFO - "script_repo_revision": "production", 09:40:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:40:02 INFO - "repository": "", 09:40:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:40:02 INFO - "buildid": "20160811083421", 09:40:02 INFO - "pgo_build": "False", 09:40:02 INFO - "basedir": "/builds/slave/test", 09:40:02 INFO - "buildnumber": 227, 09:40:02 INFO - "slavename": "talos-linux64-ix-028", 09:40:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:40:02 INFO - "platform": "ubuntu64_hw", 09:40:02 INFO - "scheduler": "tests-autoland-linux64-talos", 09:40:02 INFO - "branch": "autoland", 09:40:02 INFO - "repo_path": "integration/autoland", 09:40:02 INFO - "revision": "26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f", 09:40:02 INFO - "stage_platform": "linux64", 09:40:02 INFO - "builduid": "e9fd15ef2d09425da3487342feeaabac", 09:40:02 INFO - "slavebuilddir": "test" 09:40:02 INFO - } 09:40:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:40:02 INFO - Running post-action listener: _resource_record_post_action 09:40:02 INFO - [mozharness: 2016-08-11 16:40:02.816844Z] Finished read-buildbot-config step (success) 09:40:02 INFO - [mozharness: 2016-08-11 16:40:02.816932Z] Running download-and-extract step. 09:40:02 INFO - Running pre-action listener: _resource_record_pre_action 09:40:02 INFO - Running main action method: download_and_extract 09:40:02 INFO - mkdir: /builds/slave/test/build/tests 09:40: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:40:02 INFO - trying https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:40:02 INFO - Downloading https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:03 INFO - Downloaded 1361 bytes. 09:40:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:40:03 INFO - Using the following test package requirements: 09:40:03 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:40:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:40:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:40:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'jsshell-linux-x86_64.zip'], 09:40:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:40:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:40:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:40:03 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:40:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:40:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:40:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:03 INFO - trying https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:40:03 INFO - Downloading https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:04 INFO - Downloaded 20262781 bytes. 09:40:04 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:40:08 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:40:08 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:40:08 INFO - trying https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:40:08 INFO - Downloading https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:09 INFO - Downloaded 20262781 bytes. 09:40:09 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:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:14 INFO - trying https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:40:14 INFO - Downloading https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:14 INFO - Downloaded 14413719 bytes. 09:40:14 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:40:15 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:40:15 INFO - trying https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:40:15 INFO - Downloading https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/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:40:16 INFO - Downloaded 55628773 bytes. 09:40:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:40:16 INFO - mkdir: /builds/slave/test/properties 09:40:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:40:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:40:16 INFO - Contents: 09:40:16 INFO - build_url:https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:40:17 INFO - Running post-action listener: _resource_record_post_action 09:40:17 INFO - Running post-action listener: set_extra_try_arguments 09:40:17 INFO - [mozharness: 2016-08-11 16:40:17.054740Z] Finished download-and-extract step (success) 09:40:17 INFO - [mozharness: 2016-08-11 16:40:17.054964Z] Running populate-webroot step. 09:40:17 INFO - Running pre-action listener: _resource_record_pre_action 09:40:17 INFO - Running main action method: populate_webroot 09:40:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:40:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:40:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:40:17 INFO - '--tppagecycles', 09:40:17 INFO - '7'], 09:40:17 INFO - 'tests': ['tsvgm']}}, 09:40:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:40:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:40:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:40:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:40:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['damp', 'tps']}, 09:40:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'tests': ['damp', 'tps']}, 09:40:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['dromaeo_dom']}, 09:40:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:40:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['basic_compositor_video']}, 09:40:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:40:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['a11yr', 09:40:17 INFO - 'ts_paint', 09:40:17 INFO - 'tpaint', 09:40:17 INFO - 'sessionrestore', 09:40:17 INFO - 'sessionrestore_no_auto_restore', 09:40:17 INFO - 'tabpaint']}, 09:40:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:40:17 INFO - 'ts_paint', 09:40:17 INFO - 'tpaint', 09:40:17 INFO - 'sessionrestore', 09:40:17 INFO - 'sessionrestore_no_auto_restore', 09:40:17 INFO - 'tabpaint']}, 09:40:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:40:17 INFO - 'ts_paint', 09:40:17 INFO - 'tpaint', 09:40:17 INFO - 'sessionrestore', 09:40:17 INFO - 'sessionrestore_no_auto_restore', 09:40:17 INFO - 'tabpaint']}, 09:40:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:40:17 INFO - 'ts_paint', 09:40:17 INFO - 'tpaint', 09:40:17 INFO - 'sessionrestore', 09:40:17 INFO - 'sessionrestore_no_auto_restore', 09:40:17 INFO - 'tabpaint']}, 09:40:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['a11yr', 09:40:17 INFO - 'ts_paint', 09:40:17 INFO - 'tpaint', 09:40:17 INFO - 'sessionrestore', 09:40:17 INFO - 'sessionrestore_no_auto_restore', 09:40:17 INFO - 'tabpaint']}, 09:40:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['a11yr', 09:40:17 INFO - 'ts_paint', 09:40:17 INFO - 'tpaint', 09:40:17 INFO - 'sessionrestore', 09:40:17 INFO - 'sessionrestore_no_auto_restore', 09:40:17 INFO - 'tabpaint']}, 09:40:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['tsvgx', 09:40:17 INFO - 'tsvgr_opacity', 09:40:17 INFO - 'tart', 09:40:17 INFO - 'tscrollx', 09:40:17 INFO - 'cart']}, 09:40:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:40:17 INFO - 'tsvgr_opacity', 09:40:17 INFO - 'tart', 09:40:17 INFO - 'tscrollx', 09:40:17 INFO - 'cart']}, 09:40:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'talos_options': ['--disable-e10s'], 09:40:17 INFO - 'tests': ['tp5o']}, 09:40:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'tests': ['tp5o']}, 09:40:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'talos_options': ['--disable-e10s', 09:40:17 INFO - '--xperf_path', 09:40:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:17 INFO - 'tests': ['tp5n']}, 09:40:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:17 INFO - 'talos_options': ['--xperf_path', 09:40:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:17 INFO - 'tests': ['tp5n']}}, 09:40:17 INFO - 'talos.zip': {'path': '', 09:40:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:17 INFO - Running post-action listener: _resource_record_post_action 09:40:17 INFO - [mozharness: 2016-08-11 16:40:17.072280Z] Finished populate-webroot step (success) 09:40:17 INFO - [mozharness: 2016-08-11 16:40:17.072368Z] Running create-virtualenv step. 09:40:17 INFO - Running pre-action listener: _resource_record_pre_action 09:40:17 INFO - Running main action method: create_virtualenv 09:40:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:40:17 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:40:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:40:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:40:17 INFO - Using real prefix '/usr' 09:40:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:40:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:19 INFO - Installing pip.................done. 09:40:19 INFO - Return code: 0 09:40:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40:19 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:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:19 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:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:19 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:19 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:40:19 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:40:19 INFO - Using env: {'DISPLAY': ':0', 09:40:19 INFO - 'HOME': '/home/cltbld', 09:40:19 INFO - 'LANG': 'en_US.UTF-8', 09:40:19 INFO - 'LANGUAGE': 'en_US:en', 09:40:19 INFO - 'LOGNAME': 'cltbld', 09:40:19 INFO - 'MAIL': '/var/mail/cltbld', 09:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:19 INFO - 'MOZ_NO_REMOTE': '1', 09:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:19 INFO - 'NO_EM_RESTART': '1', 09:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:19 INFO - 'PWD': '/builds/slave/test', 09:40:19 INFO - 'SHELL': '/bin/bash', 09:40:19 INFO - 'SHLVL': '1', 09:40:19 INFO - 'TERM': 'linux', 09:40:19 INFO - 'TMOUT': '86400', 09:40:19 INFO - 'USER': 'cltbld', 09:40:19 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:19 INFO - '_': '/tools/buildbot/bin/python'} 09:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:19 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:40:19 INFO - Cleaning up... 09:40:19 INFO - Return code: 0 09:40:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:40:19 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:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:19 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:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:19 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:19 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:40:19 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:40:19 INFO - Using env: {'DISPLAY': ':0', 09:40:19 INFO - 'HOME': '/home/cltbld', 09:40:19 INFO - 'LANG': 'en_US.UTF-8', 09:40:19 INFO - 'LANGUAGE': 'en_US:en', 09:40:19 INFO - 'LOGNAME': 'cltbld', 09:40:19 INFO - 'MAIL': '/var/mail/cltbld', 09:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:19 INFO - 'MOZ_NO_REMOTE': '1', 09:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:19 INFO - 'NO_EM_RESTART': '1', 09:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:19 INFO - 'PWD': '/builds/slave/test', 09:40:19 INFO - 'SHELL': '/bin/bash', 09:40:19 INFO - 'SHLVL': '1', 09:40:19 INFO - 'TERM': 'linux', 09:40:19 INFO - 'TMOUT': '86400', 09:40:19 INFO - 'USER': 'cltbld', 09:40:19 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:19 INFO - '_': '/tools/buildbot/bin/python'} 09:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:20 INFO - Downloading/unpacking psutil>=3.1.1 09:40:20 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:40:20 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:40:20 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:40:20 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:40:20 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:40:20 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:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:22 INFO - Installing collected packages: psutil 09:40:22 INFO - Running setup.py install for psutil 09:40:22 INFO - building 'psutil._psutil_linux' extension 09:40:22 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:40:22 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:40:22 INFO - building 'psutil._psutil_posix' extension 09:40:22 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:40:22 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:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:22 INFO - Successfully installed psutil 09:40:22 INFO - Cleaning up... 09:40:22 INFO - Return code: 0 09:40:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:40:22 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:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:22 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:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:22 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:22 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:40:22 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:40:22 INFO - Using env: {'DISPLAY': ':0', 09:40:22 INFO - 'HOME': '/home/cltbld', 09:40:22 INFO - 'LANG': 'en_US.UTF-8', 09:40:22 INFO - 'LANGUAGE': 'en_US:en', 09:40:22 INFO - 'LOGNAME': 'cltbld', 09:40:22 INFO - 'MAIL': '/var/mail/cltbld', 09:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:22 INFO - 'MOZ_NO_REMOTE': '1', 09:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:22 INFO - 'NO_EM_RESTART': '1', 09:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:22 INFO - 'PWD': '/builds/slave/test', 09:40:22 INFO - 'SHELL': '/bin/bash', 09:40:22 INFO - 'SHLVL': '1', 09:40:22 INFO - 'TERM': 'linux', 09:40:22 INFO - 'TMOUT': '86400', 09:40:22 INFO - 'USER': 'cltbld', 09:40:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:22 INFO - '_': '/tools/buildbot/bin/python'} 09:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40:22 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:40:22 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:40:22 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:40:22 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:40:22 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:40:22 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:40:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:40:24 INFO - Installing collected packages: mozsystemmonitor 09:40:24 INFO - Running setup.py install for mozsystemmonitor 09:40:24 INFO - Successfully installed mozsystemmonitor 09:40:24 INFO - Cleaning up... 09:40:24 INFO - Return code: 0 09:40:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:24 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:24 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:40:24 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:40:24 INFO - Using env: {'DISPLAY': ':0', 09:40:24 INFO - 'HOME': '/home/cltbld', 09:40:24 INFO - 'LANG': 'en_US.UTF-8', 09:40:24 INFO - 'LANGUAGE': 'en_US:en', 09:40:24 INFO - 'LOGNAME': 'cltbld', 09:40:24 INFO - 'MAIL': '/var/mail/cltbld', 09:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:24 INFO - 'MOZ_NO_REMOTE': '1', 09:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:24 INFO - 'NO_EM_RESTART': '1', 09:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:24 INFO - 'PWD': '/builds/slave/test', 09:40:24 INFO - 'SHELL': '/bin/bash', 09:40:24 INFO - 'SHLVL': '1', 09:40:24 INFO - 'TERM': 'linux', 09:40:24 INFO - 'TMOUT': '86400', 09:40:24 INFO - 'USER': 'cltbld', 09:40:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:24 INFO - '_': '/tools/buildbot/bin/python'} 09:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:25 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:40:25 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:40:25 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:40:25 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:40:25 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:40:25 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:40:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:26 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:40:26 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:40:26 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:40:26 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:40:26 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:40:26 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:40:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:27 INFO - warning: no files found matching '*.txt' 09:40:27 INFO - no previously-included directories found matching 'build' 09:40:27 INFO - no previously-included directories found matching 'dist' 09:40:27 INFO - no previously-included directories found matching '.git*' 09:40:27 INFO - Installing collected packages: jsonschema, functools32 09:40:27 INFO - Running setup.py install for functools32 09:40:27 INFO - warning: no files found matching '*.txt' 09:40:27 INFO - no previously-included directories found matching 'build' 09:40:27 INFO - no previously-included directories found matching 'dist' 09:40:27 INFO - no previously-included directories found matching '.git*' 09:40:27 INFO - Successfully installed jsonschema functools32 09:40:27 INFO - Cleaning up... 09:40:27 INFO - Return code: 0 09:40:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40:27 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:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:27 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:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:27 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:27 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:40:27 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:40:27 INFO - Using env: {'DISPLAY': ':0', 09:40:27 INFO - 'HOME': '/home/cltbld', 09:40:27 INFO - 'LANG': 'en_US.UTF-8', 09:40:27 INFO - 'LANGUAGE': 'en_US:en', 09:40:27 INFO - 'LOGNAME': 'cltbld', 09:40:27 INFO - 'MAIL': '/var/mail/cltbld', 09:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:27 INFO - 'MOZ_NO_REMOTE': '1', 09:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:27 INFO - 'NO_EM_RESTART': '1', 09:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:27 INFO - 'PWD': '/builds/slave/test', 09:40:27 INFO - 'SHELL': '/bin/bash', 09:40:27 INFO - 'SHLVL': '1', 09:40:27 INFO - 'TERM': 'linux', 09:40:27 INFO - 'TMOUT': '86400', 09:40:27 INFO - 'USER': 'cltbld', 09:40:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:27 INFO - '_': '/tools/buildbot/bin/python'} 09:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:27 INFO - Cleaning up... 09:40:27 INFO - Return code: 0 09:40:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:27 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:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:27 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:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:27 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:27 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:40:27 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:40:27 INFO - Using env: {'DISPLAY': ':0', 09:40:27 INFO - 'HOME': '/home/cltbld', 09:40:27 INFO - 'LANG': 'en_US.UTF-8', 09:40:27 INFO - 'LANGUAGE': 'en_US:en', 09:40:27 INFO - 'LOGNAME': 'cltbld', 09:40:27 INFO - 'MAIL': '/var/mail/cltbld', 09:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:27 INFO - 'MOZ_NO_REMOTE': '1', 09:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:27 INFO - 'NO_EM_RESTART': '1', 09:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:27 INFO - 'PWD': '/builds/slave/test', 09:40:27 INFO - 'SHELL': '/bin/bash', 09:40:27 INFO - 'SHLVL': '1', 09:40:27 INFO - 'TERM': 'linux', 09:40:27 INFO - 'TMOUT': '86400', 09:40:27 INFO - 'USER': 'cltbld', 09:40:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:27 INFO - '_': '/tools/buildbot/bin/python'} 09:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:30 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:40:30 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:40:30 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:40:30 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:40:30 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:40:30 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:40:30 INFO - Downloading docopt-0.6.1.tar.gz 09:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:30 INFO - Running setup.py install for blobuploader 09:40:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:30 INFO - Running setup.py install for requests 09:40:30 INFO - Running setup.py install for docopt 09:40:31 INFO - Successfully installed blobuploader requests docopt 09:40:31 INFO - Cleaning up... 09:40:31 INFO - Return code: 0 09:40:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:31 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:31 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:40:31 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:40:31 INFO - Using env: {'DISPLAY': ':0', 09:40:31 INFO - 'HOME': '/home/cltbld', 09:40:31 INFO - 'LANG': 'en_US.UTF-8', 09:40:31 INFO - 'LANGUAGE': 'en_US:en', 09:40:31 INFO - 'LOGNAME': 'cltbld', 09:40:31 INFO - 'MAIL': '/var/mail/cltbld', 09:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:31 INFO - 'MOZ_NO_REMOTE': '1', 09:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:31 INFO - 'NO_EM_RESTART': '1', 09:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:31 INFO - 'PWD': '/builds/slave/test', 09:40:31 INFO - 'SHELL': '/bin/bash', 09:40:31 INFO - 'SHLVL': '1', 09:40:31 INFO - 'TERM': 'linux', 09:40:31 INFO - 'TMOUT': '86400', 09:40:31 INFO - 'USER': 'cltbld', 09:40:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:31 INFO - '_': '/tools/buildbot/bin/python'} 09:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:31 INFO - Running setup.py (path:/tmp/pip-myJ_tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:31 INFO - Running setup.py (path:/tmp/pip-TqrIAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:31 INFO - Running setup.py (path:/tmp/pip-RGrqZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:31 INFO - Running setup.py (path:/tmp/pip-zoUk4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:31 INFO - Running setup.py (path:/tmp/pip-7QSNzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:31 INFO - Running setup.py (path:/tmp/pip-tFIpic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:31 INFO - Running setup.py (path:/tmp/pip-YrMnda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:31 INFO - Running setup.py (path:/tmp/pip-yAJCRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:31 INFO - Running setup.py (path:/tmp/pip-e8xCaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:32 INFO - Running setup.py (path:/tmp/pip-pJVdrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:32 INFO - Running setup.py (path:/tmp/pip-rYKkLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:32 INFO - Running setup.py (path:/tmp/pip-ZQiYTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:32 INFO - Running setup.py (path:/tmp/pip-u4iILr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:32 INFO - Running setup.py (path:/tmp/pip-eNLkkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:32 INFO - Running setup.py (path:/tmp/pip-2Urvmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:32 INFO - Running setup.py (path:/tmp/pip-hMLHko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:32 INFO - Running setup.py (path:/tmp/pip-xRvjCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:32 INFO - Running setup.py install for manifestparser 09:40:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:32 INFO - Running setup.py install for mozcrash 09:40:32 INFO - Running setup.py install for mozdebug 09:40:32 INFO - Running setup.py install for mozdevice 09:40:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for mozfile 09:40:33 INFO - Running setup.py install for mozhttpd 09:40:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for mozinfo 09:40:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for mozInstall 09:40:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for mozleak 09:40:33 INFO - Running setup.py install for mozlog 09:40:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for moznetwork 09:40:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for mozprocess 09:40:33 INFO - Running setup.py install for mozprofile 09:40:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:33 INFO - Running setup.py install for mozrunner 09:40:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:34 INFO - Running setup.py install for mozscreenshot 09:40:34 INFO - Running setup.py install for moztest 09:40:34 INFO - Running setup.py install for mozversion 09:40:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:34 INFO - Cleaning up... 09:40:34 INFO - Return code: 0 09:40:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:34 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:34 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:40:34 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:40:34 INFO - Using env: {'DISPLAY': ':0', 09:40:34 INFO - 'HOME': '/home/cltbld', 09:40:34 INFO - 'LANG': 'en_US.UTF-8', 09:40:34 INFO - 'LANGUAGE': 'en_US:en', 09:40:34 INFO - 'LOGNAME': 'cltbld', 09:40:34 INFO - 'MAIL': '/var/mail/cltbld', 09:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:34 INFO - 'MOZ_NO_REMOTE': '1', 09:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:34 INFO - 'NO_EM_RESTART': '1', 09:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:34 INFO - 'PWD': '/builds/slave/test', 09:40:34 INFO - 'SHELL': '/bin/bash', 09:40:34 INFO - 'SHLVL': '1', 09:40:34 INFO - 'TERM': 'linux', 09:40:34 INFO - 'TMOUT': '86400', 09:40:34 INFO - 'USER': 'cltbld', 09:40:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:34 INFO - '_': '/tools/buildbot/bin/python'} 09:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:34 INFO - Running setup.py (path:/tmp/pip-ubGmhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:34 INFO - Running setup.py (path:/tmp/pip-lzQgtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:34 INFO - Running setup.py (path:/tmp/pip-bgynVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:34 INFO - Running setup.py (path:/tmp/pip-aUB1X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:34 INFO - Running setup.py (path:/tmp/pip-PiSgvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:34 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:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:34 INFO - Running setup.py (path:/tmp/pip-S2UWFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:35 INFO - Running setup.py (path:/tmp/pip-IZB7OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:35 INFO - Running setup.py (path:/tmp/pip-41DZbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:35 INFO - Running setup.py (path:/tmp/pip-7kVOEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:35 INFO - Running setup.py (path:/tmp/pip-D3WyYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:35 INFO - Running setup.py (path:/tmp/pip-DlK6Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:35 INFO - Running setup.py (path:/tmp/pip-RZtcLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:35 INFO - Running setup.py (path:/tmp/pip-4zqreY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:35 INFO - Running setup.py (path:/tmp/pip-EoOOJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:35 INFO - Running setup.py (path:/tmp/pip-deJ6Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:35 INFO - Running setup.py (path:/tmp/pip-KXA2Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:35 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:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:35 INFO - Running setup.py (path:/tmp/pip-_CqPP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:35 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:40:35 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:40:35 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:40:35 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:40:35 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:40:35 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:40:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:37 INFO - Downloading blessings-1.6.tar.gz 09:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:37 INFO - Installing collected packages: blessings 09:40:37 INFO - Running setup.py install for blessings 09:40:37 INFO - Successfully installed blessings 09:40:37 INFO - Cleaning up... 09:40:37 INFO - Return code: 0 09:40:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:38 INFO - Reading from file tmpfile_stdout 09:40:38 INFO - Current package versions: 09:40:38 INFO - argparse == 1.2.1 09:40:38 INFO - blessings == 1.6 09:40:38 INFO - blobuploader == 1.2.4 09:40:38 INFO - docopt == 0.6.1 09:40:38 INFO - functools32 == 3.2.3-2 09:40:38 INFO - jsonschema == 2.5.1 09:40:38 INFO - manifestparser == 1.1 09:40:38 INFO - mozInstall == 1.12 09:40:38 INFO - mozcrash == 0.17 09:40:38 INFO - mozdebug == 0.1 09:40:38 INFO - mozdevice == 0.48 09:40:38 INFO - mozfile == 1.2 09:40:38 INFO - mozhttpd == 0.7 09:40:38 INFO - mozinfo == 0.9 09:40:38 INFO - mozleak == 0.1 09:40:38 INFO - mozlog == 3.3 09:40:38 INFO - moznetwork == 0.27 09:40:38 INFO - mozprocess == 0.23 09:40:38 INFO - mozprofile == 0.28 09:40:38 INFO - mozrunner == 6.12 09:40:38 INFO - mozscreenshot == 0.1 09:40:38 INFO - mozsystemmonitor == 0.3 09:40:38 INFO - moztest == 0.7 09:40:38 INFO - mozversion == 1.4 09:40:38 INFO - psutil == 3.1.1 09:40:38 INFO - requests == 1.2.3 09:40:38 INFO - wsgiref == 0.1.2 09:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:38 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:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:38 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:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:38 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:38 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:40:38 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:40:38 INFO - Using env: {'DISPLAY': ':0', 09:40:38 INFO - 'HOME': '/home/cltbld', 09:40:38 INFO - 'LANG': 'en_US.UTF-8', 09:40:38 INFO - 'LANGUAGE': 'en_US:en', 09:40:38 INFO - 'LOGNAME': 'cltbld', 09:40:38 INFO - 'MAIL': '/var/mail/cltbld', 09:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:38 INFO - 'MOZ_NO_REMOTE': '1', 09:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:38 INFO - 'NO_EM_RESTART': '1', 09:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:38 INFO - 'PWD': '/builds/slave/test', 09:40:38 INFO - 'SHELL': '/bin/bash', 09:40:38 INFO - 'SHLVL': '1', 09:40:38 INFO - 'TERM': 'linux', 09:40:38 INFO - 'TMOUT': '86400', 09:40:38 INFO - 'USER': 'cltbld', 09:40:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:38 INFO - '_': '/tools/buildbot/bin/python'} 09:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 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:40:38 INFO - Cleaning up... 09:40:38 INFO - Return code: 0 09:40:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:38 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:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:38 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:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:38 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 0x7ff343c18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, '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': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', '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:40:38 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:40:38 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:40:38 INFO - Using env: {'DISPLAY': ':0', 09:40:38 INFO - 'HOME': '/home/cltbld', 09:40:38 INFO - 'LANG': 'en_US.UTF-8', 09:40:38 INFO - 'LANGUAGE': 'en_US:en', 09:40:38 INFO - 'LOGNAME': 'cltbld', 09:40:38 INFO - 'MAIL': '/var/mail/cltbld', 09:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:38 INFO - 'MOZ_NO_REMOTE': '1', 09:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:38 INFO - 'NO_EM_RESTART': '1', 09:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:38 INFO - 'PWD': '/builds/slave/test', 09:40:38 INFO - 'SHELL': '/bin/bash', 09:40:38 INFO - 'SHLVL': '1', 09:40:38 INFO - 'TERM': 'linux', 09:40:38 INFO - 'TMOUT': '86400', 09:40:38 INFO - 'USER': 'cltbld', 09:40:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:38 INFO - '_': '/tools/buildbot/bin/python'} 09:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:38 INFO - Cleaning up... 09:40:38 INFO - Return code: 0 09:40:38 INFO - Running post-action listener: _resource_record_post_action 09:40:38 INFO - Running post-action listener: _start_resource_monitoring 09:40:38 INFO - Starting resource monitoring. 09:40:38 INFO - [mozharness: 2016-08-11 16:40:38.654201Z] Finished create-virtualenv step (success) 09:40:38 INFO - [mozharness: 2016-08-11 16:40:38.654719Z] Running install step. 09:40:38 INFO - Running pre-action listener: _resource_record_pre_action 09:40:38 INFO - Running main action method: install 09:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:38 INFO - Reading from file tmpfile_stdout 09:40:38 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:38 INFO - Reading from file tmpfile_stdout 09:40:38 INFO - Output received: 09:40:38 INFO - Usage: mozinstall [options] installer 09:40:38 INFO - Options: 09:40:38 INFO - -h, --help show this help message and exit 09:40:38 INFO - -d DEST, --destination=DEST 09:40:38 INFO - Directory to install application into. [default: 09:40:38 INFO - "/builds/slave/test"] 09:40:38 INFO - --app=APP Application being installed. [default: firefox] 09:40:38 INFO - mkdir: /builds/slave/test/build/application 09:40:38 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:40:38 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:40:54 INFO - Reading from file tmpfile_stdout 09:40:54 INFO - Output received: 09:40:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:54 INFO - Running post-action listener: _resource_record_post_action 09:40:54 INFO - [mozharness: 2016-08-11 16:40:54.984605Z] Finished install step (success) 09:40:54 INFO - [mozharness: 2016-08-11 16:40:54.984854Z] Running run-tests step. 09:40:54 INFO - Running pre-action listener: _resource_record_pre_action 09:40:54 INFO - Running main action method: run_tests 09:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:54 INFO - Python 2.7.3 09:40:54 INFO - Return code: 0 09:40:54 INFO - grabbing minidump binary from tooltool 09:40: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:40:54 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 0x29cc090>, '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 0x29cf9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cfe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:54 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:40:54 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:40:54 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:40:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:55 INFO - Return code: 0 09:40:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:40:55 INFO - Using env: {'DISPLAY': ':0', 09:40:55 INFO - 'HOME': '/home/cltbld', 09:40:55 INFO - 'LANG': 'en_US.UTF-8', 09:40:55 INFO - 'LANGUAGE': 'en_US:en', 09:40:55 INFO - 'LOGNAME': 'cltbld', 09:40:55 INFO - 'MAIL': '/var/mail/cltbld', 09:40:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:55 INFO - 'MOZ_NO_REMOTE': '1', 09:40:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:55 INFO - 'NO_EM_RESTART': '1', 09:40:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:55 INFO - 'PWD': '/builds/slave/test', 09:40:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:55 INFO - 'SHELL': '/bin/bash', 09:40:55 INFO - 'SHLVL': '1', 09:40:55 INFO - 'TERM': 'linux', 09:40:55 INFO - 'TMOUT': '86400', 09:40:55 INFO - 'USER': 'cltbld', 09:40:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982', 09:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:55 INFO - '_': '/tools/buildbot/bin/python'} 09:40:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:40:55 INFO - mozversion application_buildid: 20160811083421 09:40:55 INFO - mozversion application_changeset: 26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f 09:40:55 INFO - mozversion application_display_name: Nightly 09:40:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:55 INFO - mozversion application_name: Firefox 09:40:55 INFO - mozversion application_remotingname: firefox 09:40:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:40:55 INFO - mozversion application_vendor: Mozilla 09:40:55 INFO - mozversion application_version: 51.0a1 09:40:55 INFO - mozversion platform_buildid: 20160811083421 09:40:55 INFO - mozversion platform_changeset: 26e7c3afcbada78633a8c6d6e1e11c7b4cebe23f 09:40:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:40:55 INFO - mozversion platform_version: 51.0a1 09:40:55 INFO - using testdate: 1470933655 09:40:55 INFO - actual date: 1470933655 09:40:55 INFO - starting webserver on 'localhost:52417' 09:40:55 INFO - SUITE-START | Running 2 tests 09:40:55 INFO - TEST-START | dromaeo_css 09:40:55 INFO - operating with platform_type : linux_ 09:40:55 INFO - Initialising browser for dromaeo_css test... 09:40:55 INFO - TEST-INFO | started process 15511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUFztr/profile http://localhost:52417/getInfo.html) 09:40:59 INFO - PROCESS | 15511 | __metrics Screen width/height:1600/1200 09:40:59 INFO - PROCESS | 15511 | colorDepth:24 09:40:59 INFO - PROCESS | 15511 | Browser inner width/height: 1024/697 09:40:59 INFO - PROCESS | 15511 | __metrics 09:41:00 INFO - PROCESS | 15511 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:41:00 INFO - PROCESS | 15511 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:01 INFO - TEST-INFO | 15511: exit 0 09:41:01 INFO - Browser initialized. 09:41:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:01 INFO - TEST-INFO | started process 15593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUFztr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:13 INFO - PROCESS | 15593 | RSS: Main: 156844032 09:41:13 INFO - PROCESS | 15593 | 09:42:05 INFO - PROCESS | 15593 | 1470933725260 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] 09:44:17 INFO - PROCESS | 15593 | Cycle 1(1): loaded http://localhost:52417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52417/tests/dromaeo/cssquery-ext.html) 09:44:18 INFO - PROCESS | 15593 | RSS: Main: 235778048 09:44:18 INFO - PROCESS | 15593 | 09:47:21 INFO - PROCESS | 15593 | Cycle 1(1): loaded http://localhost:52417/tests/dromaeo/cssquery-ext.html (next: http://localhost:52417/tests/dromaeo/cssquery-jquery.html) 09:47:21 INFO - PROCESS | 15593 | RSS: Main: 245305344 09:47:21 INFO - PROCESS | 15593 | 09:50:24 INFO - PROCESS | 15593 | Cycle 1(1): loaded http://localhost:52417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52417/tests/dromaeo/cssquery-mootools.html) 09:50:24 INFO - PROCESS | 15593 | RSS: Main: 190349312 09:50:24 INFO - PROCESS | 15593 | 09:53:27 INFO - PROCESS | 15593 | Cycle 1(1): loaded http://localhost:52417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52417/tests/dromaeo/cssquery-prototype.html) 09:53:27 INFO - PROCESS | 15593 | RSS: Main: 192790528 09:53:27 INFO - PROCESS | 15593 | 09:56:30 INFO - PROCESS | 15593 | Cycle 1(1): loaded http://localhost:52417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52417/tests/dromaeo/cssquery-yui.html) 09:56:31 INFO - PROCESS | 15593 | RSS: Main: 187547648 09:56:31 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | Cycle 1(1): loaded http://localhost:52417/tests/dromaeo/cssquery-yui.html (next: http://localhost:52417/tests/dromaeo/cssquery-dojo.html) 09:59:34 INFO - PROCESS | 15593 | RSS: Main: 283734016 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | __start_tp_report 09:59:34 INFO - PROCESS | 15593 | _x_x_mozilla_page_load 09:59:34 INFO - PROCESS | 15593 | _x_x_mozilla_page_load_details 09:59:34 INFO - PROCESS | 15593 | |i|pagename|runs| 09:59:34 INFO - PROCESS | 15593 | |0;dojo.html;2630.6054091886203;2637.854917979511;2651.2841532786147;2671.0384261665795;2683.7584617384446;4692.038132182903;4753.144434001878;4793.185158523051;4874.707517548945;4900.583450406711;4819.349387832642;4854.174790285651;4916.459189489162;4934.432540257872;4969.229769385742;4412.29403295472;4450.955490445102;4493.7977790999485;4521.954780452203;4524.751138687371;4175.519815221258;4443.911121777563;4529.728216307032;4571.108633816407;4613.976930115362;4299.204647140258;4490.057088011522;4496.9325460118125;4528.094381123772;4597.126545956275;4344.45694288214;4388.407564978719;4428.601425871687;4453.242948698697;4517.254652982254;4436.134953684033;4436.578525040116;4440.267355886275;4443.33349997503;4484.686071974963;4848.466668666444;4861.8784530386665;4872.244802055651;4887.120318342697;4896.657233993622;4976.5023497649945;5145.2024936134585;5166.095933211711;5168.8966220675375;5210.687358758449;5202.193659982709;5279.340082489689;5310.36275646921;5315.176147697074;5316.521513063843;4885.706857588556;4887.804487820447;4940.703557786508;4943.826966056206;4944.233643785219;5102.591792656579;5165.9225111623355;5269.604779641542;5331.920021199685;5334.813281535127;5144.356955380577;5145.15105007677;5181.818636347785;5189.247559103909;5198.454162312978;5240.423553409122;5252.816151434681;5260.184671375943;5300.178472336794;5303.390110137307;5015.598752099823;5118.436971933084;5159.045576568272;5173.974130129325;5178.6116041297055;5163.535281824578;5168.405633352213;5176.301199338041;5223.582113430916;5239.1093514102695;4455.064436468313;4456.688031837805;4458.910821783546;4458.9554104459185;4464.888377790517;3746.2320224353944;3749.9250014999548;3847.249786291702;3877.651011408987;3905.1018265798457;4499.1451624191295;4505.05393867285;4507.0309883374575;4551.294549344857;4551.431071116111;5258.316418865523;5265.710385928811;5267;5267.446918073624;5321.680699157985;4331.090471001062;4380.452443444569;4486.214912390318;4499.865004049819;4556.316552517149;4573.771311434415;4589.724616523019;4621.514740952151;4643.349931009661;4669.673122881433;4818.951810481921;4826.493218212177;4831.9275210871865;4833.734144621939;4873.488283730299;4960.900781984412;5144.202648589475;5150.124478838531;5157.6647517911215;5207.791688332576;4804.639652026042;4859.1010663027455;4867;4891.902161956812;4940.851774446773;5092;5095.388553373619;5098.821541246039;5102.1326374515675;5145.305383773292;4942.654014218971;5169.870753231199;5173.92239116406;5185.637005409585;5188.9740551297;5039.823606173766;5059.241113832954;5068.29043933857;5090.287359769562;5121.1550094234035;5069.264956581349;5080.441151473409;5083.288339632529;5086.898262034812;5132.717700526507;4596.218642830794;4975.726335051462;4983.551480366785;5073.16292811682;5074.264231686311;5044.848654540369;5106.208537676666;5116.386033675983;5129.461406552407;5174.97412512935;5002.224655178453;5006.199008158677;5011.323471331323;5018.824341148043;5059.645824792229 09:59:34 INFO - PROCESS | 15593 | |1;ext.html;558.5671104893706;569.228695118115;574.6293640601809;576.3055518100689;577.1429427300458;29122;39722.40416393753;40915.59084409155;41026;44801;41450;41816.37275440871;41946.161076778444;41952;41999.58000419995;7816.609169541529;7941.523508589475;7954.443188976774;7957.960210198941;7960.243776841191;7857.174996625357;7935.603219839014;7948.880766788503;7950.721724739636;7951.244631759973;7947.3642108631175;7985.9600701996405;8001.519908805491;8003;8006;7914.762557123267;7928.8810667840025;7947.165547617533;7956.920430795733;7963.562004089802;7741.496802707806;7789.727359542446;7806.336461400788;7811.062672479282;7819.6481158348015;38470;38709;38736;38779.22441551182;38848.22303553913;3127.702868227515;3137.372525494887;3308.553345298378;3355.8154301513405;3493.179102910814;28995.42009159805;29241.41517169666;29360.559591606143;29497.70502294971;31117.22206944822;3381.205416727067;3384.187794929224;3387.271736576648;3423.6747508986605;3464.7574669773126;259316;260480;260603;260667;261628;32183.356332873213;33223.83388083093;51193;51705.48294517082;51749.741251294254;34184.316313674084;34269.485957710654;34320;34325.485117722754;34363;13557.118787278796;13691.589252322447;13699.863001369858;13712.794308085187;13744.793828092586;10541.051305382553;10549.156067514581;10553.419561924014;10569.365838049742;10586.894131058745;7745.264199901;7925.8811117833275;7958.880616790752;7983.640736166886;8030.718924837603;3093.551435041906;3117.111623187426;3119.828409437457;3144.339688665406;3158.494640857452;815.9102498725135;872.8734333521604;879.9912000879909;928.3668190776862;980.8234517786867;28097.71902280992;28307;28781.28046798847;28894.566581501294;29074;758.3932853717115;943.3019565521465;1008.8587597736323;1013.6908242985812;1015.4009134610615;14533;15252.618684532976;15293.311800968982;15439.382424702886;15612.141332226836;380520;382946;385058;385366;385473;50405.49594504081;50727.7463612687;50782;50869.74565127225;50960.49039509558;1035.140833108518;1136.534021051365;1174.8590169179754;1180.557291015869;1207.070555672145;27415.588766168123;29220.7077929218;29248.56127158052;29334.55998160072;30094.548581770854;43156.13687726291;43608.56391436045;43648;43692;43751.56248437475;296353;298097;298350;299203;299826;25610.487790244464;26136.8693156533;26231.737682623694;27565.86217068902;27742.44515109727;42432.97780340116;42985;43151.568484314754;43171.56828431801;43840;36162.4575631371;36358.8182059088;36779.26441471209;37127.25745485021;37250.6274937258;35697.82151089332;36086.819565902006;36446.27107457783;36705.816470917474;36891.81554092212;35489;35619.28761424705;35840.64159358373;36221.81889090538;36980.63019369772;30173.54739678863;32421.35157296888;32708.34583308368;33127.66872331342;33160.336793263516;24680.753192468565;25358.36604084839;25421.61867572025;25742.227733168034;25878.741212587633 09:59:34 INFO - PROCESS | 15593 | |2;jquery.html;333.24686209167277;345.93081383723245;360.21832623207627;364.3478174068418;381.4564245949523;13359.131656442336;16771.496855094352;17204.65590688187;17948.73076903844;19384.93382863942;17141.057241851693;17549;18439.354622588213;18467.2613095476;18642.067896605182;4780.378550788392;5201.713905735183;5237.423883372826;5241.082810508165;5246.5278124968745;3783.81080945953;5219.086659834533;5289.788408463676;5936.614120082181;6235.06474028897;6222.688865556726;6268.968655156741;6280;6280.246370435554;6287.842803929892;5996.16053752475;6111.052786818028;6112.816615501542;6118.755249790003;6129.080637904305;5250.684958902478;5390.946090539083;5394.298741163663;5398.703071331075;5400.972995134999;21750.519916813235;22129.889350553145;22139.889300553554;22143.557128857494;22934.885325573432;2048.1807277089133;2086.8330533557432;2222.6332655111887;2496.2386472125995;2625.2780485366484;13981.440742370394;14615.78076328856;14788.40846366144;15044.924775376054;15077;1851.583393736412;1856;1914.2056046740586;1931.381957773513;1956.7260583518178;84693.57653211695;85401.57299213526;85586.57206713989;85914.12686985027;87812.56093719555;16435.91782041082;16650.83349166517;17020.65958680844;17337.2198251079;17997.280108795763;29998.550021749692;30055.549166762517;30065.24836879052;30067.849660751996;30114.096577102722;8771.122887711177;8846.734597962071;8936.642534298555;9012.774680633036;9019.729408117766;7266.491345605757;7312.1956584775635;7412.925870741331;7578.658960346797;7919.920800791919;8267.131951145164;8518.957405213057;8567.443116197428;8831.470111793313;8848.778780530538;3065.111147719384;3215.2283451971357;3331.034000139981;3346.2805496817814;3354.832258387071;791.730811524073;842.7977285451448;885.349268287808;923.4090182283344;929.990700093004;16599;17355.47933561995;17556.912215438842;17761.7335739964;18125.456236312933;841.3984001438878;860.9612567434481;874.6763697431863;914.0174312613966;940.5062342270226;9458.810823783624;9951.950240248752;10051.396916185053;10070.244731645156;10237.436940968319;395779;404982;408085;408161;412187;76116.61941690255;77670;78181.60909195531;80737.59631201923;81964;877.2981614708335;891.8974317953518;917.1378903830378;919.6873063158424;920.4615300049412;15393.230338483256;15610.297536610653;15990.68018639644;16196.67606647884;16316.836831632007;37445.6255437453;38775.03062423462;38958.2208355837;39592.40611390774;39679.40480892847;53468;53675.19487207773;54276;56126.158107629235;56498.717506412206;7814.6874125034365;7825.726099586487;8031.1567285434185;8032.718854840053;8072.4349295548745;10185.337953033326;11612.767744645229;11755.177137600285;11816.350100744197;11932.642020739391;9739.561719722771;10156.949215253877;10540.472976351306;10706.625268115578;10748.570057197938;10421.270511064153;10502.10732087781;10559.208059395729;10771.353718776898;10777.08394786452;10377.481125943823;10500.899820035871;10592.788144237225;10666.73333166677;11025.61410350634;7692.884606730791;7789.493682910819;7932.920670793218;8026.197380261927;8070.314023307849;8368;10462.68611941643;10511.842322365017;10537.631182908868;10542.736431589272 09:59:34 INFO - PROCESS | 15593 | |3;mootools.html;1169.2107827216626;1372.9313534323287;1428.7642538981067;1500.9924950375246;1703.3527259641326;6449.193850768654;7281.235470275617;7554.660040298186;7561.924380756198;7757.418193635472;7627.656755446004;7698.230176982299;7699.692012319514;7703.037120359955;7705.961470192655;2168.566286742654;2183.552371763785;2194.3746032380773;2196.615592271346;2197.263916587945;2117.76704562498;2148.0441203664377;2186.8687878727246;2190.9561808763815;2192.2875065603744;2172.9456763580956;2196.5826492966285;2203.9889800551055;2205.3935167828813;2209.3371988403414;2108.9578208435746;2118.8410869184872;2120.226117467121;2127.053461209762;2129.6379615465407;2068.1003763362987;2112.23959374625;2112.450762801667;2113.4399384163207;2113.608982338272;7453.552786832807;7474.476786624884;7558.508696934681;7561.432892533082;7562.319391254813;4300.8709738707885;4491.775411229425;4494.438195225597;4495.460544734653;4502.032063106448;2948.6019387382858;3019.9396012079856;3089.196808829698;3093.3349329893954;3096.876124954999;921.9032001639865;944.3248077624531;945.1399226703667;987.2200961240611;999.0708640963901;10185.541650625739;10260.486975651187;10269.332493387907;10285;10296.176305895586;3883.0874744435037;3962.643362097425;4039.4142849287277;4160.313548264502;4185.100203456272;8302.875456868152;8354.45696029756;8373.623186956602;8389.748307550783;8395.916040839636;4463.4420697412825;4465.620422264144;4467.5532446755715;4467.687261891701;4470.664700147502;3300.93398132036;3898.9805050974564;4050.027993281591;4086.8569600063856;4120.587941205916;3256.9837150814096;3262.070309961697;3371.325734853039;3373.3590617782543;3375.2405708715833;961.7307153996892;967.1972263021676;970.0445061614304;977.1157102821816;981.7825895889189;786.6892577431997;843.1821133500495;855.0338117926827;859.8495263328892;864.1401805203863;4985.326980857611;5226.189940559219;5328.3605967284175;5470.79642478654;5537.252470916455;406.11061774713875;408.5710004495268;421.63739184301477;425.1221228163894;431.99568004320184;3597.5323207982797;3660.6156353583024;3799.2021675447913;3839.865604703878;3935.5670876203594;9306.90693093074;9509.5720692569;9561.474118923526;9567.234621230285;9603.519824008772;9104.180623743894;9247.121523455395;9290.349675522648;9500.952495237618;9506.904930950603;7275;7339.119305683352;7385.22455142213;7389.298016688406;7393.9260607393235;5215.608829337891;5227.973860130675;5288.9735551322;5289.814856480159;5499.917501237404;8417.07412184647;8510.446820956618;8615.267702245128;8631.6978905738;8713.433626814236;8731.345149113715;8913.465192088495;9023;9079.273658107468;9079.409838360485;5452.836414907559;6261.311255761953;6349.809505714836;6353.936460635519;6361.077643741724;7025.121859767529;7160.176579693402;7193.748218812317;7369.115706115301;7374.926250737424;6443.67781610927;6578.80263592093;6753.932460675527;6766.898496522655;6789.694463749044;6560.507961902781;6637.1703537057865;6639.3692599203;6659.300773418721;6712.194536655633;6167.753289868355;6331.525135614939;6340.112384266298;6342.048692696132;6359.268684101387;4627.46784119817;4689.507601701908;4714.292856071616;4772.284157376422;4815.133276010351;4586.4266966629175;4614.976925115353;4620.075984802986;4667.62658987287;4835.806567737392 09:59:34 INFO - PROCESS | 15593 | |4;prototype.html;276.369876681167;283.6851293445485;288.81227202318496;292.8301585080652;294.3113115310174;4900.534449227327;4932.630052746041;4934.901301973963;4944.233643785215;4976.527229913152;4606.723596584207;4734.147853386389;4758.643101767373;4779.80880764769;4903.558679718824;3703.500027496294;3754.2491501699633;3754.6057663945303;3838.9040273993096;3846.9807650961848;3825.7513261637905;3849.5957924417953;3868.458415821773;3872.5546562145432;3876.4106716246347;3568.411212150005;3728.788143853245;3800.7339486235974;3832.9808350958206;3833.5208098987628;3725.329440700673;3746.54601236188;3755.6056614055406;3771.867984620525;3773.33966555853;3280.5079238114236;3290.8683652654104;3293.6870997255223;3299.3566254580364;3301.3397320535987;4706.411698537683;4756.906960937211;4780.904381912377;4792.95207047932;4808.591269742076;4070.531888832763;4245.893852653678;4274.2092712848225;4278.743275403454;4305.13897220554;5081.237814327844;5084.466131056222;5086.210772974121;5094.541491265803;5110.233464980245;3596.615303108296;3597.1726502904216;3597.6762091411897;3599.532060832075;3599.9100022499383;5186.014657215117;5309.362876454811;5330.333708286465;5367.51111777344;5404;3658.231771328051;3662.5421822272215;3664.926701465956;3676.8345424455965;3677.7609455385314;3705.5738590061947;3711.1649878777057;3721.6788040245324;3727.347714150013;3732.570754363283;4268.317069268902;4287.09970906107;4304.536457604429;4315.115401342718;4317.589828966243;4953.702777833341;5053.191489361684;5072.898542029138;5075.8984820303385;5077.8165388883135;1258.7545428641326;1267.1573403686446;1270.6315168601002;1278.2713853103828;1282.7113899372566;785.5483097219122;832.5379414425053;863.6718047142045;864.3992425264381;874.9168828961239;4522.321651752263;4527.547245275512;4528.252838281646;4528.366028755977;4544.522825103382;5193.532582067556;5203.245529398216;5256.369235691665;5274.8945021100135;5289.312389389354;4353.564643535685;4437.267850804646;4465.665075119379;4470.731756094645;4474.32885067236;2727.6590426196726;2733.26201925479;2751.8073734838367;2753;2763.44731053786;4855.951440485621;4862.319275301461;4863.805447782049;4867.123917694849;4876.414830220326;5125.538701516807;5195.584353251731;5207.401148867929;5303.632193557119;5307.4427185145005;4794.2808578713475;4804.855854324376;4842.951570484321;4845.442774080955;4858.611311095104;5140.794368225229;5141.742912854417;5175.948240517547;5179.482051794941;5191.792328306826;4865.5864251539015;5056.494350564914;5087.821926232564;5101.260317254051;5110.744462776772;4835.395575553056;4857.222844344888;4870;4874.122657921466;4880.1215781159735;3611.7652352596997;3633.7274704396746;3639.8180090994815;3640.7633503822167;3652.251288485907;4946.653734238569;5135.974320128375;5163.483651634807;5237.502437268454;5251.212318152155;5077.974610126926;5086.338775959101;5086.465921078234;5096.261042148942;5115.386153661584;5074.873128171826;5106.234064890296;5130.846074617767;5139.820106296262;5143.254228136974;4792.257200133985;4952.4057113146655;4981.950180498148;4993;5043.798248070183;4885.267209918398;4951.9752401237765;5078.47046302816;5106.948930510796;5111.361079865017;5005.4744251853035;5006.349174607278;5007;5022.422421421437;5028.798848046037 09:59:34 INFO - PROCESS | 15593 | |5;yui.html;634.9396807303307;661.0150875195959;686.6463771157852;737.2627372627372;754.2344520311883;12460.563880264193;13879.722405551907;13898.23559704217;13899.722005559908;13922.443102275909;13598;13703.520376786815;13726.107802992798;13726.107802992798;13737.65655858604;624.5440828195398;737.8598066367373;765.9731909383187;779.559548854898;785.9174786647405;776.1384862802284;779.1896427715169;781.3709963479397;781.5584194929875;782.2412260107715;833.3874602167432;834.2950207075012;834.7120243515977;834.7996480844583;835.3692961813822;640;674.0596867370041;819.8319344534356;820.4339006085781;826.8883700700419;495.59856516221976;495.6530428699925;564.1256053117651;595.78253937313;602.7890238416563;12613.054020948466;12636.68408289791;12677.112602117855;12679.556215532411;12739.681507962283;11916.523339066427;12105.334206618632;12213.816792748115;12322.137450378477;13292.73414531704;12183.817242741366;12222.511099556006;12258.938705306506;12598.118131730782;13012.284324362156;4047.797610119482;4115.855945041939;4195.580441955811;4226.154769046203;4236.237477254093;65917.67041164811;66194;66446.66776666134;66764.66617666929;66840.6657966712;10212.693619191436;10460.68617941463;10516.789664206673;10759.569617215224;10859.78280434387;18679;18785.34251301198;18834.434966951012;18940.337088201846;19047.333343332917;6495.350464953467;6678.966605166943;6766.69549870257;6777.390034896883;6935.6878940447805;3656.341858465502;3674.8530058797883;3689.0777305673582;3739.7195210358786;3757.192203676168;2591.8704064796684;2688.9327766805595;2693.192042387276;2704.5402281612173;2713.552263876478;457.8237378609259;463.8724350803556;467.3130498167688;469.99060018799435;473.91469535483253;476.4806361066454;501.6012270245164;537.3820106877123;548.9752961116759;575.6114622629792;7625.771226863203;7836.294733474015;8042.678292868337;8172.7956801080445;8284.751457456287;554.0940562180783;560.3751816724405;569.8689301460604;571.9656820590778;581.2269681323829;3762.8845465037543;3803.980980095082;3863.150106976461;3939.8227079781477;3991.501062367204;53104.468955310724;93164;104939.475302623;106503.46748266365;110377;51388.743056285224;85709.57145214359;89267.55366223128;90138;90227;78461;79760;79799.99999999884;80751;80833.59583202047;7368;7403.962980185064;7563.130240022248;7837.804054898673;7910.881336780068;48014.27978580394;48032;48924.2661360087;49515.50484495253;49856.50143498664;63678.363216367245;64804.35195648172;72157;73358;73660;8989;9446.527673616429;9603.807923841345;9627.759306017126;9763.951180244054;10455.895441045492;10596.735081623021;10754.569817207224;10859.696836379684;11218.495167717636;9934.784660239424;10262.846057308998;10286.691399258034;10371.740706482398;10519.526621302213;8937.553122343987;8999;9061;9080.954595226982;9349.906500934903;9737.318387712792;9748.658796942073;9768.853467197856;9891.406515609087;9989.800203996025;8302.583025830296;8486.787830304293;8515.361347899056;8597.699080532402;8649.3512986525;7868.409869259714;8549.615267313111;8773.341999350201;8802.065903108478;8974.68588599422 09:59:34 INFO - PROCESS | 15593 | __end_tp_report 09:59:34 INFO - PROCESS | 15593 | __start_cc_report 09:59:34 INFO - PROCESS | 15593 | _x_x_mozilla_cycle_collect,1160 09:59:34 INFO - PROCESS | 15593 | __end_cc_report 09:59:34 INFO - PROCESS | 15593 | __startTimestamp1470934774562__endTimestamp 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | ------- Summary: start ------- 09:59:34 INFO - PROCESS | 15593 | Number of tests: 6 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | [#0] dojo.html Cycles:165 Average:4798.40 Median:4940.85 stddev:514.46 (10.4%) stddev-sans-first:487.12 09:59:34 INFO - PROCESS | 15593 | Values: 2630.6 2637.9 2651.3 2671.0 2683.8 4692.0 4753.1 4793.2 4874.7 4900.6 4819.3 4854.2 4916.5 4934.4 4969.2 4412.3 4451.0 4493.8 4522.0 4524.8 4175.5 4443.9 4529.7 4571.1 4614.0 4299.2 4490.1 4496.9 4528.1 4597.1 4344.5 4388.4 4428.6 4453.2 4517.3 4436.1 4436.6 4440.3 4443.3 4484.7 4848.5 4861.9 4872.2 4887.1 4896.7 4976.5 5145.2 5166.1 5168.9 5210.7 5202.2 5279.3 5310.4 5315.2 5316.5 4885.7 4887.8 4940.7 4943.8 4944.2 5102.6 5165.9 5269.6 5331.9 5334.8 5144.4 5145.2 5181.8 5189.2 5198.5 5240.4 5252.8 5260.2 5300.2 5303.4 5015.6 5118.4 5159.0 5174.0 5178.6 5163.5 5168.4 5176.3 5223.6 5239.1 4455.1 4456.7 4458.9 4459.0 4464.9 3746.2 3749.9 3847.2 3877.7 3905.1 4499.1 4505.1 4507.0 4551.3 4551.4 5258.3 5265.7 5267.0 5267.4 5321.7 4331.1 4380.5 4486.2 4499.9 4556.3 4573.8 4589.7 4621.5 4643.3 4669.7 4819.0 4826.5 4831.9 4833.7 4873.5 4960.9 5144.2 5150.1 5157.7 5207.8 4804.6 4859.1 4867.0 4891.9 4940.9 5092.0 5095.4 5098.8 5102.1 5145.3 4942.7 5169.9 5173.9 5185.6 5189.0 5039.8 5059.2 5068.3 5090.3 5121.2 5069.3 5080.4 5083.3 5086.9 5132.7 4596.2 4975.7 4983.6 5073.2 5074.3 5044.8 5106.2 5116.4 5129.5 5175.0 5002.2 5006.2 5011.3 5018.8 5059.6 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | [#1] ext.html Cycles:180 Average:46094.24 Median:36124.64 stddev:83895.54 (232.2%) stddev-sans-first:84061.22 09:59:34 INFO - PROCESS | 15593 | Values: 558.6 569.2 574.6 576.3 577.1 29122.0 39722.4 40915.6 41026.0 44801.0 41450.0 41816.4 41946.2 41952.0 41999.6 7816.6 7941.5 7954.4 7958.0 7960.2 7857.2 7935.6 7948.9 7950.7 7951.2 7947.4 7986.0 8001.5 8003.0 8006.0 7914.8 7928.9 7947.2 7956.9 7963.6 7741.5 7789.7 7806.3 7811.1 7819.6 38470.0 38709.0 38736.0 38779.2 38848.2 3127.7 3137.4 3308.6 3355.8 3493.2 28995.4 29241.4 29360.6 29497.7 31117.2 3381.2 3384.2 3387.3 3423.7 3464.8 259316.0 260480.0 260603.0 260667.0 261628.0 32183.4 33223.8 51193.0 51705.5 51749.7 34184.3 34269.5 34320.0 34325.5 34363.0 13557.1 13691.6 13699.9 13712.8 13744.8 10541.1 10549.2 10553.4 10569.4 10586.9 7745.3 7925.9 7958.9 7983.6 8030.7 3093.6 3117.1 3119.8 3144.3 3158.5 815.9 872.9 880.0 928.4 980.8 28097.7 28307.0 28781.3 28894.6 29074.0 758.4 943.3 1008.9 1013.7 1015.4 14533.0 15252.6 15293.3 15439.4 15612.1 380520.0 382946.0 385058.0 385366.0 385473.0 50405.5 50727.7 50782.0 50869.7 50960.5 1035.1 1136.5 1174.9 1180.6 1207.1 27415.6 29220.7 29248.6 29334.6 30094.5 43156.1 43608.6 43648.0 43692.0 43751.6 296353.0 298097.0 298350.0 299203.0 299826.0 25610.5 26136.9 26231.7 27565.9 27742.4 42433.0 42985.0 43151.6 43171.6 43840.0 36162.5 36358.8 36779.3 37127.3 37250.6 35697.8 36086.8 36446.3 36705.8 36891.8 35489.0 35619.3 35840.6 36221.8 36980.6 30173.5 32421.4 32708.3 33127.7 33160.3 24680.8 25358.4 25421.6 25742.2 25878.7 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | [#2] jquery.html Cycles:180 Average:26650.80 Median:217685.70 stddev:67178.44 (30.9%) stddev-sans-first:67337.83 09:59:34 INFO - PROCESS | 15593 | Values: 333.2 345.9 360.2 364.3 381.5 13359.1 16771.5 17204.7 17948.7 19384.9 17141.1 17549.0 18439.4 18467.3 18642.1 4780.4 5201.7 5237.4 5241.1 5246.5 3783.8 5219.1 5289.8 5936.6 6235.1 6222.7 6269.0 6280.0 6280.2 6287.8 5996.2 6111.1 6112.8 6118.8 6129.1 5250.7 5390.9 5394.3 5398.7 5401.0 21750.5 22129.9 22139.9 22143.6 22934.9 2048.2 2086.8 2222.6 2496.2 2625.3 13981.4 14615.8 14788.4 15044.9 15077.0 1851.6 1856.0 1914.2 1931.4 1956.7 84693.6 85401.6 85586.6 85914.1 87812.6 16435.9 16650.8 17020.7 17337.2 17997.3 29998.6 30055.5 30065.2 30067.8 30114.1 8771.1 8846.7 8936.6 9012.8 9019.7 7266.5 7312.2 7412.9 7578.7 7919.9 8267.1 8519.0 8567.4 8831.5 8848.8 3065.1 3215.2 3331.0 3346.3 3354.8 791.7 842.8 885.3 923.4 930.0 16599.0 17355.5 17556.9 17761.7 18125.5 841.4 861.0 874.7 914.0 940.5 9458.8 9952.0 10051.4 10070.2 10237.4 395779.0 404982.0 408085.0 408161.0 412187.0 76116.6 77670.0 78181.6 80737.6 81964.0 877.3 891.9 917.1 919.7 920.5 15393.2 15610.3 15990.7 16196.7 16316.8 37445.6 38775.0 38958.2 39592.4 39679.4 53468.0 53675.2 54276.0 56126.2 56498.7 7814.7 7825.7 8031.2 8032.7 8072.4 10185.3 11612.8 11755.2 11816.4 11932.6 9739.6 10156.9 10540.5 10706.6 10748.6 10421.3 10502.1 10559.2 10771.4 10777.1 10377.5 10500.9 10592.8 10666.7 11025.6 7692.9 7789.5 7932.9 8026.2 8070.3 8368.0 10462.7 10511.8 10537.6 10542.7 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | [#3] mootools.html Cycles:180 Average:5008.36 Median:5309.09 stddev:2798.97 (52.7%) stddev-sans-first:2791.95 09:59:34 INFO - PROCESS | 15593 | Values: 1169.2 1372.9 1428.8 1501.0 1703.4 6449.2 7281.2 7554.7 7561.9 7757.4 7627.7 7698.2 7699.7 7703.0 7706.0 2168.6 2183.6 2194.4 2196.6 2197.3 2117.8 2148.0 2186.9 2191.0 2192.3 2172.9 2196.6 2204.0 2205.4 2209.3 2109.0 2118.8 2120.2 2127.1 2129.6 2068.1 2112.2 2112.5 2113.4 2113.6 7453.6 7474.5 7558.5 7561.4 7562.3 4300.9 4491.8 4494.4 4495.5 4502.0 2948.6 3019.9 3089.2 3093.3 3096.9 921.9 944.3 945.1 987.2 999.1 10185.5 10260.5 10269.3 10285.0 10296.2 3883.1 3962.6 4039.4 4160.3 4185.1 8302.9 8354.5 8373.6 8389.7 8395.9 4463.4 4465.6 4467.6 4467.7 4470.7 3300.9 3899.0 4050.0 4086.9 4120.6 3257.0 3262.1 3371.3 3373.4 3375.2 961.7 967.2 970.0 977.1 981.8 786.7 843.2 855.0 859.8 864.1 4985.3 5226.2 5328.4 5470.8 5537.3 406.1 408.6 421.6 425.1 432.0 3597.5 3660.6 3799.2 3839.9 3935.6 9306.9 9509.6 9561.5 9567.2 9603.5 9104.2 9247.1 9290.3 9501.0 9506.9 7275.0 7339.1 7385.2 7389.3 7393.9 5215.6 5228.0 5289.0 5289.8 5499.9 8417.1 8510.4 8615.3 8631.7 8713.4 8731.3 8913.5 9023.0 9079.3 9079.4 5452.8 6261.3 6349.8 6353.9 6361.1 7025.1 7160.2 7193.7 7369.1 7374.9 6443.7 6578.8 6753.9 6766.9 6789.7 6560.5 6637.2 6639.4 6659.3 6712.2 6167.8 6331.5 6340.1 6342.0 6359.3 4627.5 4689.5 4714.3 4772.3 4815.1 4586.4 4615.0 4620.1 4667.6 4835.8 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | [#4] prototype.html Cycles:180 Average:4200.71 Median:4806.72 stddev:1224.74 (25.5%) stddev-sans-first:1192.23 09:59:34 INFO - PROCESS | 15593 | Values: 276.4 283.7 288.8 292.8 294.3 4900.5 4932.6 4934.9 4944.2 4976.5 4606.7 4734.1 4758.6 4779.8 4903.6 3703.5 3754.2 3754.6 3838.9 3847.0 3825.8 3849.6 3868.5 3872.6 3876.4 3568.4 3728.8 3800.7 3833.0 3833.5 3725.3 3746.5 3755.6 3771.9 3773.3 3280.5 3290.9 3293.7 3299.4 3301.3 4706.4 4756.9 4780.9 4793.0 4808.6 4070.5 4245.9 4274.2 4278.7 4305.1 5081.2 5084.5 5086.2 5094.5 5110.2 3596.6 3597.2 3597.7 3599.5 3599.9 5186.0 5309.4 5330.3 5367.5 5404.0 3658.2 3662.5 3664.9 3676.8 3677.8 3705.6 3711.2 3721.7 3727.3 3732.6 4268.3 4287.1 4304.5 4315.1 4317.6 4953.7 5053.2 5072.9 5075.9 5077.8 1258.8 1267.2 1270.6 1278.3 1282.7 785.5 832.5 863.7 864.4 874.9 4522.3 4527.5 4528.3 4528.4 4544.5 5193.5 5203.2 5256.4 5274.9 5289.3 4353.6 4437.3 4465.7 4470.7 4474.3 2727.7 2733.3 2751.8 2753.0 2763.4 4856.0 4862.3 4863.8 4867.1 4876.4 5125.5 5195.6 5207.4 5303.6 5307.4 4794.3 4804.9 4843.0 4845.4 4858.6 5140.8 5141.7 5175.9 5179.5 5191.8 4865.6 5056.5 5087.8 5101.3 5110.7 4835.4 4857.2 4870.0 4874.1 4880.1 3611.8 3633.7 3639.8 3640.8 3652.3 4946.7 5136.0 5163.5 5237.5 5251.2 5078.0 5086.3 5086.5 5096.3 5115.4 5074.9 5106.2 5130.8 5139.8 5143.3 4792.3 4952.4 4982.0 4993.0 5043.8 4885.3 4952.0 5078.5 5106.9 5111.4 5005.5 5006.3 5007.0 5022.4 5028.8 09:59:34 INFO - PROCESS | 15593 | 09:59:34 INFO - PROCESS | 15593 | [#5] yui.html Cycles:180 Average:17865.91 Median:578.42 stddev:26307.43 (4548.2%) stddev-sans-first:26349.41 09:59:34 INFO - PROCESS | 15593 | Values: 634.9 661.0 686.6 737.3 754.2 12460.6 13879.7 13898.2 13899.7 13922.4 13598.0 13703.5 13726.1 13726.1 13737.7 624.5 737.9 766.0 779.6 785.9 776.1 779.2 781.4 781.6 782.2 833.4 834.3 834.7 834.8 835.4 640.0 674.1 819.8 820.4 826.9 495.6 495.7 564.1 595.8 602.8 12613.1 12636.7 12677.1 12679.6 12739.7 11916.5 12105.3 12213.8 12322.1 13292.7 12183.8 12222.5 12258.9 12598.1 13012.3 4047.8 4115.9 4195.6 4226.2 4236.2 65917.7 66194.0 66446.7 66764.7 66840.7 10212.7 10460.7 10516.8 10759.6 10859.8 18679.0 18785.3 18834.4 18940.3 19047.3 6495.4 6679.0 6766.7 6777.4 6935.7 3656.3 3674.9 3689.1 3739.7 3757.2 2591.9 2688.9 2693.2 2704.5 2713.6 457.8 463.9 467.3 470.0 473.9 476.5 501.6 537.4 549.0 575.6 7625.8 7836.3 8042.7 8172.8 8284.8 554.1 560.4 569.9 572.0 581.2 3762.9 3804.0 3863.2 3939.8 3991.5 53104.5 93164.0 104939.5 106503.5 110377.0 51388.7 85709.6 89267.6 90138.0 90227.0 78461.0 79760.0 79800.0 80751.0 80833.6 7368.0 7404.0 7563.1 7837.8 7910.9 48014.3 48032.0 48924.3 49515.5 49856.5 63678.4 64804.4 72157.0 73358.0 73660.0 8989.0 9446.5 9603.8 9627.8 9764.0 10455.9 10596.7 10754.6 10859.7 11218.5 9934.8 10262.8 10286.7 10371.7 10519.5 8937.6 8999.0 9061.0 9081.0 9349.9 9737.3 9748.7 9768.9 9891.4 9989.8 8302.6 8486.8 8515.4 8597.7 8649.4 7868.4 8549.6 8773.3 8802.1 8974.7 09:59:34 INFO - PROCESS | 15593 | -------- Summary: end -------- 09:59:34 INFO - PROCESS | 15593 | 09:59:35 INFO - TEST-INFO | 15593: exit 0 09:59:35 INFO - TEST-OK | dromaeo_css | took 1120137ms 09:59:35 INFO - TEST-START | kraken 09:59:35 INFO - operating with platform_type : linux_ 09:59:35 INFO - Initialising browser for kraken test... 09:59:35 INFO - TEST-INFO | started process 15891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo56QxO/profile http://localhost:52417/getInfo.html) 09:59:39 INFO - PROCESS | 15891 | __metrics Screen width/height:1600/1200 09:59:39 INFO - PROCESS | 15891 | colorDepth:24 09:59:39 INFO - PROCESS | 15891 | Browser inner width/height: 1024/697 09:59:39 INFO - PROCESS | 15891 | __metrics 09:59:40 INFO - PROCESS | 15891 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:59:40 INFO - PROCESS | 15891 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:41 INFO - TEST-INFO | 15891: exit 0 09:59:41 INFO - Browser initialized. 09:59:41 INFO - Running cycle 1/1 for kraken test... 09:59:41 INFO - TEST-INFO | started process 15972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo56QxO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:53 INFO - PROCESS | 15972 | RSS: Main: 157642752 09:59:53 INFO - PROCESS | 15972 | 09:59:56 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52417/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:57 INFO - PROCESS | 15972 | RSS: Main: 212869120 09:59:57 INFO - PROCESS | 15972 | 10:00:00 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52417/tests/kraken/driver.html?testName=audio-dft) 10:00:00 INFO - PROCESS | 15972 | RSS: Main: 192262144 10:00:00 INFO - PROCESS | 15972 | 10:00:03 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52417/tests/kraken/driver.html?testName=audio-fft) 10:00:04 INFO - PROCESS | 15972 | RSS: Main: 271945728 10:00:04 INFO - PROCESS | 15972 | 10:00:06 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52417/tests/kraken/driver.html?testName=audio-oscillator) 10:00:07 INFO - PROCESS | 15972 | RSS: Main: 179425280 10:00:07 INFO - PROCESS | 15972 | 10:00:09 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:00:10 INFO - PROCESS | 15972 | RSS: Main: 184320000 10:00:10 INFO - PROCESS | 15972 | 10:00:13 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52417/tests/kraken/driver.html?testName=imaging-darkroom) 10:00:13 INFO - PROCESS | 15972 | RSS: Main: 220508160 10:00:13 INFO - PROCESS | 15972 | 10:00:17 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52417/tests/kraken/driver.html?testName=imaging-desaturate) 10:00:18 INFO - PROCESS | 15972 | RSS: Main: 214462464 10:00:18 INFO - PROCESS | 15972 | 10:00:20 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52417/tests/kraken/driver.html?testName=json-parse-financial) 10:00:21 INFO - PROCESS | 15972 | RSS: Main: 218091520 10:00:21 INFO - PROCESS | 15972 | 10:00:23 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:23 INFO - PROCESS | 15972 | RSS: Main: 181837824 10:00:23 INFO - PROCESS | 15972 | 10:00:25 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:00:26 INFO - PROCESS | 15972 | RSS: Main: 188612608 10:00:26 INFO - PROCESS | 15972 | 10:00:28 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:00:29 INFO - PROCESS | 15972 | RSS: Main: 193495040 10:00:29 INFO - PROCESS | 15972 | 10:00:31 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:32 INFO - PROCESS | 15972 | RSS: Main: 188563456 10:00:32 INFO - PROCESS | 15972 | 10:00:35 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:36 INFO - PROCESS | 15972 | RSS: Main: 191328256 10:00:36 INFO - PROCESS | 15972 | 10:00:37 INFO - PROCESS | 15972 | Cycle 1(1): loaded http://localhost:52417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52417/tests/kraken/driver.html?testName=ai-astar) 10:00:38 INFO - PROCESS | 15972 | RSS: Main: 241930240 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | __start_tp_report 10:00:38 INFO - PROCESS | 15972 | _x_x_mozilla_page_load 10:00:38 INFO - PROCESS | 15972 | _x_x_mozilla_page_load_details 10:00:38 INFO - PROCESS | 15972 | |i|pagename|runs| 10:00:38 INFO - PROCESS | 15972 | |0;ai-astar;105;115;113;114;114;115;114;114;114;115 10:00:38 INFO - PROCESS | 15972 | |1;audio-beat-detection;148;128;125;196;128;128;151;123;175;123 10:00:38 INFO - PROCESS | 15972 | |2;audio-dft;161;163;163;164;164;163;163;161;161;164 10:00:38 INFO - PROCESS | 15972 | |3;audio-fft;75;76;76;106;76;76;74;75;99;75 10:00:38 INFO - PROCESS | 15972 | |4;audio-oscillator;84;85;129;84;85;84;117;85;86;120 10:00:38 INFO - PROCESS | 15972 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 10:00:38 INFO - PROCESS | 15972 | |6;imaging-darkroom;150;149;150;149;148;148;148;148;149;146 10:00:38 INFO - PROCESS | 15972 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;96;95 10:00:38 INFO - PROCESS | 15972 | |8;json-parse-financial;63;71;62;63;62;62;63;72;62;64 10:00:38 INFO - PROCESS | 15972 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;65;65;65 10:00:38 INFO - PROCESS | 15972 | |10;stanford-crypto-aes;79;81;80;79;83;85;79;81;79;78 10:00:38 INFO - PROCESS | 15972 | |11;stanford-crypto-ccm;137;132;139;130;128;131;127;131;158;131 10:00:38 INFO - PROCESS | 15972 | |12;stanford-crypto-pbkdf2;173;169;166;176;171;173;166;171;169;166 10:00:38 INFO - PROCESS | 15972 | |13;stanford-crypto-sha256-iterative;68;68;67;68;67;68;69;67;65;70 10:00:38 INFO - PROCESS | 15972 | __end_tp_report 10:00:38 INFO - PROCESS | 15972 | __start_cc_report 10:00:38 INFO - PROCESS | 15972 | _x_x_mozilla_cycle_collect,1929 10:00:38 INFO - PROCESS | 15972 | __end_cc_report 10:00:38 INFO - PROCESS | 15972 | __startTimestamp1470934838118__endTimestamp 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | ------- Summary: start ------- 10:00:38 INFO - PROCESS | 15972 | Number of tests: 14 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:0.67 10:00:38 INFO - PROCESS | 15972 | Values: 105.0 115.0 113.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:138.00 stddev:25.21 (18.3%) stddev-sans-first:26.66 10:00:38 INFO - PROCESS | 15972 | Values: 148.0 128.0 125.0 196.0 128.0 128.0 151.0 123.0 175.0 123.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 10:00:38 INFO - PROCESS | 15972 | Values: 161.0 163.0 163.0 164.0 164.0 163.0 163.0 161.0 161.0 164.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.57 (15.2%) stddev-sans-first:12.08 10:00:38 INFO - PROCESS | 15972 | Values: 75.0 76.0 76.0 106.0 76.0 76.0 74.0 75.0 99.0 75.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.50 stddev:18.26 (21.6%) stddev-sans-first:18.85 10:00:38 INFO - PROCESS | 15972 | Values: 84.0 85.0 129.0 84.0 85.0 84.0 117.0 85.0 86.0 120.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:00:38 INFO - PROCESS | 15972 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.18 (0.8%) stddev-sans-first:1.12 10:00:38 INFO - PROCESS | 15972 | Values: 150.0 149.0 150.0 149.0 148.0 148.0 148.0 148.0 149.0 146.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:00:38 INFO - PROCESS | 15972 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:63.00 stddev:3.81 (6.0%) stddev-sans-first:4.00 10:00:38 INFO - PROCESS | 15972 | Values: 63.0 71.0 62.0 63.0 62.0 62.0 63.0 72.0 62.0 64.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 10:00:38 INFO - PROCESS | 15972 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:2.17 (2.7%) stddev-sans-first:2.24 10:00:38 INFO - PROCESS | 15972 | Values: 79.0 81.0 80.0 79.0 83.0 85.0 79.0 81.0 79.0 78.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:131.50 stddev:9.07 (6.9%) stddev-sans-first:9.57 10:00:38 INFO - PROCESS | 15972 | Values: 137.0 132.0 139.0 130.0 128.0 131.0 127.0 131.0 158.0 131.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.00 stddev:3.43 (2.0%) stddev-sans-first:3.46 10:00:38 INFO - PROCESS | 15972 | Values: 173.0 169.0 166.0 176.0 171.0 173.0 166.0 171.0 169.0 166.0 10:00:38 INFO - PROCESS | 15972 | 10:00:38 INFO - PROCESS | 15972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.41 10:00:38 INFO - PROCESS | 15972 | Values: 68.0 68.0 67.0 68.0 67.0 68.0 69.0 67.0 65.0 70.0 10:00:38 INFO - PROCESS | 15972 | -------- Summary: end -------- 10:00:38 INFO - PROCESS | 15972 | 10:00:39 INFO - TEST-INFO | 15972: exit 0 10:00:39 INFO - TEST-OK | kraken | took 63898ms 10:00:39 INFO - SUITE-END | took 1184s 10:00:39 INFO - Completed test suite (00:19:44) 10:00:39 INFO - javascript benchmark 10:00:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.6054091886203, 2637.854917979511, 2651.2841532786147, 2671.0384261665795, 2683.7584617384446, 4692.038132182903, 4753.144434001878, 4793.185158523051, 4874.707517548945, 4900.583450406711, 4819.349387832642, 4854.174790285651, 4916.459189489162, 4934.432540257872, 4969.229769385742, 4412.29403295472, 4450.955490445102, 4493.7977790999485, 4521.954780452203, 4524.751138687371, 4175.519815221258, 4443.911121777563, 4529.728216307032, 4571.108633816407, 4613.976930115362, 4299.204647140258, 4490.057088011522, 4496.9325460118125, 4528.094381123772, 4597.126545956275, 4344.45694288214, 4388.407564978719, 4428.601425871687, 4453.242948698697, 4517.254652982254, 4436.134953684033, 4436.578525040116, 4440.267355886275, 4443.33349997503, 4484.686071974963, 4848.466668666444, 4861.8784530386665, 4872.244802055651, 4887.120318342697, 4896.657233993622, 4976.5023497649945, 5145.2024936134585, 5166.095933211711, 5168.8966220675375, 5210.687358758449, 5202.193659982709, 5279.340082489689, 5310.36275646921, 5315.176147697074, 5316.521513063843, 4885.706857588556, 4887.804487820447, 4940.703557786508, 4943.826966056206, 4944.233643785219, 5102.591792656579, 5165.9225111623355, 5269.604779641542, 5331.920021199685, 5334.813281535127, 5144.356955380577, 5145.15105007677, 5181.818636347785, 5189.247559103909, 5198.454162312978, 5240.423553409122, 5252.816151434681, 5260.184671375943, 5300.178472336794, 5303.390110137307, 5015.598752099823, 5118.436971933084, 5159.045576568272, 5173.974130129325, 5178.6116041297055, 5163.535281824578, 5168.405633352213, 5176.301199338041, 5223.582113430916, 5239.1093514102695, 4455.064436468313, 4456.688031837805, 4458.910821783546, 4458.9554104459185, 4464.888377790517, 3746.2320224353944, 3749.9250014999548, 3847.249786291702, 3877.651011408987, 3905.1018265798457, 4499.1451624191295, 4505.05393867285, 4507.0309883374575, 4551.294549344857, 4551.431071116111, 5258.316418865523, 5265.710385928811, 5267.0, 5267.446918073624, 5321.680699157985, 4331.090471001062, 4380.452443444569, 4486.214912390318, 4499.865004049819, 4556.316552517149, 4573.771311434415, 4589.724616523019, 4621.514740952151, 4643.349931009661, 4669.673122881433, 4818.951810481921, 4826.493218212177, 4831.9275210871865, 4833.734144621939, 4873.488283730299, 4960.900781984412, 5144.202648589475, 5150.124478838531, 5157.6647517911215, 5207.791688332576, 4804.639652026042, 4859.1010663027455, 4867.0, 4891.902161956812, 4940.851774446773, 5092.0, 5095.388553373619, 5098.821541246039, 5102.1326374515675, 5145.305383773292, 4942.654014218971, 5169.870753231199, 5173.92239116406, 5185.637005409585, 5188.9740551297, 5039.823606173766, 5059.241113832954, 5068.29043933857, 5090.287359769562, 5121.1550094234035, 5069.264956581349, 5080.441151473409, 5083.288339632529, 5086.898262034812, 5132.717700526507, 4596.218642830794, 4975.726335051462, 4983.551480366785, 5073.16292811682, 5074.264231686311, 5044.848654540369, 5106.208537676666, 5116.386033675983, 5129.461406552407, 5174.97412512935, 5002.224655178453, 5006.199008158677, 5011.323471331323, 5018.824341148043, 5059.645824792229], "value": 4764.672398580328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5671104893706, 569.228695118115, 574.6293640601809, 576.3055518100689, 577.1429427300458, 29122.0, 39722.40416393753, 40915.59084409155, 41026.0, 44801.0, 41450.0, 41816.37275440871, 41946.161076778444, 41952.0, 41999.58000419995, 7816.609169541529, 7941.523508589475, 7954.443188976774, 7957.960210198941, 7960.243776841191, 7857.174996625357, 7935.603219839014, 7948.880766788503, 7950.721724739636, 7951.244631759973, 7947.3642108631175, 7985.9600701996405, 8001.519908805491, 8003.0, 8006.0, 7914.762557123267, 7928.8810667840025, 7947.165547617533, 7956.920430795733, 7963.562004089802, 7741.496802707806, 7789.727359542446, 7806.336461400788, 7811.062672479282, 7819.6481158348015, 38470.0, 38709.0, 38736.0, 38779.22441551182, 38848.22303553913, 3127.702868227515, 3137.372525494887, 3308.553345298378, 3355.8154301513405, 3493.179102910814, 28995.42009159805, 29241.41517169666, 29360.559591606143, 29497.70502294971, 31117.22206944822, 3381.205416727067, 3384.187794929224, 3387.271736576648, 3423.6747508986605, 3464.7574669773126, 259316.0, 260480.0, 260603.0, 260667.0, 261628.0, 32183.356332873213, 33223.83388083093, 51193.0, 51705.48294517082, 51749.741251294254, 34184.316313674084, 34269.485957710654, 34320.0, 34325.485117722754, 34363.0, 13557.118787278796, 13691.589252322447, 13699.863001369858, 13712.794308085187, 13744.793828092586, 10541.051305382553, 10549.156067514581, 10553.419561924014, 10569.365838049742, 10586.894131058745, 7745.264199901, 7925.8811117833275, 7958.880616790752, 7983.640736166886, 8030.718924837603, 3093.551435041906, 3117.111623187426, 3119.828409437457, 3144.339688665406, 3158.494640857452, 815.9102498725135, 872.8734333521604, 879.9912000879909, 928.3668190776862, 980.8234517786867, 28097.71902280992, 28307.0, 28781.28046798847, 28894.566581501294, 29074.0, 758.3932853717115, 943.3019565521465, 1008.8587597736323, 1013.6908242985812, 1015.4009134610615, 14533.0, 15252.618684532976, 15293.311800968982, 15439.382424702886, 15612.141332226836, 380520.0, 382946.0, 385058.0, 385366.0, 385473.0, 50405.49594504081, 50727.7463612687, 50782.0, 50869.74565127225, 50960.49039509558, 1035.140833108518, 1136.534021051365, 1174.8590169179754, 1180.557291015869, 1207.070555672145, 27415.588766168123, 29220.7077929218, 29248.56127158052, 29334.55998160072, 30094.548581770854, 43156.13687726291, 43608.56391436045, 43648.0, 43692.0, 43751.56248437475, 296353.0, 298097.0, 298350.0, 299203.0, 299826.0, 25610.487790244464, 26136.8693156533, 26231.737682623694, 27565.86217068902, 27742.44515109727, 42432.97780340116, 42985.0, 43151.568484314754, 43171.56828431801, 43840.0, 36162.4575631371, 36358.8182059088, 36779.26441471209, 37127.25745485021, 37250.6274937258, 35697.82151089332, 36086.819565902006, 36446.27107457783, 36705.816470917474, 36891.81554092212, 35489.0, 35619.28761424705, 35840.64159358373, 36221.81889090538, 36980.63019369772, 30173.54739678863, 32421.35157296888, 32708.34583308368, 33127.66872331342, 33160.336793263516, 24680.753192468565, 25358.36604084839, 25421.61867572025, 25742.227733168034, 25878.741212587633], "value": 16548.047103268684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.24686209167277, 345.93081383723245, 360.21832623207627, 364.3478174068418, 381.4564245949523, 13359.131656442336, 16771.496855094352, 17204.65590688187, 17948.73076903844, 19384.93382863942, 17141.057241851693, 17549.0, 18439.354622588213, 18467.2613095476, 18642.067896605182, 4780.378550788392, 5201.713905735183, 5237.423883372826, 5241.082810508165, 5246.5278124968745, 3783.81080945953, 5219.086659834533, 5289.788408463676, 5936.614120082181, 6235.06474028897, 6222.688865556726, 6268.968655156741, 6280.0, 6280.246370435554, 6287.842803929892, 5996.16053752475, 6111.052786818028, 6112.816615501542, 6118.755249790003, 6129.080637904305, 5250.684958902478, 5390.946090539083, 5394.298741163663, 5398.703071331075, 5400.972995134999, 21750.519916813235, 22129.889350553145, 22139.889300553554, 22143.557128857494, 22934.885325573432, 2048.1807277089133, 2086.8330533557432, 2222.6332655111887, 2496.2386472125995, 2625.2780485366484, 13981.440742370394, 14615.78076328856, 14788.40846366144, 15044.924775376054, 15077.0, 1851.583393736412, 1856.0, 1914.2056046740586, 1931.381957773513, 1956.7260583518178, 84693.57653211695, 85401.57299213526, 85586.57206713989, 85914.12686985027, 87812.56093719555, 16435.91782041082, 16650.83349166517, 17020.65958680844, 17337.2198251079, 17997.280108795763, 29998.550021749692, 30055.549166762517, 30065.24836879052, 30067.849660751996, 30114.096577102722, 8771.122887711177, 8846.734597962071, 8936.642534298555, 9012.774680633036, 9019.729408117766, 7266.491345605757, 7312.1956584775635, 7412.925870741331, 7578.658960346797, 7919.920800791919, 8267.131951145164, 8518.957405213057, 8567.443116197428, 8831.470111793313, 8848.778780530538, 3065.111147719384, 3215.2283451971357, 3331.034000139981, 3346.2805496817814, 3354.832258387071, 791.730811524073, 842.7977285451448, 885.349268287808, 923.4090182283344, 929.990700093004, 16599.0, 17355.47933561995, 17556.912215438842, 17761.7335739964, 18125.456236312933, 841.3984001438878, 860.9612567434481, 874.6763697431863, 914.0174312613966, 940.5062342270226, 9458.810823783624, 9951.950240248752, 10051.396916185053, 10070.244731645156, 10237.436940968319, 395779.0, 404982.0, 408085.0, 408161.0, 412187.0, 76116.61941690255, 77670.0, 78181.60909195531, 80737.59631201923, 81964.0, 877.2981614708335, 891.8974317953518, 917.1378903830378, 919.6873063158424, 920.4615300049412, 15393.230338483256, 15610.297536610653, 15990.68018639644, 16196.67606647884, 16316.836831632007, 37445.6255437453, 38775.03062423462, 38958.2208355837, 39592.40611390774, 39679.40480892847, 53468.0, 53675.19487207773, 54276.0, 56126.158107629235, 56498.717506412206, 7814.6874125034365, 7825.726099586487, 8031.1567285434185, 8032.718854840053, 8072.4349295548745, 10185.337953033326, 11612.767744645229, 11755.177137600285, 11816.350100744197, 11932.642020739391, 9739.561719722771, 10156.949215253877, 10540.472976351306, 10706.625268115578, 10748.570057197938, 10421.270511064153, 10502.10732087781, 10559.208059395729, 10771.353718776898, 10777.08394786452, 10377.481125943823, 10500.899820035871, 10592.788144237225, 10666.73333166677, 11025.61410350634, 7692.884606730791, 7789.493682910819, 7932.920670793218, 8026.197380261927, 8070.314023307849, 8368.0, 10462.68611941643, 10511.842322365017, 10537.631182908868, 10542.736431589272], "value": 9327.534310547442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1169.2107827216626, 1372.9313534323287, 1428.7642538981067, 1500.9924950375246, 1703.3527259641326, 6449.193850768654, 7281.235470275617, 7554.660040298186, 7561.924380756198, 7757.418193635472, 7627.656755446004, 7698.230176982299, 7699.692012319514, 7703.037120359955, 7705.961470192655, 2168.566286742654, 2183.552371763785, 2194.3746032380773, 2196.615592271346, 2197.263916587945, 2117.76704562498, 2148.0441203664377, 2186.8687878727246, 2190.9561808763815, 2192.2875065603744, 2172.9456763580956, 2196.5826492966285, 2203.9889800551055, 2205.3935167828813, 2209.3371988403414, 2108.9578208435746, 2118.8410869184872, 2120.226117467121, 2127.053461209762, 2129.6379615465407, 2068.1003763362987, 2112.23959374625, 2112.450762801667, 2113.4399384163207, 2113.608982338272, 7453.552786832807, 7474.476786624884, 7558.508696934681, 7561.432892533082, 7562.319391254813, 4300.8709738707885, 4491.775411229425, 4494.438195225597, 4495.460544734653, 4502.032063106448, 2948.6019387382858, 3019.9396012079856, 3089.196808829698, 3093.3349329893954, 3096.876124954999, 921.9032001639865, 944.3248077624531, 945.1399226703667, 987.2200961240611, 999.0708640963901, 10185.541650625739, 10260.486975651187, 10269.332493387907, 10285.0, 10296.176305895586, 3883.0874744435037, 3962.643362097425, 4039.4142849287277, 4160.313548264502, 4185.100203456272, 8302.875456868152, 8354.45696029756, 8373.623186956602, 8389.748307550783, 8395.916040839636, 4463.4420697412825, 4465.620422264144, 4467.5532446755715, 4467.687261891701, 4470.664700147502, 3300.93398132036, 3898.9805050974564, 4050.027993281591, 4086.8569600063856, 4120.587941205916, 3256.9837150814096, 3262.070309961697, 3371.325734853039, 3373.3590617782543, 3375.2405708715833, 961.7307153996892, 967.1972263021676, 970.0445061614304, 977.1157102821816, 981.7825895889189, 786.6892577431997, 843.1821133500495, 855.0338117926827, 859.8495263328892, 864.1401805203863, 4985.326980857611, 5226.189940559219, 5328.3605967284175, 5470.79642478654, 5537.252470916455, 406.11061774713875, 408.5710004495268, 421.63739184301477, 425.1221228163894, 431.99568004320184, 3597.5323207982797, 3660.6156353583024, 3799.2021675447913, 3839.865604703878, 3935.5670876203594, 9306.90693093074, 9509.5720692569, 9561.474118923526, 9567.234621230285, 9603.519824008772, 9104.180623743894, 9247.121523455395, 9290.349675522648, 9500.952495237618, 9506.904930950603, 7275.0, 7339.119305683352, 7385.22455142213, 7389.298016688406, 7393.9260607393235, 5215.608829337891, 5227.973860130675, 5288.9735551322, 5289.814856480159, 5499.917501237404, 8417.07412184647, 8510.446820956618, 8615.267702245128, 8631.6978905738, 8713.433626814236, 8731.345149113715, 8913.465192088495, 9023.0, 9079.273658107468, 9079.409838360485, 5452.836414907559, 6261.311255761953, 6349.809505714836, 6353.936460635519, 6361.077643741724, 7025.121859767529, 7160.176579693402, 7193.748218812317, 7369.115706115301, 7374.926250737424, 6443.67781610927, 6578.80263592093, 6753.932460675527, 6766.898496522655, 6789.694463749044, 6560.507961902781, 6637.1703537057865, 6639.3692599203, 6659.300773418721, 6712.194536655633, 6167.753289868355, 6331.525135614939, 6340.112384266298, 6342.048692696132, 6359.268684101387, 4627.46784119817, 4689.507601701908, 4714.292856071616, 4772.284157376422, 4815.133276010351, 4586.4266966629175, 4614.976925115353, 4620.075984802986, 4667.62658987287, 4835.806567737392], "value": 3973.2275064592745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.369876681167, 283.6851293445485, 288.81227202318496, 292.8301585080652, 294.3113115310174, 4900.534449227327, 4932.630052746041, 4934.901301973963, 4944.233643785215, 4976.527229913152, 4606.723596584207, 4734.147853386389, 4758.643101767373, 4779.80880764769, 4903.558679718824, 3703.500027496294, 3754.2491501699633, 3754.6057663945303, 3838.9040273993096, 3846.9807650961848, 3825.7513261637905, 3849.5957924417953, 3868.458415821773, 3872.5546562145432, 3876.4106716246347, 3568.411212150005, 3728.788143853245, 3800.7339486235974, 3832.9808350958206, 3833.5208098987628, 3725.329440700673, 3746.54601236188, 3755.6056614055406, 3771.867984620525, 3773.33966555853, 3280.5079238114236, 3290.8683652654104, 3293.6870997255223, 3299.3566254580364, 3301.3397320535987, 4706.411698537683, 4756.906960937211, 4780.904381912377, 4792.95207047932, 4808.591269742076, 4070.531888832763, 4245.893852653678, 4274.2092712848225, 4278.743275403454, 4305.13897220554, 5081.237814327844, 5084.466131056222, 5086.210772974121, 5094.541491265803, 5110.233464980245, 3596.615303108296, 3597.1726502904216, 3597.6762091411897, 3599.532060832075, 3599.9100022499383, 5186.014657215117, 5309.362876454811, 5330.333708286465, 5367.51111777344, 5404.0, 3658.231771328051, 3662.5421822272215, 3664.926701465956, 3676.8345424455965, 3677.7609455385314, 3705.5738590061947, 3711.1649878777057, 3721.6788040245324, 3727.347714150013, 3732.570754363283, 4268.317069268902, 4287.09970906107, 4304.536457604429, 4315.115401342718, 4317.589828966243, 4953.702777833341, 5053.191489361684, 5072.898542029138, 5075.8984820303385, 5077.8165388883135, 1258.7545428641326, 1267.1573403686446, 1270.6315168601002, 1278.2713853103828, 1282.7113899372566, 785.5483097219122, 832.5379414425053, 863.6718047142045, 864.3992425264381, 874.9168828961239, 4522.321651752263, 4527.547245275512, 4528.252838281646, 4528.366028755977, 4544.522825103382, 5193.532582067556, 5203.245529398216, 5256.369235691665, 5274.8945021100135, 5289.312389389354, 4353.564643535685, 4437.267850804646, 4465.665075119379, 4470.731756094645, 4474.32885067236, 2727.6590426196726, 2733.26201925479, 2751.8073734838367, 2753.0, 2763.44731053786, 4855.951440485621, 4862.319275301461, 4863.805447782049, 4867.123917694849, 4876.414830220326, 5125.538701516807, 5195.584353251731, 5207.401148867929, 5303.632193557119, 5307.4427185145005, 4794.2808578713475, 4804.855854324376, 4842.951570484321, 4845.442774080955, 4858.611311095104, 5140.794368225229, 5141.742912854417, 5175.948240517547, 5179.482051794941, 5191.792328306826, 4865.5864251539015, 5056.494350564914, 5087.821926232564, 5101.260317254051, 5110.744462776772, 4835.395575553056, 4857.222844344888, 4870.0, 4874.122657921466, 4880.1215781159735, 3611.7652352596997, 3633.7274704396746, 3639.8180090994815, 3640.7633503822167, 3652.251288485907, 4946.653734238569, 5135.974320128375, 5163.483651634807, 5237.502437268454, 5251.212318152155, 5077.974610126926, 5086.338775959101, 5086.465921078234, 5096.261042148942, 5115.386153661584, 5074.873128171826, 5106.234064890296, 5130.846074617767, 5139.820106296262, 5143.254228136974, 4792.257200133985, 4952.4057113146655, 4981.950180498148, 4993.0, 5043.798248070183, 4885.267209918398, 4951.9752401237765, 5078.47046302816, 5106.948930510796, 5111.361079865017, 5005.4744251853035, 5006.349174607278, 5007.0, 5022.422421421437, 5028.798848046037], "value": 3805.6984275069267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.9396807303307, 661.0150875195959, 686.6463771157852, 737.2627372627372, 754.2344520311883, 12460.563880264193, 13879.722405551907, 13898.23559704217, 13899.722005559908, 13922.443102275909, 13598.0, 13703.520376786815, 13726.107802992798, 13726.107802992798, 13737.65655858604, 624.5440828195398, 737.8598066367373, 765.9731909383187, 779.559548854898, 785.9174786647405, 776.1384862802284, 779.1896427715169, 781.3709963479397, 781.5584194929875, 782.2412260107715, 833.3874602167432, 834.2950207075012, 834.7120243515977, 834.7996480844583, 835.3692961813822, 640.0, 674.0596867370041, 819.8319344534356, 820.4339006085781, 826.8883700700419, 495.59856516221976, 495.6530428699925, 564.1256053117651, 595.78253937313, 602.7890238416563, 12613.054020948466, 12636.68408289791, 12677.112602117855, 12679.556215532411, 12739.681507962283, 11916.523339066427, 12105.334206618632, 12213.816792748115, 12322.137450378477, 13292.73414531704, 12183.817242741366, 12222.511099556006, 12258.938705306506, 12598.118131730782, 13012.284324362156, 4047.797610119482, 4115.855945041939, 4195.580441955811, 4226.154769046203, 4236.237477254093, 65917.67041164811, 66194.0, 66446.66776666134, 66764.66617666929, 66840.6657966712, 10212.693619191436, 10460.68617941463, 10516.789664206673, 10759.569617215224, 10859.78280434387, 18679.0, 18785.34251301198, 18834.434966951012, 18940.337088201846, 19047.333343332917, 6495.350464953467, 6678.966605166943, 6766.69549870257, 6777.390034896883, 6935.6878940447805, 3656.341858465502, 3674.8530058797883, 3689.0777305673582, 3739.7195210358786, 3757.192203676168, 2591.8704064796684, 2688.9327766805595, 2693.192042387276, 2704.5402281612173, 2713.552263876478, 457.8237378609259, 463.8724350803556, 467.3130498167688, 469.99060018799435, 473.91469535483253, 476.4806361066454, 501.6012270245164, 537.3820106877123, 548.9752961116759, 575.6114622629792, 7625.771226863203, 7836.294733474015, 8042.678292868337, 8172.7956801080445, 8284.751457456287, 554.0940562180783, 560.3751816724405, 569.8689301460604, 571.9656820590778, 581.2269681323829, 3762.8845465037543, 3803.980980095082, 3863.150106976461, 3939.8227079781477, 3991.501062367204, 53104.468955310724, 93164.0, 104939.475302623, 106503.46748266365, 110377.0, 51388.743056285224, 85709.57145214359, 89267.55366223128, 90138.0, 90227.0, 78461.0, 79760.0, 79799.99999999884, 80751.0, 80833.59583202047, 7368.0, 7403.962980185064, 7563.130240022248, 7837.804054898673, 7910.881336780068, 48014.27978580394, 48032.0, 48924.2661360087, 49515.50484495253, 49856.50143498664, 63678.363216367245, 64804.35195648172, 72157.0, 73358.0, 73660.0, 8989.0, 9446.527673616429, 9603.807923841345, 9627.759306017126, 9763.951180244054, 10455.895441045492, 10596.735081623021, 10754.569817207224, 10859.696836379684, 11218.495167717636, 9934.784660239424, 10262.846057308998, 10286.691399258034, 10371.740706482398, 10519.526621302213, 8937.553122343987, 8999.0, 9061.0, 9080.954595226982, 9349.906500934903, 9737.318387712792, 9748.658796942073, 9768.853467197856, 9891.406515609087, 9989.800203996025, 8302.583025830296, 8486.787830304293, 8515.361347899056, 8597.699080532402, 8649.3512986525, 7868.409869259714, 8549.615267313111, 8773.341999350201, 8802.065903108478, 8974.68588599422], "value": 6368.4305038621505, "unit": "score"}], "name": "dromaeo_css", "value": 6432.3236192441, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 125.0, 196.0, 128.0, 128.0, 151.0, 123.0, 175.0, 123.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 164.0, 164.0, 163.0, 163.0, 161.0, 161.0, 164.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 76.0, 76.0, 74.0, 75.0, 99.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 129.0, 84.0, 85.0, 84.0, 117.0, 85.0, 86.0, 120.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 146.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 62.0, 63.0, 62.0, 62.0, 63.0, 72.0, 62.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 79.0, 83.0, 85.0, 79.0, 81.0, 79.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 139.0, 130.0, 128.0, 131.0, 127.0, 131.0, 158.0, 131.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 166.0, 176.0, 171.0, 173.0, 166.0, 171.0, 169.0, 166.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 69.0, 67.0, 65.0, 70.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1538.0000000000002, "alertThreshold": 2.0}]} 10:00:39 INFO - Return code: 0 10:00:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:00:39 INFO - # TBPL SUCCESS # 10:00:39 INFO - Running post-action listener: _resource_record_post_action 10:00:39 INFO - [mozharness: 2016-08-11 17:00:39.928652Z] Finished run-tests step (success) 10:00:39 INFO - Running post-run listener: _resource_record_post_run 10:00:40 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407900160; Read time: 8; Write time: 273504 10:00:40 INFO - TinderboxPrint: CPU usage
13.0% 10:00:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:00:40 INFO - TinderboxPrint: I/O write bytes / time
407,900,160 / 273,504 10:00:40 INFO - TinderboxPrint: CPU idle
8,342.9 (87.0%) 10:00:40 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 10:00:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:00:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124739584; Read time: 0; Write time: 84656 10:00:40 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 281997312; Read time: 0; Write time: 188820 10:00:40 INFO - Running post-run listener: _upload_blobber_files 10:00:40 INFO - Blob upload gear active. 10:00:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:40 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:00:40 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:00:40 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:00:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:41 INFO - (blobuploader) - INFO - Done attempting. 10:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:00:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:45 INFO - (blobuploader) - INFO - Done attempting. 10:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:00:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:45 INFO - (blobuploader) - INFO - Done attempting. 10:00:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:45 INFO - Return code: 0 10:00:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/58345d2f3750d2f0e5be95feb724793a59519be385d71bc10e87d50bafc5f774cb0840b993b9b55012d1960ccaf8c161089ce9e0fb518b664f8b221f85b32fcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6edb139468cf102d70b1a0948a043cc01a28ae5c224af0aeff16750ee86347d587f946c6e094546dbb290be39dc4be3327a2ac5d2162e49ddcf0d1b03424b094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/713e6e7536d24514fe8ff99a54cee51678925530685edda5da3e7b7e820502eafc8978ce881d520ae0a0a4b0250c62fc5edb3125a4a96a9ec7a0bf6694f08077"} 10:00:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:45 INFO - Contents: 10:00:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/58345d2f3750d2f0e5be95feb724793a59519be385d71bc10e87d50bafc5f774cb0840b993b9b55012d1960ccaf8c161089ce9e0fb518b664f8b221f85b32fcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6edb139468cf102d70b1a0948a043cc01a28ae5c224af0aeff16750ee86347d587f946c6e094546dbb290be39dc4be3327a2ac5d2162e49ddcf0d1b03424b094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/713e6e7536d24514fe8ff99a54cee51678925530685edda5da3e7b7e820502eafc8978ce881d520ae0a0a4b0250c62fc5edb3125a4a96a9ec7a0bf6694f08077"} 10:00:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:45 INFO - Copying logs to upload dir... 10:00:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.799700 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-11 10:00:45.809469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 10:00:45.813155) ========= 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=836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/58345d2f3750d2f0e5be95feb724793a59519be385d71bc10e87d50bafc5f774cb0840b993b9b55012d1960ccaf8c161089ce9e0fb518b664f8b221f85b32fcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6edb139468cf102d70b1a0948a043cc01a28ae5c224af0aeff16750ee86347d587f946c6e094546dbb290be39dc4be3327a2ac5d2162e49ddcf0d1b03424b094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/713e6e7536d24514fe8ff99a54cee51678925530685edda5da3e7b7e820502eafc8978ce881d520ae0a0a4b0250c62fc5edb3125a4a96a9ec7a0bf6694f08077"} build_url:https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/C5bMiXkOTj-8JAFOoui97Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/58345d2f3750d2f0e5be95feb724793a59519be385d71bc10e87d50bafc5f774cb0840b993b9b55012d1960ccaf8c161089ce9e0fb518b664f8b221f85b32fcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6edb139468cf102d70b1a0948a043cc01a28ae5c224af0aeff16750ee86347d587f946c6e094546dbb290be39dc4be3327a2ac5d2162e49ddcf0d1b03424b094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/713e6e7536d24514fe8ff99a54cee51678925530685edda5da3e7b7e820502eafc8978ce881d520ae0a0a4b0250c62fc5edb3125a4a96a9ec7a0bf6694f08077"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 10:00:45.845770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:00:45.846449) ========= 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=836cfdc75598d54cb747368e000001a9-1470933463.988140-951642982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 10:00:45.929614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 10:00:45.929957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 10:00:45.930328) ========= ========= Total master_lag: 0.18 =========