builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1470957909.33 results: success (0) buildid: 20160811160617 builduid: 1c7dd2feab5348269d96038226bbbb15 revision: d8dc463ad2af6a33780c45ddac7474be277bb83a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:09.336116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:09.336653) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:09.337009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:10.227277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:10.227569) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 16:25:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.0M=0s 2016-08-11 16:25:10 (28.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.467364 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:10.801986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:10.802271) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023089 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:10.841588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:10.841907) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d8dc463ad2af6a33780c45ddac7474be277bb83a --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 d8dc463ad2af6a33780c45ddac7474be277bb83a --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=9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 16:25:10,920 truncating revision to first 12 chars 2016-08-11 16:25:10,920 Setting DEBUG logging. 2016-08-11 16:25:10,920 attempt 1/10 2016-08-11 16:25:10,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d8dc463ad2af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 16:25:11,393 unpacking tar archive at: autoland-d8dc463ad2af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.818687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:11.673789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:11.674100) ========= script_repo_revision: d8dc463ad2af6a33780c45ddac7474be277bb83a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:11.674525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:11.674801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 16:25:11.683728) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-08-11 16:25:11.684000) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:25:11 INFO - MultiFileLogger online at 20160811 16:25:11 in /builds/slave/test 16:25:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 16:25:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:25:11 INFO - {'append_to_log': False, 16:25:11 INFO - 'base_work_dir': '/builds/slave/test', 16:25:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 16:25:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:25:11 INFO - 'branch': 'Autoland-Non-PGO', 16:25:11 INFO - 'buildbot_json_path': 'buildprops.json', 16:25:11 INFO - 'config_files': ('talos/linux_config.py',), 16:25:11 INFO - 'default_actions': ('clobber', 16:25:11 INFO - 'read-buildbot-config', 16:25:11 INFO - 'download-and-extract', 16:25:11 INFO - 'populate-webroot', 16:25:11 INFO - 'create-virtualenv', 16:25:11 INFO - 'install', 16:25:11 INFO - 'run-tests'), 16:25:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:25:11 INFO - 'download_minidump_stackwalk': True, 16:25:11 INFO - 'download_symbols': 'ondemand', 16:25:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:25:11 INFO - 'tooltool.py': '/tools/tooltool.py', 16:25:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:25:11 INFO - '/tools/misc-python/virtualenv.py')}, 16:25:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:25:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:25:11 INFO - 'installer_path': 'installer.exe', 16:25:11 INFO - 'log_level': 'info', 16:25:11 INFO - 'log_name': 'talos', 16:25:11 INFO - 'log_to_console': True, 16:25:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:25:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:25:11 INFO - 'opt_config_files': (), 16:25:11 INFO - 'pip_index': False, 16:25:11 INFO - 'sps_profile': False, 16:25:11 INFO - 'sps_profile_interval': 0, 16:25:11 INFO - 'suite': 'dromaeojs', 16:25:11 INFO - 'system_bits': '32', 16:25:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:25:11 INFO - 'title': 'talos-linux64-ix-013', 16:25:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:25:11 INFO - 'use_talos_json': True, 16:25:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:25:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:25:11 INFO - 'work_dir': 'build'} 16:25:11 INFO - [mozharness: 2016-08-11 23:25:11.857487Z] Running clobber step. 16:25:11 INFO - Running pre-action listener: _resource_record_pre_action 16:25:11 INFO - Running main action method: clobber 16:25:11 INFO - rmtree: /builds/slave/test/build 16:25:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:25:12 INFO - Running post-action listener: _resource_record_post_action 16:25:12 INFO - [mozharness: 2016-08-11 23:25:12.304837Z] Finished clobber step (success) 16:25:12 INFO - [mozharness: 2016-08-11 23:25:12.304937Z] Running read-buildbot-config step. 16:25:12 INFO - Running pre-action listener: _resource_record_pre_action 16:25:12 INFO - Running main action method: read_buildbot_config 16:25:12 INFO - Using buildbot properties: 16:25:12 INFO - { 16:25:12 INFO - "project": "", 16:25:12 INFO - "product": "firefox", 16:25:12 INFO - "script_repo_revision": "production", 16:25:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 16:25:12 INFO - "repository": "", 16:25:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 16:25:12 INFO - "buildid": "20160811160617", 16:25:12 INFO - "pgo_build": "False", 16:25:12 INFO - "basedir": "/builds/slave/test", 16:25:12 INFO - "buildnumber": 268, 16:25:12 INFO - "slavename": "talos-linux64-ix-013", 16:25:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:25:12 INFO - "platform": "ubuntu64_hw", 16:25:12 INFO - "scheduler": "tests-autoland-linux64-talos", 16:25:12 INFO - "branch": "autoland", 16:25:12 INFO - "repo_path": "integration/autoland", 16:25:12 INFO - "revision": "d8dc463ad2af6a33780c45ddac7474be277bb83a", 16:25:12 INFO - "stage_platform": "linux64", 16:25:12 INFO - "builduid": "1c7dd2feab5348269d96038226bbbb15", 16:25:12 INFO - "slavebuilddir": "test" 16:25:12 INFO - } 16:25:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:25:12 INFO - Running post-action listener: _resource_record_post_action 16:25:12 INFO - [mozharness: 2016-08-11 23:25:12.307331Z] Finished read-buildbot-config step (success) 16:25:12 INFO - [mozharness: 2016-08-11 23:25:12.307417Z] Running download-and-extract step. 16:25:12 INFO - Running pre-action listener: _resource_record_pre_action 16:25:12 INFO - Running main action method: download_and_extract 16:25:12 INFO - mkdir: /builds/slave/test/build/tests 16:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:12 INFO - trying https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:25:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:13 INFO - Downloaded 1361 bytes. 16:25:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:25:13 INFO - Using the following test package requirements: 16:25:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:25:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:25:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:25:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'jsshell-linux-x86_64.zip'], 16:25:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:25:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:25:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:25:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:25:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:25:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:25:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:25:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:25:13 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')]} 16:25:13 INFO - trying https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:14 INFO - Downloaded 20263146 bytes. 16:25:14 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 16:25:19 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 16:25: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')]} 16:25:19 INFO - trying https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:25:19 INFO - Downloading https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:20 INFO - Downloaded 20263146 bytes. 16:25:20 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 16:25: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')]} 16:25:24 INFO - trying https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:25:24 INFO - Downloading https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:25 INFO - Downloaded 14413719 bytes. 16:25:25 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 16:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:25 INFO - trying https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:25:25 INFO - Downloading https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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 16:25:27 INFO - Downloaded 55641190 bytes. 16:25:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:25:27 INFO - mkdir: /builds/slave/test/properties 16:25:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:25:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:25:27 INFO - Contents: 16:25:27 INFO - build_url:https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:25:28 INFO - Running post-action listener: _resource_record_post_action 16:25:28 INFO - Running post-action listener: set_extra_try_arguments 16:25:28 INFO - [mozharness: 2016-08-11 23:25:28.177998Z] Finished download-and-extract step (success) 16:25:28 INFO - [mozharness: 2016-08-11 23:25:28.178222Z] Running populate-webroot step. 16:25:28 INFO - Running pre-action listener: _resource_record_pre_action 16:25:28 INFO - Running main action method: populate_webroot 16:25:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:25:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:25:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:25:28 INFO - '--tppagecycles', 16:25:28 INFO - '7'], 16:25:28 INFO - 'tests': ['tsvgm']}}, 16:25:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:25:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:25:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:25:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:25:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:25:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:25:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['damp', 'tps']}, 16:25:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'tests': ['damp', 'tps']}, 16:25:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['dromaeo_dom']}, 16:25:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:25:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['basic_compositor_video']}, 16:25:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:25:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['a11yr', 16:25:28 INFO - 'ts_paint', 16:25:28 INFO - 'tpaint', 16:25:28 INFO - 'sessionrestore', 16:25:28 INFO - 'sessionrestore_no_auto_restore', 16:25:28 INFO - 'tabpaint']}, 16:25:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:25:28 INFO - 'ts_paint', 16:25:28 INFO - 'tpaint', 16:25:28 INFO - 'sessionrestore', 16:25:28 INFO - 'sessionrestore_no_auto_restore', 16:25:28 INFO - 'tabpaint']}, 16:25:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:25:28 INFO - 'ts_paint', 16:25:28 INFO - 'tpaint', 16:25:28 INFO - 'sessionrestore', 16:25:28 INFO - 'sessionrestore_no_auto_restore', 16:25:28 INFO - 'tabpaint']}, 16:25:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:25:28 INFO - 'ts_paint', 16:25:28 INFO - 'tpaint', 16:25:28 INFO - 'sessionrestore', 16:25:28 INFO - 'sessionrestore_no_auto_restore', 16:25:28 INFO - 'tabpaint']}, 16:25:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['a11yr', 16:25:28 INFO - 'ts_paint', 16:25:28 INFO - 'tpaint', 16:25:28 INFO - 'sessionrestore', 16:25:28 INFO - 'sessionrestore_no_auto_restore', 16:25:28 INFO - 'tabpaint']}, 16:25:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['a11yr', 16:25:28 INFO - 'ts_paint', 16:25:28 INFO - 'tpaint', 16:25:28 INFO - 'sessionrestore', 16:25:28 INFO - 'sessionrestore_no_auto_restore', 16:25:28 INFO - 'tabpaint']}, 16:25:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['tsvgx', 16:25:28 INFO - 'tsvgr_opacity', 16:25:28 INFO - 'tart', 16:25:28 INFO - 'tscrollx', 16:25:28 INFO - 'cart']}, 16:25:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:25:28 INFO - 'tsvgr_opacity', 16:25:28 INFO - 'tart', 16:25:28 INFO - 'tscrollx', 16:25:28 INFO - 'cart']}, 16:25:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'talos_options': ['--disable-e10s'], 16:25:28 INFO - 'tests': ['tp5o']}, 16:25:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'tests': ['tp5o']}, 16:25:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'talos_options': ['--disable-e10s', 16:25:28 INFO - '--xperf_path', 16:25:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:25:28 INFO - 'tests': ['tp5n']}, 16:25:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:25:28 INFO - 'talos_options': ['--xperf_path', 16:25:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:25:28 INFO - 'tests': ['tp5n']}}, 16:25:28 INFO - 'talos.zip': {'path': '', 16:25:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:25:28 INFO - Running post-action listener: _resource_record_post_action 16:25:28 INFO - [mozharness: 2016-08-11 23:25:28.197484Z] Finished populate-webroot step (success) 16:25:28 INFO - [mozharness: 2016-08-11 23:25:28.197571Z] Running create-virtualenv step. 16:25:28 INFO - Running pre-action listener: _resource_record_pre_action 16:25:28 INFO - Running main action method: create_virtualenv 16:25:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:25:28 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 16:25:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:25:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:25:28 INFO - Using real prefix '/usr' 16:25:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:25:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:25:30 INFO - Installing pip.................done. 16:25:30 INFO - Return code: 0 16:25:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:25:30 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')]} 16:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:30 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')]} 16:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:30 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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:30 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 16:25:30 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 16:25:30 INFO - Using env: {'DISPLAY': ':0', 16:25:30 INFO - 'HOME': '/home/cltbld', 16:25:30 INFO - 'LANG': 'en_US.UTF-8', 16:25:30 INFO - 'LANGUAGE': 'en_US:en', 16:25:30 INFO - 'LOGNAME': 'cltbld', 16:25:30 INFO - 'MAIL': '/var/mail/cltbld', 16:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:30 INFO - 'MOZ_NO_REMOTE': '1', 16:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:30 INFO - 'NO_EM_RESTART': '1', 16:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:30 INFO - 'PWD': '/builds/slave/test', 16:25:30 INFO - 'SHELL': '/bin/bash', 16:25:30 INFO - 'SHLVL': '1', 16:25:30 INFO - 'TERM': 'linux', 16:25:30 INFO - 'TMOUT': '86400', 16:25:30 INFO - 'USER': 'cltbld', 16:25:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:30 INFO - '_': '/tools/buildbot/bin/python'} 16:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:30 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 16:25:30 INFO - Cleaning up... 16:25:31 INFO - Return code: 0 16:25:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:25:31 INFO - Using env: {'DISPLAY': ':0', 16:25:31 INFO - 'HOME': '/home/cltbld', 16:25:31 INFO - 'LANG': 'en_US.UTF-8', 16:25:31 INFO - 'LANGUAGE': 'en_US:en', 16:25:31 INFO - 'LOGNAME': 'cltbld', 16:25:31 INFO - 'MAIL': '/var/mail/cltbld', 16:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:31 INFO - 'MOZ_NO_REMOTE': '1', 16:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:31 INFO - 'NO_EM_RESTART': '1', 16:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:31 INFO - 'PWD': '/builds/slave/test', 16:25:31 INFO - 'SHELL': '/bin/bash', 16:25:31 INFO - 'SHLVL': '1', 16:25:31 INFO - 'TERM': 'linux', 16:25:31 INFO - 'TMOUT': '86400', 16:25:31 INFO - 'USER': 'cltbld', 16:25:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:31 INFO - '_': '/tools/buildbot/bin/python'} 16:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:31 INFO - Downloading/unpacking psutil>=3.1.1 16:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:25:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:33 INFO - Installing collected packages: psutil 16:25:33 INFO - Running setup.py install for psutil 16:25:33 INFO - building 'psutil._psutil_linux' extension 16:25:33 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 16:25:33 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 16:25:33 INFO - building 'psutil._psutil_posix' extension 16:25:33 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 16:25:33 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 16:25:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:33 INFO - Successfully installed psutil 16:25:33 INFO - Cleaning up... 16:25:33 INFO - Return code: 0 16:25:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:25:33 INFO - Using env: {'DISPLAY': ':0', 16:25:33 INFO - 'HOME': '/home/cltbld', 16:25:33 INFO - 'LANG': 'en_US.UTF-8', 16:25:33 INFO - 'LANGUAGE': 'en_US:en', 16:25:33 INFO - 'LOGNAME': 'cltbld', 16:25:33 INFO - 'MAIL': '/var/mail/cltbld', 16:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:33 INFO - 'MOZ_NO_REMOTE': '1', 16:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:33 INFO - 'NO_EM_RESTART': '1', 16:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:33 INFO - 'PWD': '/builds/slave/test', 16:25:33 INFO - 'SHELL': '/bin/bash', 16:25:33 INFO - 'SHLVL': '1', 16:25:33 INFO - 'TERM': 'linux', 16:25:33 INFO - 'TMOUT': '86400', 16:25:33 INFO - 'USER': 'cltbld', 16:25:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:33 INFO - '_': '/tools/buildbot/bin/python'} 16:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:25:33 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 16:25:33 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 16:25:33 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 16:25:33 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 16:25:33 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 16:25:33 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 16:25:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:25:35 INFO - Installing collected packages: mozsystemmonitor 16:25:35 INFO - Running setup.py install for mozsystemmonitor 16:25:35 INFO - Successfully installed mozsystemmonitor 16:25:35 INFO - Cleaning up... 16:25:36 INFO - Return code: 0 16:25:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:25:36 INFO - Using env: {'DISPLAY': ':0', 16:25:36 INFO - 'HOME': '/home/cltbld', 16:25:36 INFO - 'LANG': 'en_US.UTF-8', 16:25:36 INFO - 'LANGUAGE': 'en_US:en', 16:25:36 INFO - 'LOGNAME': 'cltbld', 16:25:36 INFO - 'MAIL': '/var/mail/cltbld', 16:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:36 INFO - 'MOZ_NO_REMOTE': '1', 16:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:36 INFO - 'NO_EM_RESTART': '1', 16:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:36 INFO - 'PWD': '/builds/slave/test', 16:25:36 INFO - 'SHELL': '/bin/bash', 16:25:36 INFO - 'SHLVL': '1', 16:25:36 INFO - 'TERM': 'linux', 16:25:36 INFO - 'TMOUT': '86400', 16:25:36 INFO - 'USER': 'cltbld', 16:25:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:36 INFO - '_': '/tools/buildbot/bin/python'} 16:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:36 INFO - Downloading/unpacking jsonschema==2.5.1 16:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:25:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:38 INFO - Downloading functools32-3.2.3-2.tar.gz 16:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:25:38 INFO - warning: no files found matching '*.txt' 16:25:38 INFO - no previously-included directories found matching 'build' 16:25:38 INFO - no previously-included directories found matching 'dist' 16:25:38 INFO - no previously-included directories found matching '.git*' 16:25:38 INFO - Installing collected packages: jsonschema, functools32 16:25:38 INFO - Running setup.py install for functools32 16:25:38 INFO - warning: no files found matching '*.txt' 16:25:38 INFO - no previously-included directories found matching 'build' 16:25:38 INFO - no previously-included directories found matching 'dist' 16:25:38 INFO - no previously-included directories found matching '.git*' 16:25:38 INFO - Successfully installed jsonschema functools32 16:25:38 INFO - Cleaning up... 16:25:38 INFO - Return code: 0 16:25:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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', '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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:25: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 functools32==3.2.3-2 16:25:38 INFO - Using env: {'DISPLAY': ':0', 16:25:38 INFO - 'HOME': '/home/cltbld', 16:25:38 INFO - 'LANG': 'en_US.UTF-8', 16:25:38 INFO - 'LANGUAGE': 'en_US:en', 16:25:38 INFO - 'LOGNAME': 'cltbld', 16:25:38 INFO - 'MAIL': '/var/mail/cltbld', 16:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:38 INFO - 'MOZ_NO_REMOTE': '1', 16:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:38 INFO - 'NO_EM_RESTART': '1', 16:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:38 INFO - 'PWD': '/builds/slave/test', 16:25:38 INFO - 'SHELL': '/bin/bash', 16:25:38 INFO - 'SHLVL': '1', 16:25:38 INFO - 'TERM': 'linux', 16:25:38 INFO - 'TMOUT': '86400', 16:25:38 INFO - 'USER': 'cltbld', 16:25:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:38 INFO - '_': '/tools/buildbot/bin/python'} 16:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:25:38 INFO - Cleaning up... 16:25:38 INFO - Return code: 0 16:25:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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', '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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:25: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 blobuploader==1.2.4 16:25:38 INFO - Using env: {'DISPLAY': ':0', 16:25:38 INFO - 'HOME': '/home/cltbld', 16:25:38 INFO - 'LANG': 'en_US.UTF-8', 16:25:38 INFO - 'LANGUAGE': 'en_US:en', 16:25:38 INFO - 'LOGNAME': 'cltbld', 16:25:38 INFO - 'MAIL': '/var/mail/cltbld', 16:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:38 INFO - 'MOZ_NO_REMOTE': '1', 16:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:38 INFO - 'NO_EM_RESTART': '1', 16:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:38 INFO - 'PWD': '/builds/slave/test', 16:25:38 INFO - 'SHELL': '/bin/bash', 16:25:38 INFO - 'SHLVL': '1', 16:25:38 INFO - 'TERM': 'linux', 16:25:38 INFO - 'TMOUT': '86400', 16:25:38 INFO - 'USER': 'cltbld', 16:25:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:38 INFO - '_': '/tools/buildbot/bin/python'} 16:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:40 INFO - Downloading blobuploader-1.2.4.tar.gz 16:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:25:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:25:41 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 16:25:41 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 16:25:41 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 16:25:41 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 16:25:41 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 16:25:41 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 16:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:25:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:44 INFO - Downloading docopt-0.6.1.tar.gz 16:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:25:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:25:44 INFO - Running setup.py install for blobuploader 16:25:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:25:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:25:44 INFO - Running setup.py install for requests 16:25:45 INFO - Running setup.py install for docopt 16:25:45 INFO - Successfully installed blobuploader requests docopt 16:25:45 INFO - Cleaning up... 16:25:45 INFO - Return code: 0 16:25:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:45 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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:45 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 16:25:45 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 16:25:45 INFO - Using env: {'DISPLAY': ':0', 16:25:45 INFO - 'HOME': '/home/cltbld', 16:25:45 INFO - 'LANG': 'en_US.UTF-8', 16:25:45 INFO - 'LANGUAGE': 'en_US:en', 16:25:45 INFO - 'LOGNAME': 'cltbld', 16:25:45 INFO - 'MAIL': '/var/mail/cltbld', 16:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:45 INFO - 'MOZ_NO_REMOTE': '1', 16:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:45 INFO - 'NO_EM_RESTART': '1', 16:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:45 INFO - 'PWD': '/builds/slave/test', 16:25:45 INFO - 'SHELL': '/bin/bash', 16:25:45 INFO - 'SHLVL': '1', 16:25:45 INFO - 'TERM': 'linux', 16:25:45 INFO - 'TMOUT': '86400', 16:25:45 INFO - 'USER': 'cltbld', 16:25:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:45 INFO - '_': '/tools/buildbot/bin/python'} 16:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:45 INFO - Running setup.py (path:/tmp/pip-ARuk89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:45 INFO - Running setup.py (path:/tmp/pip-zGowqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:45 INFO - Running setup.py (path:/tmp/pip-auDSTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:45 INFO - Running setup.py (path:/tmp/pip-DkgCzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:46 INFO - Running setup.py (path:/tmp/pip-31zyGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:46 INFO - Running setup.py (path:/tmp/pip-5HG3gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:46 INFO - Running setup.py (path:/tmp/pip-MmjT8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:46 INFO - Running setup.py (path:/tmp/pip-9iorwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:46 INFO - Running setup.py (path:/tmp/pip-f3xstG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:46 INFO - Running setup.py (path:/tmp/pip-xv4NEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:46 INFO - Running setup.py (path:/tmp/pip-tb5N1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:46 INFO - Running setup.py (path:/tmp/pip-1XYYeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:46 INFO - Running setup.py (path:/tmp/pip-gkjk9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:46 INFO - Running setup.py (path:/tmp/pip-PkkmBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:46 INFO - Running setup.py (path:/tmp/pip-0OUWaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:46 INFO - Running setup.py (path:/tmp/pip-Uvh806-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:46 INFO - Running setup.py (path:/tmp/pip-t11kra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:25:46 INFO - Running setup.py install for manifestparser 16:25:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Running setup.py install for mozcrash 16:25:47 INFO - Running setup.py install for mozdebug 16:25:47 INFO - Running setup.py install for mozdevice 16:25:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Running setup.py install for mozfile 16:25:47 INFO - Running setup.py install for mozhttpd 16:25:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Running setup.py install for mozinfo 16:25:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Running setup.py install for mozInstall 16:25:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Running setup.py install for mozleak 16:25:47 INFO - Running setup.py install for mozlog 16:25:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:25:47 INFO - Running setup.py install for moznetwork 16:25:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:25:48 INFO - Running setup.py install for mozprocess 16:25:48 INFO - Running setup.py install for mozprofile 16:25:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:25:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:25:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:25:48 INFO - Running setup.py install for mozrunner 16:25:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:25:48 INFO - Running setup.py install for mozscreenshot 16:25:48 INFO - Running setup.py install for moztest 16:25:48 INFO - Running setup.py install for mozversion 16:25:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:25:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:25:48 INFO - Cleaning up... 16:25:48 INFO - Return code: 0 16:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:48 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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:48 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 16:25:48 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 16:25:48 INFO - Using env: {'DISPLAY': ':0', 16:25:48 INFO - 'HOME': '/home/cltbld', 16:25:48 INFO - 'LANG': 'en_US.UTF-8', 16:25:48 INFO - 'LANGUAGE': 'en_US:en', 16:25:48 INFO - 'LOGNAME': 'cltbld', 16:25:48 INFO - 'MAIL': '/var/mail/cltbld', 16:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:48 INFO - 'MOZ_NO_REMOTE': '1', 16:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:48 INFO - 'NO_EM_RESTART': '1', 16:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:48 INFO - 'PWD': '/builds/slave/test', 16:25:48 INFO - 'SHELL': '/bin/bash', 16:25:48 INFO - 'SHLVL': '1', 16:25:48 INFO - 'TERM': 'linux', 16:25:48 INFO - 'TMOUT': '86400', 16:25:48 INFO - 'USER': 'cltbld', 16:25:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:48 INFO - '_': '/tools/buildbot/bin/python'} 16:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:48 INFO - Running setup.py (path:/tmp/pip-baCFjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:49 INFO - Running setup.py (path:/tmp/pip-A32ji2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:49 INFO - Running setup.py (path:/tmp/pip-Vx3Dsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:49 INFO - Running setup.py (path:/tmp/pip-gfDA1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:49 INFO - Running setup.py (path:/tmp/pip-5dzAgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:49 INFO - Running setup.py (path:/tmp/pip-3_PWkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:49 INFO - Running setup.py (path:/tmp/pip-cxG0vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:49 INFO - Running setup.py (path:/tmp/pip-XxhzL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:49 INFO - Running setup.py (path:/tmp/pip-di22Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:49 INFO - Running setup.py (path:/tmp/pip-bhaXA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:49 INFO - Running setup.py (path:/tmp/pip-gY4M2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:49 INFO - Running setup.py (path:/tmp/pip-P9sw3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:49 INFO - Running setup.py (path:/tmp/pip-fI1B_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:49 INFO - Running setup.py (path:/tmp/pip-W8Eoe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:49 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)) 16:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:49 INFO - Running setup.py (path:/tmp/pip-z3XA9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:50 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)) 16:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:50 INFO - Running setup.py (path:/tmp/pip-oa2kCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:50 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)) 16:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:50 INFO - Running setup.py (path:/tmp/pip-nChyAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:50 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)) 16:25:50 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)) 16:25:50 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)) 16:25:50 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)) 16:25:50 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)) 16:25:50 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)) 16:25:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:54 INFO - Downloading blessings-1.6.tar.gz 16:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:25:55 INFO - Installing collected packages: blessings 16:25:55 INFO - Running setup.py install for blessings 16:25:55 INFO - Successfully installed blessings 16:25:55 INFO - Cleaning up... 16:25:55 INFO - Return code: 0 16:25:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:55 INFO - Reading from file tmpfile_stdout 16:25:55 INFO - Current package versions: 16:25:55 INFO - argparse == 1.2.1 16:25:55 INFO - blessings == 1.6 16:25:55 INFO - blobuploader == 1.2.4 16:25:55 INFO - docopt == 0.6.1 16:25:55 INFO - functools32 == 3.2.3-2 16:25:55 INFO - jsonschema == 2.5.1 16:25:55 INFO - manifestparser == 1.1 16:25:55 INFO - mozInstall == 1.12 16:25:55 INFO - mozcrash == 0.17 16:25:55 INFO - mozdebug == 0.1 16:25:55 INFO - mozdevice == 0.48 16:25:55 INFO - mozfile == 1.2 16:25:55 INFO - mozhttpd == 0.7 16:25:55 INFO - mozinfo == 0.9 16:25:55 INFO - mozleak == 0.1 16:25:55 INFO - mozlog == 3.3 16:25:55 INFO - moznetwork == 0.27 16:25:55 INFO - mozprocess == 0.23 16:25:55 INFO - mozprofile == 0.28 16:25:55 INFO - mozrunner == 6.12 16:25:55 INFO - mozscreenshot == 0.1 16:25:55 INFO - mozsystemmonitor == 0.3 16:25:55 INFO - moztest == 0.7 16:25:55 INFO - mozversion == 1.4 16:25:55 INFO - psutil == 3.1.1 16:25:55 INFO - requests == 1.2.3 16:25:55 INFO - wsgiref == 0.1.2 16:25:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:55 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')]} 16:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:55 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')]} 16:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:55 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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:55 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 16:25:55 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 16:25:55 INFO - Using env: {'DISPLAY': ':0', 16:25:55 INFO - 'HOME': '/home/cltbld', 16:25:55 INFO - 'LANG': 'en_US.UTF-8', 16:25:55 INFO - 'LANGUAGE': 'en_US:en', 16:25:55 INFO - 'LOGNAME': 'cltbld', 16:25:55 INFO - 'MAIL': '/var/mail/cltbld', 16:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:55 INFO - 'MOZ_NO_REMOTE': '1', 16:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:55 INFO - 'NO_EM_RESTART': '1', 16:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:55 INFO - 'PWD': '/builds/slave/test', 16:25:55 INFO - 'SHELL': '/bin/bash', 16:25:55 INFO - 'SHLVL': '1', 16:25:55 INFO - 'TERM': 'linux', 16:25:55 INFO - 'TMOUT': '86400', 16:25:55 INFO - 'USER': 'cltbld', 16:25:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:55 INFO - '_': '/tools/buildbot/bin/python'} 16:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 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)) 16:25:55 INFO - Cleaning up... 16:25:55 INFO - Return code: 0 16:25:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:25:55 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')]} 16:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:55 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')]} 16:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:55 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 0x7fea752ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', '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 16:25:55 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 16:25:55 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 16:25:55 INFO - Using env: {'DISPLAY': ':0', 16:25:55 INFO - 'HOME': '/home/cltbld', 16:25:55 INFO - 'LANG': 'en_US.UTF-8', 16:25:55 INFO - 'LANGUAGE': 'en_US:en', 16:25:55 INFO - 'LOGNAME': 'cltbld', 16:25:55 INFO - 'MAIL': '/var/mail/cltbld', 16:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:55 INFO - 'MOZ_NO_REMOTE': '1', 16:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:55 INFO - 'NO_EM_RESTART': '1', 16:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:55 INFO - 'PWD': '/builds/slave/test', 16:25:55 INFO - 'SHELL': '/bin/bash', 16:25:55 INFO - 'SHLVL': '1', 16:25:55 INFO - 'TERM': 'linux', 16:25:55 INFO - 'TMOUT': '86400', 16:25:55 INFO - 'USER': 'cltbld', 16:25:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:55 INFO - '_': '/tools/buildbot/bin/python'} 16:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:25:55 INFO - Cleaning up... 16:25:55 INFO - Return code: 0 16:25:55 INFO - Running post-action listener: _resource_record_post_action 16:25:55 INFO - Running post-action listener: _start_resource_monitoring 16:25:55 INFO - Starting resource monitoring. 16:25:55 INFO - [mozharness: 2016-08-11 23:25:55.890562Z] Finished create-virtualenv step (success) 16:25:55 INFO - [mozharness: 2016-08-11 23:25:55.891061Z] Running install step. 16:25:55 INFO - Running pre-action listener: _resource_record_pre_action 16:25:55 INFO - Running main action method: install 16:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:56 INFO - Reading from file tmpfile_stdout 16:25:56 INFO - Detecting whether we're running mozinstall >=1.0... 16:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:25:56 INFO - Reading from file tmpfile_stdout 16:25:56 INFO - Output received: 16:25:56 INFO - Usage: mozinstall [options] installer 16:25:56 INFO - Options: 16:25:56 INFO - -h, --help show this help message and exit 16:25:56 INFO - -d DEST, --destination=DEST 16:25:56 INFO - Directory to install application into. [default: 16:25:56 INFO - "/builds/slave/test"] 16:25:56 INFO - --app=APP Application being installed. [default: firefox] 16:25:56 INFO - mkdir: /builds/slave/test/build/application 16:25:56 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'] 16:25:56 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 16:26:12 INFO - Reading from file tmpfile_stdout 16:26:12 INFO - Output received: 16:26:12 INFO - /builds/slave/test/build/application/firefox/firefox 16:26:12 INFO - Running post-action listener: _resource_record_post_action 16:26:12 INFO - [mozharness: 2016-08-11 23:26:12.234673Z] Finished install step (success) 16:26:12 INFO - [mozharness: 2016-08-11 23:26:12.234918Z] Running run-tests step. 16:26:12 INFO - Running pre-action listener: _resource_record_pre_action 16:26:12 INFO - Running main action method: run_tests 16:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:26:12 INFO - Python 2.7.3 16:26:12 INFO - Return code: 0 16:26:12 INFO - grabbing minidump binary from tooltool 16:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:26:12 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 0x100a090>, '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 0x100d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:26:12 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 16:26:12 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 16:26:12 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 16:26:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:26:12 INFO - Return code: 0 16:26:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:26:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:26:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:26:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:26:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:26:12 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/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:26:12 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/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 16:26:12 INFO - Using env: {'DISPLAY': ':0', 16:26:12 INFO - 'HOME': '/home/cltbld', 16:26:12 INFO - 'LANG': 'en_US.UTF-8', 16:26:12 INFO - 'LANGUAGE': 'en_US:en', 16:26:12 INFO - 'LOGNAME': 'cltbld', 16:26:12 INFO - 'MAIL': '/var/mail/cltbld', 16:26:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:26:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:12 INFO - 'MOZ_NO_REMOTE': '1', 16:26:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:26:12 INFO - 'NO_EM_RESTART': '1', 16:26:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:12 INFO - 'PWD': '/builds/slave/test', 16:26:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:26:12 INFO - 'SHELL': '/bin/bash', 16:26:12 INFO - 'SHLVL': '1', 16:26:12 INFO - 'TERM': 'linux', 16:26:12 INFO - 'TMOUT': '86400', 16:26:12 INFO - 'USER': 'cltbld', 16:26:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186', 16:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:12 INFO - '_': '/tools/buildbot/bin/python'} 16:26:12 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/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:26:12 INFO - mozversion application_buildid: 20160811160617 16:26:12 INFO - mozversion application_changeset: d8dc463ad2af6a33780c45ddac7474be277bb83a 16:26:12 INFO - mozversion application_display_name: Nightly 16:26:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:26:12 INFO - mozversion application_name: Firefox 16:26:12 INFO - mozversion application_remotingname: firefox 16:26:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:26:12 INFO - mozversion application_vendor: Mozilla 16:26:12 INFO - mozversion application_version: 51.0a1 16:26:12 INFO - mozversion platform_buildid: 20160811160617 16:26:12 INFO - mozversion platform_changeset: d8dc463ad2af6a33780c45ddac7474be277bb83a 16:26:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:26:12 INFO - mozversion platform_version: 51.0a1 16:26:12 INFO - using testdate: 1470957972 16:26:12 INFO - actual date: 1470957972 16:26:12 INFO - starting webserver on 'localhost:40118' 16:26:12 INFO - SUITE-START | Running 2 tests 16:26:12 INFO - TEST-START | dromaeo_css 16:26:12 INFO - operating with platform_type : linux_ 16:26:12 INFO - Initialising browser for dromaeo_css test... 16:26:12 INFO - TEST-INFO | started process 4346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCUtOtK/profile http://localhost:40118/getInfo.html) 16:26:17 INFO - PROCESS | 4346 | __metrics Screen width/height:1600/1200 16:26:17 INFO - PROCESS | 4346 | colorDepth:24 16:26:17 INFO - PROCESS | 4346 | Browser inner width/height: 1024/697 16:26:17 INFO - PROCESS | 4346 | __metrics 16:26:17 INFO - PROCESS | 4346 | 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" 16:26:17 INFO - PROCESS | 4346 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:26:18 INFO - PROCESS | 4346 | console.error: PushService: 16:26:18 INFO - PROCESS | 4346 | stateChangeProcessEnqueue: Error transitioning state 16:26:18 INFO - PROCESS | 4346 | UnknownError 16:26:19 INFO - TEST-INFO | 4346: exit 0 16:26:19 INFO - Browser initialized. 16:26:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:26:19 INFO - TEST-INFO | started process 4425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCUtOtK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:31 INFO - PROCESS | 4425 | RSS: Main: 157011968 16:26:31 INFO - PROCESS | 4425 | 16:27:22 INFO - PROCESS | 4425 | 1470958042019 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] 16:29:35 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:40118/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40118/tests/dromaeo/cssquery-ext.html) 16:29:36 INFO - PROCESS | 4425 | RSS: Main: 276828160 16:29:36 INFO - PROCESS | 4425 | 16:32:39 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:40118/tests/dromaeo/cssquery-ext.html (next: http://localhost:40118/tests/dromaeo/cssquery-jquery.html) 16:32:40 INFO - PROCESS | 4425 | RSS: Main: 249942016 16:32:40 INFO - PROCESS | 4425 | 16:35:42 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:40118/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40118/tests/dromaeo/cssquery-mootools.html) 16:35:42 INFO - PROCESS | 4425 | RSS: Main: 231014400 16:35:42 INFO - PROCESS | 4425 | 16:38:45 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:40118/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40118/tests/dromaeo/cssquery-prototype.html) 16:38:45 INFO - PROCESS | 4425 | RSS: Main: 205651968 16:38:45 INFO - PROCESS | 4425 | 16:41:48 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:40118/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40118/tests/dromaeo/cssquery-yui.html) 16:41:49 INFO - PROCESS | 4425 | RSS: Main: 190070784 16:41:49 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:40118/tests/dromaeo/cssquery-yui.html (next: http://localhost:40118/tests/dromaeo/cssquery-dojo.html) 16:44:52 INFO - PROCESS | 4425 | RSS: Main: 281292800 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | __start_tp_report 16:44:52 INFO - PROCESS | 4425 | _x_x_mozilla_page_load 16:44:52 INFO - PROCESS | 4425 | _x_x_mozilla_page_load_details 16:44:52 INFO - PROCESS | 4425 | |i|pagename|runs| 16:44:52 INFO - PROCESS | 4425 | |0;dojo.html;2636.6308716779654;2649.4171282317884;2676.9961264525805;2682.2221555748833;2683.718209587993;4626.629869610431;4667.719936803795;4823.975880120599;4949.52979466951;4949.52979466951;4733.1243719911845;4736.739479328636;4754.9286760698615;4807.0866535358255;4865.075635629228;4400.119976004796;4504.864854054384;4511.300748384006;4511.977440112795;4539.387182730322;4395.05506316142;4406.889827754299;4443.488998765135;4485.865424037284;4515.05183911379;4508.752018638974;4547.1587756265035;4563.726176429408;4564.0871825635;4566.406367172263;4238.109996900655;4475.1944649963;4481.282994720829;4489.147062058215;4557.886052848706;4245.5542168072525;4278.443802305712;4406.889827754332;4451.2655411857;4456.108778244332;4785.066911952171;4798.664093513456;4846.733429661367;4855.902881942341;4925.802967881281;5163.845084647466;5222.399424066243;5274.103402421598;5274.973625131888;5281;5029.321041659366;5245.26566280721;5251.6061295403;5288.391834938992;5311.601629877775;4948.925766113512;4949.579285760678;4950.18321976877;4950.25746138075;4958.181899986462;5392.487713667196;5455.0726376515295;5455.1544510600925;5459.781608735686;5460.31746031746;4913.803447862046;5049.242613607915;5077.213031980049;5097.362829646294;5214.139666954986;5191.9480805192225;5200.193969934666;5203.531682148625;5246.895062098737;5265.420803711589;5166.5866730661455;5175.792968281226;5181.4559471255725;5184.7407629618365;5236.083685355124;4963.677360971597;5005.974970125126;5151.381834179922;5154.226865970059;5207.869803254873;4494.191045611756;4497.752623605733;4537.568930951555;4537.77311134442;4546.1135078659345;3903.590123037097;3914.2171565686976;3919.392494163409;3922.097917478996;3955.5055618047745;4328.350747387917;4402.25161722508;4421.204183246982;4547.977260113678;4588.105319462673;5133.486651334837;5167;5174.197999310113;5218;5225.503577160163;4426.778661066934;4437.29003359461;4444.355568442623;4489.32660100981;4491.977540112279;4507.864764057083;4626.282926146453;4648.86053418398;4659.510751371125;4663.860084197479;4829.179039563212;4851.95148048515;4854.514548545118;4877.731724755031;4902.313676085422;5161.535461808456;5203.11547036997;5215.530602245816;5219.608529360389;5267.73661316925;4727.692699974628;4746.288056791509;4774.856754297377;4846.709197448165;4906.509349065065;5027.849164524924;5035.320231768665;5041;5069.493050694901;5083.923741143812;5118.846434606968;5119.5648369887485;5121.257417674491;5133.589312855037;5171.793128274827;4784.258439941815;4933.925991110208;4956.8760780980765;4966.205407134841;4975.253711943237;4961.652684312208;4963.950360496493;4991.07665081961;4991.925121123113;4997.175466048061;4891.877703057452;4936.925946110883;4939.283803848493;4939.975300123477;4946.703197808143;4859;4902.289168070539;4905.803767849389;4969.801207951641;5001.174806157089;4824.517548245148;4842.903141937212;4851.805927762991;4865.221564549655;4869.220924652181 16:44:52 INFO - PROCESS | 4425 | |1;ext.html;547.1464515356043;566.8639526513635;576.1875755185189;580.4166812353586;581.7498475655467;28922.421551568983;40052;41817.16365672685;41869.90650467476;45530.77234613831;41590.37614435786;41990;42087.78956105223;42100.578994210045;42168.36747448783;7660.080790305157;7800.219978002211;7809.3752499799875;7810.765677029698;7812.765617031469;7814.218578142197;7880.645370958292;7885.053793544783;7895.763127106167;7896.170902055288;7888.1323054463965;7932.087809901848;7932.841343173133;7935.682572697086;7945.9602701986405;7861.882071768928;7892.723754668559;7892.763217103496;7895.960520197362;7911.802204944865;7812;7851.136374998746;7880.842383152362;7881.527108373516;7882.448228623999;39361.80319098386;39639.20721585581;39674.40488392676;39711.60288397108;39737.40393894094;3204.583404157468;3289.32568823393;3344.1973926257765;3472.861085556575;3581.7313701472235;28659.283517912012;28759.56860647092;29389;30054.699453005407;30421.543676844864;3486.529318542015;3486.843092060838;3592.0660628236587;3611.981940090309;3710.8330125144435;183107;183808;184226.99999999866;184503.99999999866;184766;31865;32720.509192362133;33052.504212436834;54073;54562;34265.65734342675;34332.97001089971;34496.655033449846;34504;34529;13046.934765326112;13196.934015329862;13243.66890827737;13271.800922986164;13287.93356033233;10668.839967400496;10677.305975111592;10679.519421626046;10680;10719.142468602493;7917.920820791718;7950.363970882316;7986.161453047463;7991.0810256821205;8062.032556093306;3123.1567476781142;3129.4679904416303;3163.8259895705955;3165.271987442855;3201.695838895301;871.2115535440437;895.6775560798108;970.9368891022061;999.6101520407047;1017.0338178730236;27752;29080.27299317534;29084.418311634072;29249.561256581168;29416.26459338534;955.2167222877174;975.8243516167016;980.4852452462515;1010.3836659637615;1012.5291739341242;15145.545633631009;15240.466583669519;15373.38506459729;15676.294566744524;15859.127747973973;384712;387359;388459;389380;389424;50580;51109;51130;51134.74432627813;51209.48790512122;1036.6786296248188;1153.9365334906493;1161.1175506615034;1178.7112157521462;1193.0634451955173;28430.289242769097;29805.701942980293;29976.100716978526;30740;30797.8460107698;42959;47189.29216061693;48858.75570622124;48883;53987.730061349444;283807;287247.63761812245;287304;287847;288030;33566.664333356355;38192.80903595464;38749.80625096856;40677.38983915303;41842;42498.78750606227;42784;43098.784506078526;43372.34941475817;44040.77979610081;36588.81705591455;37107.628923710414;37499;37537.2492550153;38471;36133.096672582345;36267.45598816073;36354.818225908704;36620;37121;36362.27275454423;36618.8169059153;36691.26617467689;36864;37455.81272093622;31211;32805.83597081999;33619.327613448084;34015.489767654;34027;25474.23577292684;26010.479790403708;26143.339932409857;26212.344691382106;26737.598936015587 16:44:52 INFO - PROCESS | 4425 | |2;jquery.html;339.5823137540823;349.4949797542552;361.10085886143503;364.1914948813634;381.0414469626122;12824;16410.67178656426;16722.91638541807;16795.91602041988;17807.64384712305;17275.91362043191;17368.305267789307;17648.470545883643;18260.634787304247;18339.17473713683;5045.394552653677;5096.261042148886;5255.684658920458;5274.55166310864;5277.472252774711;3712.2761061592864;5162.664426812245;5231.450697676746;5236.869078273055;5969.611975221618;6222.719977600997;6271.404216599416;6291.874162516747;6305.873882522347;6311.779087731908;6060.818175454721;6174.7530098796;6207.068939659042;6213.285472170668;6299.622022678631;5420.349558053059;5426.972865135688;5431.565474762009;5432.668996095982;5436.592255580847;20832.37502874916;21455;21494.462638434008;21542.461438464008;21640.89179554108;1961.4802077449488;1998.5703073839195;2355.646653002046;2469.4567195217023;2492.277239600514;6081.3614570470345;6970.616616086113;13086.214827110403;13435.26106064166;13847.584572462842;1748.5628592851788;1749.4314347836876;1771.433141394754;1818.627181427804;1837.9632407351912;69155;70538.29461705369;70572;72251.27748722499;73828.26171738267;9006.909930900738;9405.247580193569;9440.811183776423;9531.714048578553;9624.855627165598;12869.2921889297;12905.225686458842;12911.289879056741;12914.612561622978;12950.870491295154;7228.819279518054;7305.269473052652;7428.517146385468;7447.962760186165;7523.210062943422;7006.2643422439905;7038.577685338896;7078;7251.963740181265;7330.67011984462;6023.849403764853;6035.245594300713;6039.8490037748525;6073.908891366633;6181.412765787243;1749;1763.5855573940114;1782.7415024821328;1809.7559026806664;1809.8642601804918;809.6154326694891;927.2859897878595;934.131257930118;940.1162906867522;943.7216021273741;17136.22886970089;17603;18051;18450.446486605422;18530.16614252362;884.8761173435724;921.1525396635112;924.6578765856676;937.3017102258724;974.7563109222694;9915.30592858493;10289.897101029044;10521.84217236742;10541.104006159409;10566.260361774755;381805;383198;391565;395510;396140;70965.2903470969;72515.63742181256;73303.26696733071;73483.26516734764;76366.61816690881;928.6749637626912;955.5556666150412;967.240716037921;967.4002118686319;975.4732444479902;15877.2855221513;15880;16146.111963841631;16399.262033208295;16851.24169412404;38823.41764873473;38876;38895;38996;39983;52851.47148528465;53379;53530.732346338016;54335.184972224655;54383;6871.793846184622;7077.1507419107975;7078.964605176941;7175.174854891546;7223.386012189023;8639.574470212345;12016.098792590765;12230.14388992762;12250.938745306217;13175;10454.843177352193;10724.356538607708;10825.837612435977;11027.393493357942;11030.172737044913;4919.557239848287;8574.356923230907;9316.369635313657;10302.33034852732;10471.162307015573;10071.748206294902;10618.097461715532;10803.729906752395;10816.783664326827;10950.288231264942;6862.142232220973;7065.6467176639935;7072.186698529735;7130.180029296697;7164.498485105993;8730.388872778845;10170.949145254226;10339.483025848827;10566.366018038942;10728 16:44:52 INFO - PROCESS | 4425 | |3;mootools.html;1242.6023672424817;1369.4453746232773;1426.529245349035;1467.7137958098176;1696.8133505314406;6433.967830160848;7349.412047036238;7649.426293028025;7664.386849052076;7857.489263197888;7661.080670319556;7749.031371078615;7754.883676744853;7757.379409647228;7762.45662803604;2105.3683894831565;2123.7132987046784;2128.053016407699;2129.6486079796814;2130.1266480742897;2081.209140526598;2146.6887301341294;2156.5902478529106;2160.794724501178;2166.5125346797004;2103.6423807952683;2108.7574928883146;2126.734158230221;2132.040581738216;2156.55790562935;2074.823639990595;2077.8649387789897;2078.0752565108533;2078.594674038563;2080.9687854682193;1982.33591746765;2054.753429588444;2056.239191499155;2057.1565658080117;2064.5354795171115;7453;7539.396848252127;7712.074551053854;7718.922810771876;7720.1121870985;4324.6972711910175;4451.376807246988;4507.278835386355;4508.368828364031;4512.751798651073;2842.0905310300714;2961;3030.575719399286;3032.2267821705545;3041.3309072004345;974.2352253480983;980.2011360740973;988.8813342398886;997.6059456514708;1009.3489699144085;9639.277054220962;9727.65953191635;9808.558614862277;9814.705558833246;9830.754231144207;3892.9805350973065;3940.192260586573;4034.8789536313957;4064.8170832312617;4072.5927407259037;8454.070052294242;8477.533735644598;8477.618507167192;8487.405881588229;8499.957500212584;4347.174036932973;4354.542773008852;4358.21552120615;4361.498427680794;4361.80371883266;3351.396748585278;3527.647235276503;3931;3944.230874979409;3984.764722935899;3532.897925734184;3600.531930848973;3709.9629003710156;3717.237966216919;3727.142757165867;1132.5469812075237;1150.7295785490403;1151.758130792543;1156.4160099149876;1187.0978056676988;772.8454309138195;823.4482896459386;824.2499325613662;851.3317046118767;864.148813418782;5161.81933632321;5220.738963051908;5260.316158899395;5295.576353891679;5347.51872331492;917.5824999625155;942.7643089227693;956.9904300956902;969.2730452160879;990.6334656177116;3596.496490491333;3636.781793092423;3679.2273622539565;3713.665770080706;3904.7657140571655;9284.62861485533;9701.6604418845;9708.660196893215;9721.125098741148;9734.41593504392;9630.662926797528;9644.469554174448;9644.565994530123;9649.13157815786;9660.855087173699;6859.691313890887;7186.640667966581;7190.496665233488;7254.455915806336;7355.485116041933;5281.298477162431;5371.62398632092;5388.757505912322;5408.918866217088;5705;8668.176523230282;8895.24390426795;8918.10818918103;8966.641334346554;9041.23149532297;7648.273414025881;8737;9176.908230917605;9203.217726493323;9212.769680758034;5633.718314084362;5915.378885217162;6754.18949726036;6897.620630865351;6900.30996900326;7430.182679905098;7525.6989720410575;7533.472656913963;7535.54786712799;7544.471886968079;6651.235107962646;6672.633005184762;6792;6832.7950161493245;6897.55165914214;6529.608223506605;6577.210734711865;6604.075429439787;6621.404073633396;6672.866542669217;6312.968435157794;6506.577072490273;6533.542652014314;6585.868282634417;6586.209654841258;4512.729236245705;4559.38448309474;4641.11822716224;4664.953350466588;4683.625309975262;4621.32990716351;4685.437747470325;4757.976210118927;4772.331873537777;4851.151048566416 16:44:52 INFO - PROCESS | 4425 | |4;prototype.html;283.3959787602171;290.1542005055264;294.31571596039214;296.3243804126592;296.37612825003373;4803.303520989454;4914.361133052698;4923.630727695424;4942.9258561121615;4956.430010548788;4702.177119004169;4805.855824325267;4822.4213094428715;4826.179549476588;4861.100696371165;3817.3701339278987;3827.1771569112634;3848.2495913296916;3855.4024126260333;3858.5369755629363;3597.172650290435;3844.615538446161;3854.2249580302278;3859.36320507116;3880.2821478026513;3566.197605538746;3718.7396882218254;3751.6623503884643;3753.6058713835064;3771.717121215906;3760.135168911152;3760.3607386744184;3767.2653832502397;3767.3407153747985;3775.9811200944096;3320.767546271738;3326.3846188454972;3336.849841757127;3343.8160901150427;3347.6317605063423;4588.141802569964;4775.689580177277;4781.904361912742;4784.5933095686905;4801.831935882262;4273.687891883815;4289.721168124062;4295.763732994684;4299.247631664478;4300.591443812833;5048.8697007855;5060.924086138711;5068.594512438996;5072.34059572257;5114.897702045975;3328.6172090209693;3604.9279014419567;3605.1888325126897;3615.783053016801;3627.8004709740953;5318.627696061278;5328.6269961102735;5332.92000619991;5334.813281535127;5335.439778823245;3665.890023299305;3670.7430479866152;3673.9081522961606;3698.5746639136305;3705.629437056327;3725.9441108383394;3750.5499340079364;3751.2122454284904;3752.437134429803;3752.7560708553856;4194.601512856274;4264.573542645772;4277.224951645095;4292.227399068198;4314.590113939171;5085.821996230115;5097.464766199496;5102.209157580581;5102.413222479388;5102.846914592568;1219.5000049979467;1238.3127364312713;1278.7058976435471;1301.9869801302054;1302.6222395505388;816.848882956655;833.8999320081629;836.5691668790578;837.67962743201;841.5539763925129;4484.497693272725;4523.88690282739;4527.049319642846;4532.4334458192725;4536.251518499476;5226.5818734501145;5233.947660523422;5242.213667949838;5249.343832020997;5254.448282930313;4357.193919124972;4467.5755803198645;4488.169688607618;4513.323001549728;4516.683832131719;2425.2966639674296;2457.004913010234;2457.8525288482747;2458.2300743464675;2466.839655422392;4339.652827773771;4357.237483440385;4364.672649551297;4364.886953826754;4366;4314.331278651814;4597.908041839144;4627.3521706961055;4649.674522783373;4689.921318096857;4305.634021108178;4310.017391999652;4336.241157797373;4338.327559228324;4349.02147016925;4580.839670611513;4612.563640088156;4614.976925115353;4615.353850460871;4638;4242.639375653104;4514.751688657024;4517.864464066083;4529.592336689714;4548.587869766321;4342.522322544454;4345.130973805189;4381.364702118239;4388;4409.889752756207;3307.007897630653;3318.4856347266214;3321.7709447504576;3348.464245720673;3363.3105213431677;4375.649948004216;4630.1942242524765;4636.93044604338;4639.188142075056;4681.438227412732;4417.359482875029;4425.668074894332;4428.387251521618;4429.712068715523;4435.157320109169;4404.383386325853;4430.357598148186;4433.955660443355;4461.330800379969;4489.842855500042;4428.2914733642465;4446.53311402311;4460.085682435158;4756.167670657552;4900.411950565955;4750.738709370879;4960.72716000609;4990.975045124751;5042.445331013512;5094.1849304111165;4921.975390123026;4961.355023846877;4981.327520784647;4997.85006449807;5006.424261210008 16:44:52 INFO - PROCESS | 4425 | |5;yui.html;533.1065075589361;652.7617419641831;660.8281846719855;677.4783416769085;688.9724411023559;12706.936465317673;14081.29593520325;14088.295585220736;14097.647558811022;14099.78850317246;12270.631881043582;12331.136820422575;12335.876641233584;12354.629361119181;12361.134720569564;621.4500167351881;749.7375918428534;755.7543798265572;779.2908453307491;782.5617654113714;776.3827756933251;780.6916268074108;781.679511400326;782.1982467970319;782.7221336425572;823.6705317872869;824.6412810427453;824.8886400335967;825.2119226139052;825.3685930263354;660.0956689335617;791.3945831438954;816.1797393619433;820.5938060659952;824.5135370131591;601.3835818286248;601.9247594050744;602.7408214467777;603.2971588099858;603.4629180029777;13103.737925241441;13111.278879661615;13124.081314308003;13133.868661313456;13137.146085504508;11213.663590092228;11993.820092698617;12342.81485777714;12640.620781376574;12966.416511256923;11579.710507237301;11917.940410297893;12110.091743119214;12411.565595204125;12632.873671263262;3871.3031654302495;3952.7430717003303;3993.2412841560013;4055.229506393776;4063.045184381668;53370.46629533694;54530.45469545333;67891.66054169697;68045.25751083689;68682.19224654276;10203.744906377251;10366;10537.789244215226;10761.192910531741;11284.774304513863;19275.036248187535;19283.325083622007;19290.131944062272;19309.131089101025;19313.324033659035;7060.6116663584;7183.46124040699;7196.028536147658;7203.783886483414;7266.527675701062;3845.9230815383535;3871.070942973666;3905.414187871785;3959.3862951242604;3993.940090898639;2902.4050069735654;2969.5545668149516;2986.671466138723;3000.819950802959;3029.5001324781606;496.2481840012384;498.1083859890755;503.2702581257192;508.329005712456;517.6298946253447;514.5960421069517;534.4415086234894;561.9743967259685;576.8615532272308;623.1680706257107;8144.714934977366;8508.702195423131;8573.699920502753;8700.825983480296;8714.4838873864;532.475511621053;558.8467614534029;574.6006525464762;615.9353267906805;621.2234706616729;4034.757914525138;4100.528439229467;4176.812043458051;4231.7672528010635;4252.383404406344;100011;104472;105513;110341.44829275802;110847;87706;90365.99999999869;90534.54732726295;91311.54344228236;92435;64931.67534162299;74108.62945685237;77466;79776.60111699405;80649;7672.693092276247;7985.920140798517;8010.679572817022;8132.67469301245;8236.629351679068;48324.7583762093;48601.513984861114;48681.269780954026;49431.25853112278;49432.75283623559;39467;39712.80143599264;40081.599184008955;54523.45476545184;67229;9295.953520232355;10120.84818727705;10214.182865370902;10282.228832837716;10379.481025948824;11012.119030477383;11028.944855275673;11180;11223.382713950485;11343.546258149581;10554.472276385997;10752.946235268773;10826.296290741077;10845.783084338427;11233.66299011031;10754.838677419688;11370.374629395463;11670.358130302915;12161;12180.93909530482;12298.631041068782;12423.254604723745;12547.560835370718;12671.556495522613;12691.301978391277;10387.169026478015;10551;10601.575936962743;11301.830472543083;11382.886171138514;9076;9366.859497107413;10936.617218397318;11228.214025018497;11243.100551955988 16:44:52 INFO - PROCESS | 4425 | __end_tp_report 16:44:52 INFO - PROCESS | 4425 | __start_cc_report 16:44:52 INFO - PROCESS | 4425 | _x_x_mozilla_cycle_collect,1219 16:44:52 INFO - PROCESS | 4425 | __end_cc_report 16:44:52 INFO - PROCESS | 4425 | __startTimestamp1470959092805__endTimestamp 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | ------- Summary: start ------- 16:44:52 INFO - PROCESS | 4425 | Number of tests: 6 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | [#0] dojo.html Cycles:165 Average:4778.28 Median:4891.88 stddev:501.28 (10.2%) stddev-sans-first:473.83 16:44:52 INFO - PROCESS | 4425 | Values: 2636.6 2649.4 2677.0 2682.2 2683.7 4626.6 4667.7 4824.0 4949.5 4949.5 4733.1 4736.7 4754.9 4807.1 4865.1 4400.1 4504.9 4511.3 4512.0 4539.4 4395.1 4406.9 4443.5 4485.9 4515.1 4508.8 4547.2 4563.7 4564.1 4566.4 4238.1 4475.2 4481.3 4489.1 4557.9 4245.6 4278.4 4406.9 4451.3 4456.1 4785.1 4798.7 4846.7 4855.9 4925.8 5163.8 5222.4 5274.1 5275.0 5281.0 5029.3 5245.3 5251.6 5288.4 5311.6 4948.9 4949.6 4950.2 4950.3 4958.2 5392.5 5455.1 5455.2 5459.8 5460.3 4913.8 5049.2 5077.2 5097.4 5214.1 5191.9 5200.2 5203.5 5246.9 5265.4 5166.6 5175.8 5181.5 5184.7 5236.1 4963.7 5006.0 5151.4 5154.2 5207.9 4494.2 4497.8 4537.6 4537.8 4546.1 3903.6 3914.2 3919.4 3922.1 3955.5 4328.4 4402.3 4421.2 4548.0 4588.1 5133.5 5167.0 5174.2 5218.0 5225.5 4426.8 4437.3 4444.4 4489.3 4492.0 4507.9 4626.3 4648.9 4659.5 4663.9 4829.2 4852.0 4854.5 4877.7 4902.3 5161.5 5203.1 5215.5 5219.6 5267.7 4727.7 4746.3 4774.9 4846.7 4906.5 5027.8 5035.3 5041.0 5069.5 5083.9 5118.8 5119.6 5121.3 5133.6 5171.8 4784.3 4933.9 4956.9 4966.2 4975.3 4961.7 4964.0 4991.1 4991.9 4997.2 4891.9 4936.9 4939.3 4940.0 4946.7 4859.0 4902.3 4905.8 4969.8 5001.2 4824.5 4842.9 4851.8 4865.2 4869.2 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | [#1] ext.html Cycles:180 Average:44323.52 Median:20287.42 stddev:78668.44 (387.8%) stddev-sans-first:78820.46 16:44:52 INFO - PROCESS | 4425 | Values: 547.1 566.9 576.2 580.4 581.7 28922.4 40052.0 41817.2 41869.9 45530.8 41590.4 41990.0 42087.8 42100.6 42168.4 7660.1 7800.2 7809.4 7810.8 7812.8 7814.2 7880.6 7885.1 7895.8 7896.2 7888.1 7932.1 7932.8 7935.7 7946.0 7861.9 7892.7 7892.8 7896.0 7911.8 7812.0 7851.1 7880.8 7881.5 7882.4 39361.8 39639.2 39674.4 39711.6 39737.4 3204.6 3289.3 3344.2 3472.9 3581.7 28659.3 28759.6 29389.0 30054.7 30421.5 3486.5 3486.8 3592.1 3612.0 3710.8 183107.0 183808.0 184227.0 184504.0 184766.0 31865.0 32720.5 33052.5 54073.0 54562.0 34265.7 34333.0 34496.7 34504.0 34529.0 13046.9 13196.9 13243.7 13271.8 13287.9 10668.8 10677.3 10679.5 10680.0 10719.1 7917.9 7950.4 7986.2 7991.1 8062.0 3123.2 3129.5 3163.8 3165.3 3201.7 871.2 895.7 970.9 999.6 1017.0 27752.0 29080.3 29084.4 29249.6 29416.3 955.2 975.8 980.5 1010.4 1012.5 15145.5 15240.5 15373.4 15676.3 15859.1 384712.0 387359.0 388459.0 389380.0 389424.0 50580.0 51109.0 51130.0 51134.7 51209.5 1036.7 1153.9 1161.1 1178.7 1193.1 28430.3 29805.7 29976.1 30740.0 30797.8 42959.0 47189.3 48858.8 48883.0 53987.7 283807.0 287247.6 287304.0 287847.0 288030.0 33566.7 38192.8 38749.8 40677.4 41842.0 42498.8 42784.0 43098.8 43372.3 44040.8 36588.8 37107.6 37499.0 37537.2 38471.0 36133.1 36267.5 36354.8 36620.0 37121.0 36362.3 36618.8 36691.3 36864.0 37455.8 31211.0 32805.8 33619.3 34015.5 34027.0 25474.2 26010.5 26143.3 26212.3 26737.6 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | [#2] jquery.html Cycles:180 Average:24547.52 Median:5129.46 stddev:64323.18 (1254.0%) stddev-sans-first:64477.94 16:44:52 INFO - PROCESS | 4425 | Values: 339.6 349.5 361.1 364.2 381.0 12824.0 16410.7 16722.9 16795.9 17807.6 17275.9 17368.3 17648.5 18260.6 18339.2 5045.4 5096.3 5255.7 5274.6 5277.5 3712.3 5162.7 5231.5 5236.9 5969.6 6222.7 6271.4 6291.9 6305.9 6311.8 6060.8 6174.8 6207.1 6213.3 6299.6 5420.3 5427.0 5431.6 5432.7 5436.6 20832.4 21455.0 21494.5 21542.5 21640.9 1961.5 1998.6 2355.6 2469.5 2492.3 6081.4 6970.6 13086.2 13435.3 13847.6 1748.6 1749.4 1771.4 1818.6 1838.0 69155.0 70538.3 70572.0 72251.3 73828.3 9006.9 9405.2 9440.8 9531.7 9624.9 12869.3 12905.2 12911.3 12914.6 12950.9 7228.8 7305.3 7428.5 7448.0 7523.2 7006.3 7038.6 7078.0 7252.0 7330.7 6023.8 6035.2 6039.8 6073.9 6181.4 1749.0 1763.6 1782.7 1809.8 1809.9 809.6 927.3 934.1 940.1 943.7 17136.2 17603.0 18051.0 18450.4 18530.2 884.9 921.2 924.7 937.3 974.8 9915.3 10289.9 10521.8 10541.1 10566.3 381805.0 383198.0 391565.0 395510.0 396140.0 70965.3 72515.6 73303.3 73483.3 76366.6 928.7 955.6 967.2 967.4 975.5 15877.3 15880.0 16146.1 16399.3 16851.2 38823.4 38876.0 38895.0 38996.0 39983.0 52851.5 53379.0 53530.7 54335.2 54383.0 6871.8 7077.2 7079.0 7175.2 7223.4 8639.6 12016.1 12230.1 12250.9 13175.0 10454.8 10724.4 10825.8 11027.4 11030.2 4919.6 8574.4 9316.4 10302.3 10471.2 10071.7 10618.1 10803.7 10816.8 10950.3 6862.1 7065.6 7072.2 7130.2 7164.5 8730.4 10170.9 10339.5 10566.4 10728.0 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | [#3] mootools.html Cycles:180 Average:5049.44 Median:5669.36 stddev:2797.72 (49.3%) stddev-sans-first:2790.94 16:44:52 INFO - PROCESS | 4425 | Values: 1242.6 1369.4 1426.5 1467.7 1696.8 6434.0 7349.4 7649.4 7664.4 7857.5 7661.1 7749.0 7754.9 7757.4 7762.5 2105.4 2123.7 2128.1 2129.6 2130.1 2081.2 2146.7 2156.6 2160.8 2166.5 2103.6 2108.8 2126.7 2132.0 2156.6 2074.8 2077.9 2078.1 2078.6 2081.0 1982.3 2054.8 2056.2 2057.2 2064.5 7453.0 7539.4 7712.1 7718.9 7720.1 4324.7 4451.4 4507.3 4508.4 4512.8 2842.1 2961.0 3030.6 3032.2 3041.3 974.2 980.2 988.9 997.6 1009.3 9639.3 9727.7 9808.6 9814.7 9830.8 3893.0 3940.2 4034.9 4064.8 4072.6 8454.1 8477.5 8477.6 8487.4 8500.0 4347.2 4354.5 4358.2 4361.5 4361.8 3351.4 3527.6 3931.0 3944.2 3984.8 3532.9 3600.5 3710.0 3717.2 3727.1 1132.5 1150.7 1151.8 1156.4 1187.1 772.8 823.4 824.2 851.3 864.1 5161.8 5220.7 5260.3 5295.6 5347.5 917.6 942.8 957.0 969.3 990.6 3596.5 3636.8 3679.2 3713.7 3904.8 9284.6 9701.7 9708.7 9721.1 9734.4 9630.7 9644.5 9644.6 9649.1 9660.9 6859.7 7186.6 7190.5 7254.5 7355.5 5281.3 5371.6 5388.8 5408.9 5705.0 8668.2 8895.2 8918.1 8966.6 9041.2 7648.3 8737.0 9176.9 9203.2 9212.8 5633.7 5915.4 6754.2 6897.6 6900.3 7430.2 7525.7 7533.5 7535.5 7544.5 6651.2 6672.6 6792.0 6832.8 6897.6 6529.6 6577.2 6604.1 6621.4 6672.9 6313.0 6506.6 6533.5 6585.9 6586.2 4512.7 4559.4 4641.1 4665.0 4683.6 4621.3 4685.4 4758.0 4772.3 4851.2 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | [#4] prototype.html Cycles:180 Average:4030.55 Median:4421.51 stddev:1155.72 (26.1%) stddev-sans-first:1124.22 16:44:52 INFO - PROCESS | 4425 | Values: 283.4 290.2 294.3 296.3 296.4 4803.3 4914.4 4923.6 4942.9 4956.4 4702.2 4805.9 4822.4 4826.2 4861.1 3817.4 3827.2 3848.2 3855.4 3858.5 3597.2 3844.6 3854.2 3859.4 3880.3 3566.2 3718.7 3751.7 3753.6 3771.7 3760.1 3760.4 3767.3 3767.3 3776.0 3320.8 3326.4 3336.8 3343.8 3347.6 4588.1 4775.7 4781.9 4784.6 4801.8 4273.7 4289.7 4295.8 4299.2 4300.6 5048.9 5060.9 5068.6 5072.3 5114.9 3328.6 3604.9 3605.2 3615.8 3627.8 5318.6 5328.6 5332.9 5334.8 5335.4 3665.9 3670.7 3673.9 3698.6 3705.6 3725.9 3750.5 3751.2 3752.4 3752.8 4194.6 4264.6 4277.2 4292.2 4314.6 5085.8 5097.5 5102.2 5102.4 5102.8 1219.5 1238.3 1278.7 1302.0 1302.6 816.8 833.9 836.6 837.7 841.6 4484.5 4523.9 4527.0 4532.4 4536.3 5226.6 5233.9 5242.2 5249.3 5254.4 4357.2 4467.6 4488.2 4513.3 4516.7 2425.3 2457.0 2457.9 2458.2 2466.8 4339.7 4357.2 4364.7 4364.9 4366.0 4314.3 4597.9 4627.4 4649.7 4689.9 4305.6 4310.0 4336.2 4338.3 4349.0 4580.8 4612.6 4615.0 4615.4 4638.0 4242.6 4514.8 4517.9 4529.6 4548.6 4342.5 4345.1 4381.4 4388.0 4409.9 3307.0 3318.5 3321.8 3348.5 3363.3 4375.6 4630.2 4636.9 4639.2 4681.4 4417.4 4425.7 4428.4 4429.7 4435.2 4404.4 4430.4 4434.0 4461.3 4489.8 4428.3 4446.5 4460.1 4756.2 4900.4 4750.7 4960.7 4991.0 5042.4 5094.2 4922.0 4961.4 4981.3 4997.9 5006.4 16:44:52 INFO - PROCESS | 4425 | 16:44:52 INFO - PROCESS | 4425 | [#5] yui.html Cycles:180 Average:17984.81 Median:4081.79 stddev:26301.10 (644.4%) stddev-sans-first:26342.23 16:44:52 INFO - PROCESS | 4425 | Values: 533.1 652.8 660.8 677.5 689.0 12706.9 14081.3 14088.3 14097.6 14099.8 12270.6 12331.1 12335.9 12354.6 12361.1 621.5 749.7 755.8 779.3 782.6 776.4 780.7 781.7 782.2 782.7 823.7 824.6 824.9 825.2 825.4 660.1 791.4 816.2 820.6 824.5 601.4 601.9 602.7 603.3 603.5 13103.7 13111.3 13124.1 13133.9 13137.1 11213.7 11993.8 12342.8 12640.6 12966.4 11579.7 11917.9 12110.1 12411.6 12632.9 3871.3 3952.7 3993.2 4055.2 4063.0 53370.5 54530.5 67891.7 68045.3 68682.2 10203.7 10366.0 10537.8 10761.2 11284.8 19275.0 19283.3 19290.1 19309.1 19313.3 7060.6 7183.5 7196.0 7203.8 7266.5 3845.9 3871.1 3905.4 3959.4 3993.9 2902.4 2969.6 2986.7 3000.8 3029.5 496.2 498.1 503.3 508.3 517.6 514.6 534.4 562.0 576.9 623.2 8144.7 8508.7 8573.7 8700.8 8714.5 532.5 558.8 574.6 615.9 621.2 4034.8 4100.5 4176.8 4231.8 4252.4 100011.0 104472.0 105513.0 110341.4 110847.0 87706.0 90366.0 90534.5 91311.5 92435.0 64931.7 74108.6 77466.0 79776.6 80649.0 7672.7 7985.9 8010.7 8132.7 8236.6 48324.8 48601.5 48681.3 49431.3 49432.8 39467.0 39712.8 40081.6 54523.5 67229.0 9296.0 10120.8 10214.2 10282.2 10379.5 11012.1 11028.9 11180.0 11223.4 11343.5 10554.5 10752.9 10826.3 10845.8 11233.7 10754.8 11370.4 11670.4 12161.0 12180.9 12298.6 12423.3 12547.6 12671.6 12691.3 10387.2 10551.0 10601.6 11301.8 11382.9 9076.0 9366.9 10936.6 11228.2 11243.1 16:44:52 INFO - PROCESS | 4425 | -------- Summary: end -------- 16:44:52 INFO - PROCESS | 4425 | 16:44:53 INFO - TEST-INFO | 4425: exit 0 16:44:53 INFO - TEST-OK | dromaeo_css | took 1121191ms 16:44:53 INFO - TEST-START | kraken 16:44:53 INFO - operating with platform_type : linux_ 16:44:53 INFO - Initialising browser for kraken test... 16:44:53 INFO - TEST-INFO | started process 4722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSBnLCF/profile http://localhost:40118/getInfo.html) 16:44:58 INFO - PROCESS | 4722 | __metrics Screen width/height:1600/1200 16:44:58 INFO - PROCESS | 4722 | colorDepth:24 16:44:58 INFO - PROCESS | 4722 | Browser inner width/height: 1024/697 16:44:58 INFO - PROCESS | 4722 | __metrics 16:44:59 INFO - PROCESS | 4722 | 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" 16:44:59 INFO - PROCESS | 4722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:45:00 INFO - TEST-INFO | 4722: exit 0 16:45:00 INFO - Browser initialized. 16:45:00 INFO - Running cycle 1/1 for kraken test... 16:45:00 INFO - TEST-INFO | started process 4801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSBnLCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:11 INFO - PROCESS | 4801 | RSS: Main: 156893184 16:45:11 INFO - PROCESS | 4801 | 16:45:14 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40118/tests/kraken/driver.html?testName=audio-beat-detection) 16:45:15 INFO - PROCESS | 4801 | RSS: Main: 213291008 16:45:15 INFO - PROCESS | 4801 | 16:45:18 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40118/tests/kraken/driver.html?testName=audio-dft) 16:45:18 INFO - PROCESS | 4801 | RSS: Main: 191410176 16:45:18 INFO - PROCESS | 4801 | 16:45:22 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40118/tests/kraken/driver.html?testName=audio-fft) 16:45:22 INFO - PROCESS | 4801 | RSS: Main: 272269312 16:45:22 INFO - PROCESS | 4801 | 16:45:25 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40118/tests/kraken/driver.html?testName=audio-oscillator) 16:45:25 INFO - PROCESS | 4801 | RSS: Main: 179171328 16:45:25 INFO - PROCESS | 4801 | 16:45:27 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40118/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:45:28 INFO - PROCESS | 4801 | RSS: Main: 183836672 16:45:28 INFO - PROCESS | 4801 | 16:45:31 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40118/tests/kraken/driver.html?testName=imaging-darkroom) 16:45:32 INFO - PROCESS | 4801 | RSS: Main: 220639232 16:45:32 INFO - PROCESS | 4801 | 16:45:35 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40118/tests/kraken/driver.html?testName=imaging-desaturate) 16:45:36 INFO - PROCESS | 4801 | RSS: Main: 220065792 16:45:36 INFO - PROCESS | 4801 | 16:45:39 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40118/tests/kraken/driver.html?testName=json-parse-financial) 16:45:39 INFO - PROCESS | 4801 | RSS: Main: 219602944 16:45:39 INFO - PROCESS | 4801 | 16:45:41 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40118/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:45:42 INFO - PROCESS | 4801 | RSS: Main: 184557568 16:45:42 INFO - PROCESS | 4801 | 16:45:43 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:45:44 INFO - PROCESS | 4801 | RSS: Main: 190939136 16:45:44 INFO - PROCESS | 4801 | 16:45:46 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:45:47 INFO - PROCESS | 4801 | RSS: Main: 194428928 16:45:47 INFO - PROCESS | 4801 | 16:45:50 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:45:50 INFO - PROCESS | 4801 | RSS: Main: 189435904 16:45:50 INFO - PROCESS | 4801 | 16:45:53 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:45:54 INFO - PROCESS | 4801 | RSS: Main: 192409600 16:45:54 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | Cycle 1(1): loaded http://localhost:40118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40118/tests/kraken/driver.html?testName=ai-astar) 16:45:56 INFO - PROCESS | 4801 | RSS: Main: 242905088 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | __start_tp_report 16:45:56 INFO - PROCESS | 4801 | _x_x_mozilla_page_load 16:45:56 INFO - PROCESS | 4801 | _x_x_mozilla_page_load_details 16:45:56 INFO - PROCESS | 4801 | |i|pagename|runs| 16:45:56 INFO - PROCESS | 4801 | |0;ai-astar;104;116;113;113;113;113;113;114;114;113 16:45:56 INFO - PROCESS | 4801 | |1;audio-beat-detection;151;126;124;192;121;126;146;123;185;122 16:45:56 INFO - PROCESS | 4801 | |2;audio-dft;162;161;161;161;163;161;162;162;161;159 16:45:56 INFO - PROCESS | 4801 | |3;audio-fft;75;77;75;113;76;76;76;76;109;77 16:45:56 INFO - PROCESS | 4801 | |4;audio-oscillator;85;85;123;85;86;85;124;83;84;121 16:45:56 INFO - PROCESS | 4801 | |5;imaging-gaussian-blur;117;116;118;117;117;117;117;116;117;116 16:45:56 INFO - PROCESS | 4801 | |6;imaging-darkroom;146;146;145;145;146;146;145;146;146;145 16:45:56 INFO - PROCESS | 4801 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;96;96 16:45:56 INFO - PROCESS | 4801 | |8;json-parse-financial;63;62;62;64;63;63;63;63;62;62 16:45:56 INFO - PROCESS | 4801 | |9;json-stringify-tinderbox;65;65;65;66;66;67;66;66;65;65 16:45:56 INFO - PROCESS | 4801 | |10;stanford-crypto-aes;79;80;80;79;79;79;79;81;80;81 16:45:56 INFO - PROCESS | 4801 | |11;stanford-crypto-ccm;131;132;140;130;130;138;130;130;146;139 16:45:56 INFO - PROCESS | 4801 | |12;stanford-crypto-pbkdf2;166;167;168;170;166;165;166;173;167;165 16:45:56 INFO - PROCESS | 4801 | |13;stanford-crypto-sha256-iterative;68;70;67;67;67;69;75;70;70;67 16:45:56 INFO - PROCESS | 4801 | __end_tp_report 16:45:56 INFO - PROCESS | 4801 | __start_cc_report 16:45:56 INFO - PROCESS | 4801 | _x_x_mozilla_cycle_collect,1949 16:45:56 INFO - PROCESS | 4801 | __end_cc_report 16:45:56 INFO - PROCESS | 4801 | __startTimestamp1470959156354__endTimestamp 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | ------- Summary: start ------- 16:45:56 INFO - PROCESS | 4801 | Number of tests: 14 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:1.01 16:45:56 INFO - PROCESS | 4801 | Values: 104.0 116.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 113.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:136.00 stddev:26.84 (19.7%) stddev-sans-first:28.25 16:45:56 INFO - PROCESS | 4801 | Values: 151.0 126.0 124.0 192.0 121.0 126.0 146.0 123.0 185.0 122.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 16:45:56 INFO - PROCESS | 4801 | Values: 162.0 161.0 161.0 161.0 163.0 161.0 162.0 162.0 161.0 159.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.80 (19.5%) stddev-sans-first:15.41 16:45:56 INFO - PROCESS | 4801 | Values: 75.0 77.0 75.0 113.0 76.0 76.0 76.0 76.0 109.0 77.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:18.36 (21.6%) stddev-sans-first:19.03 16:45:56 INFO - PROCESS | 4801 | Values: 85.0 85.0 123.0 85.0 86.0 85.0 124.0 83.0 84.0 121.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:45:56 INFO - PROCESS | 4801 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:45:56 INFO - PROCESS | 4801 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:45:56 INFO - PROCESS | 4801 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 16:45:56 INFO - PROCESS | 4801 | Values: 63.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 62.0 62.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 16:45:56 INFO - PROCESS | 4801 | Values: 65.0 65.0 65.0 66.0 66.0 67.0 66.0 66.0 65.0 65.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 16:45:56 INFO - PROCESS | 4801 | Values: 79.0 80.0 80.0 79.0 79.0 79.0 79.0 81.0 80.0 81.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:135.00 stddev:5.72 (4.2%) stddev-sans-first:5.92 16:45:56 INFO - PROCESS | 4801 | Values: 131.0 132.0 140.0 130.0 130.0 138.0 130.0 130.0 146.0 139.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:2.50 (1.5%) stddev-sans-first:2.60 16:45:56 INFO - PROCESS | 4801 | Values: 166.0 167.0 168.0 170.0 166.0 165.0 166.0 173.0 167.0 165.0 16:45:56 INFO - PROCESS | 4801 | 16:45:56 INFO - PROCESS | 4801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:2.49 (3.6%) stddev-sans-first:2.62 16:45:56 INFO - PROCESS | 4801 | Values: 68.0 70.0 67.0 67.0 67.0 69.0 75.0 70.0 70.0 67.0 16:45:56 INFO - PROCESS | 4801 | -------- Summary: end -------- 16:45:56 INFO - PROCESS | 4801 | 16:45:57 INFO - TEST-INFO | 4801: exit 0 16:45:57 INFO - TEST-OK | kraken | took 63791ms 16:45:57 INFO - SUITE-END | took 1184s 16:45:57 INFO - Completed test suite (00:19:45) 16:45:57 INFO - javascript benchmark 16:45:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.6308716779654, 2649.4171282317884, 2676.9961264525805, 2682.2221555748833, 2683.718209587993, 4626.629869610431, 4667.719936803795, 4823.975880120599, 4949.52979466951, 4949.52979466951, 4733.1243719911845, 4736.739479328636, 4754.9286760698615, 4807.0866535358255, 4865.075635629228, 4400.119976004796, 4504.864854054384, 4511.300748384006, 4511.977440112795, 4539.387182730322, 4395.05506316142, 4406.889827754299, 4443.488998765135, 4485.865424037284, 4515.05183911379, 4508.752018638974, 4547.1587756265035, 4563.726176429408, 4564.0871825635, 4566.406367172263, 4238.109996900655, 4475.1944649963, 4481.282994720829, 4489.147062058215, 4557.886052848706, 4245.5542168072525, 4278.443802305712, 4406.889827754332, 4451.2655411857, 4456.108778244332, 4785.066911952171, 4798.664093513456, 4846.733429661367, 4855.902881942341, 4925.802967881281, 5163.845084647466, 5222.399424066243, 5274.103402421598, 5274.973625131888, 5281.0, 5029.321041659366, 5245.26566280721, 5251.6061295403, 5288.391834938992, 5311.601629877775, 4948.925766113512, 4949.579285760678, 4950.18321976877, 4950.25746138075, 4958.181899986462, 5392.487713667196, 5455.0726376515295, 5455.1544510600925, 5459.781608735686, 5460.31746031746, 4913.803447862046, 5049.242613607915, 5077.213031980049, 5097.362829646294, 5214.139666954986, 5191.9480805192225, 5200.193969934666, 5203.531682148625, 5246.895062098737, 5265.420803711589, 5166.5866730661455, 5175.792968281226, 5181.4559471255725, 5184.7407629618365, 5236.083685355124, 4963.677360971597, 5005.974970125126, 5151.381834179922, 5154.226865970059, 5207.869803254873, 4494.191045611756, 4497.752623605733, 4537.568930951555, 4537.77311134442, 4546.1135078659345, 3903.590123037097, 3914.2171565686976, 3919.392494163409, 3922.097917478996, 3955.5055618047745, 4328.350747387917, 4402.25161722508, 4421.204183246982, 4547.977260113678, 4588.105319462673, 5133.486651334837, 5167.0, 5174.197999310113, 5218.0, 5225.503577160163, 4426.778661066934, 4437.29003359461, 4444.355568442623, 4489.32660100981, 4491.977540112279, 4507.864764057083, 4626.282926146453, 4648.86053418398, 4659.510751371125, 4663.860084197479, 4829.179039563212, 4851.95148048515, 4854.514548545118, 4877.731724755031, 4902.313676085422, 5161.535461808456, 5203.11547036997, 5215.530602245816, 5219.608529360389, 5267.73661316925, 4727.692699974628, 4746.288056791509, 4774.856754297377, 4846.709197448165, 4906.509349065065, 5027.849164524924, 5035.320231768665, 5041.0, 5069.493050694901, 5083.923741143812, 5118.846434606968, 5119.5648369887485, 5121.257417674491, 5133.589312855037, 5171.793128274827, 4784.258439941815, 4933.925991110208, 4956.8760780980765, 4966.205407134841, 4975.253711943237, 4961.652684312208, 4963.950360496493, 4991.07665081961, 4991.925121123113, 4997.175466048061, 4891.877703057452, 4936.925946110883, 4939.283803848493, 4939.975300123477, 4946.703197808143, 4859.0, 4902.289168070539, 4905.803767849389, 4969.801207951641, 5001.174806157089, 4824.517548245148, 4842.903141937212, 4851.805927762991, 4865.221564549655, 4869.220924652181], "value": 4746.228162182633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.1464515356043, 566.8639526513635, 576.1875755185189, 580.4166812353586, 581.7498475655467, 28922.421551568983, 40052.0, 41817.16365672685, 41869.90650467476, 45530.77234613831, 41590.37614435786, 41990.0, 42087.78956105223, 42100.578994210045, 42168.36747448783, 7660.080790305157, 7800.219978002211, 7809.3752499799875, 7810.765677029698, 7812.765617031469, 7814.218578142197, 7880.645370958292, 7885.053793544783, 7895.763127106167, 7896.170902055288, 7888.1323054463965, 7932.087809901848, 7932.841343173133, 7935.682572697086, 7945.9602701986405, 7861.882071768928, 7892.723754668559, 7892.763217103496, 7895.960520197362, 7911.802204944865, 7812.0, 7851.136374998746, 7880.842383152362, 7881.527108373516, 7882.448228623999, 39361.80319098386, 39639.20721585581, 39674.40488392676, 39711.60288397108, 39737.40393894094, 3204.583404157468, 3289.32568823393, 3344.1973926257765, 3472.861085556575, 3581.7313701472235, 28659.283517912012, 28759.56860647092, 29389.0, 30054.699453005407, 30421.543676844864, 3486.529318542015, 3486.843092060838, 3592.0660628236587, 3611.981940090309, 3710.8330125144435, 183107.0, 183808.0, 184226.99999999866, 184503.99999999866, 184766.0, 31865.0, 32720.509192362133, 33052.504212436834, 54073.0, 54562.0, 34265.65734342675, 34332.97001089971, 34496.655033449846, 34504.0, 34529.0, 13046.934765326112, 13196.934015329862, 13243.66890827737, 13271.800922986164, 13287.93356033233, 10668.839967400496, 10677.305975111592, 10679.519421626046, 10680.0, 10719.142468602493, 7917.920820791718, 7950.363970882316, 7986.161453047463, 7991.0810256821205, 8062.032556093306, 3123.1567476781142, 3129.4679904416303, 3163.8259895705955, 3165.271987442855, 3201.695838895301, 871.2115535440437, 895.6775560798108, 970.9368891022061, 999.6101520407047, 1017.0338178730236, 27752.0, 29080.27299317534, 29084.418311634072, 29249.561256581168, 29416.26459338534, 955.2167222877174, 975.8243516167016, 980.4852452462515, 1010.3836659637615, 1012.5291739341242, 15145.545633631009, 15240.466583669519, 15373.38506459729, 15676.294566744524, 15859.127747973973, 384712.0, 387359.0, 388459.0, 389380.0, 389424.0, 50580.0, 51109.0, 51130.0, 51134.74432627813, 51209.48790512122, 1036.6786296248188, 1153.9365334906493, 1161.1175506615034, 1178.7112157521462, 1193.0634451955173, 28430.289242769097, 29805.701942980293, 29976.100716978526, 30740.0, 30797.8460107698, 42959.0, 47189.29216061693, 48858.75570622124, 48883.0, 53987.730061349444, 283807.0, 287247.63761812245, 287304.0, 287847.0, 288030.0, 33566.664333356355, 38192.80903595464, 38749.80625096856, 40677.38983915303, 41842.0, 42498.78750606227, 42784.0, 43098.784506078526, 43372.34941475817, 44040.77979610081, 36588.81705591455, 37107.628923710414, 37499.0, 37537.2492550153, 38471.0, 36133.096672582345, 36267.45598816073, 36354.818225908704, 36620.0, 37121.0, 36362.27275454423, 36618.8169059153, 36691.26617467689, 36864.0, 37455.81272093622, 31211.0, 32805.83597081999, 33619.327613448084, 34015.489767654, 34027.0, 25474.23577292684, 26010.479790403708, 26143.339932409857, 26212.344691382106, 26737.598936015587], "value": 16716.56132558571, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5823137540823, 349.4949797542552, 361.10085886143503, 364.1914948813634, 381.0414469626122, 12824.0, 16410.67178656426, 16722.91638541807, 16795.91602041988, 17807.64384712305, 17275.91362043191, 17368.305267789307, 17648.470545883643, 18260.634787304247, 18339.17473713683, 5045.394552653677, 5096.261042148886, 5255.684658920458, 5274.55166310864, 5277.472252774711, 3712.2761061592864, 5162.664426812245, 5231.450697676746, 5236.869078273055, 5969.611975221618, 6222.719977600997, 6271.404216599416, 6291.874162516747, 6305.873882522347, 6311.779087731908, 6060.818175454721, 6174.7530098796, 6207.068939659042, 6213.285472170668, 6299.622022678631, 5420.349558053059, 5426.972865135688, 5431.565474762009, 5432.668996095982, 5436.592255580847, 20832.37502874916, 21455.0, 21494.462638434008, 21542.461438464008, 21640.89179554108, 1961.4802077449488, 1998.5703073839195, 2355.646653002046, 2469.4567195217023, 2492.277239600514, 6081.3614570470345, 6970.616616086113, 13086.214827110403, 13435.26106064166, 13847.584572462842, 1748.5628592851788, 1749.4314347836876, 1771.433141394754, 1818.627181427804, 1837.9632407351912, 69155.0, 70538.29461705369, 70572.0, 72251.27748722499, 73828.26171738267, 9006.909930900738, 9405.247580193569, 9440.811183776423, 9531.714048578553, 9624.855627165598, 12869.2921889297, 12905.225686458842, 12911.289879056741, 12914.612561622978, 12950.870491295154, 7228.819279518054, 7305.269473052652, 7428.517146385468, 7447.962760186165, 7523.210062943422, 7006.2643422439905, 7038.577685338896, 7078.0, 7251.963740181265, 7330.67011984462, 6023.849403764853, 6035.245594300713, 6039.8490037748525, 6073.908891366633, 6181.412765787243, 1749.0, 1763.5855573940114, 1782.7415024821328, 1809.7559026806664, 1809.8642601804918, 809.6154326694891, 927.2859897878595, 934.131257930118, 940.1162906867522, 943.7216021273741, 17136.22886970089, 17603.0, 18051.0, 18450.446486605422, 18530.16614252362, 884.8761173435724, 921.1525396635112, 924.6578765856676, 937.3017102258724, 974.7563109222694, 9915.30592858493, 10289.897101029044, 10521.84217236742, 10541.104006159409, 10566.260361774755, 381805.0, 383198.0, 391565.0, 395510.0, 396140.0, 70965.2903470969, 72515.63742181256, 73303.26696733071, 73483.26516734764, 76366.61816690881, 928.6749637626912, 955.5556666150412, 967.240716037921, 967.4002118686319, 975.4732444479902, 15877.2855221513, 15880.0, 16146.111963841631, 16399.262033208295, 16851.24169412404, 38823.41764873473, 38876.0, 38895.0, 38996.0, 39983.0, 52851.47148528465, 53379.0, 53530.732346338016, 54335.184972224655, 54383.0, 6871.793846184622, 7077.1507419107975, 7078.964605176941, 7175.174854891546, 7223.386012189023, 8639.574470212345, 12016.098792590765, 12230.14388992762, 12250.938745306217, 13175.0, 10454.843177352193, 10724.356538607708, 10825.837612435977, 11027.393493357942, 11030.172737044913, 4919.557239848287, 8574.356923230907, 9316.369635313657, 10302.33034852732, 10471.162307015573, 10071.748206294902, 10618.097461715532, 10803.729906752395, 10816.783664326827, 10950.288231264942, 6862.142232220973, 7065.6467176639935, 7072.186698529735, 7130.180029296697, 7164.498485105993, 8730.388872778845, 10170.949145254226, 10339.483025848827, 10566.366018038942, 10728.0], "value": 8444.280285271667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.6023672424817, 1369.4453746232773, 1426.529245349035, 1467.7137958098176, 1696.8133505314406, 6433.967830160848, 7349.412047036238, 7649.426293028025, 7664.386849052076, 7857.489263197888, 7661.080670319556, 7749.031371078615, 7754.883676744853, 7757.379409647228, 7762.45662803604, 2105.3683894831565, 2123.7132987046784, 2128.053016407699, 2129.6486079796814, 2130.1266480742897, 2081.209140526598, 2146.6887301341294, 2156.5902478529106, 2160.794724501178, 2166.5125346797004, 2103.6423807952683, 2108.7574928883146, 2126.734158230221, 2132.040581738216, 2156.55790562935, 2074.823639990595, 2077.8649387789897, 2078.0752565108533, 2078.594674038563, 2080.9687854682193, 1982.33591746765, 2054.753429588444, 2056.239191499155, 2057.1565658080117, 2064.5354795171115, 7453.0, 7539.396848252127, 7712.074551053854, 7718.922810771876, 7720.1121870985, 4324.6972711910175, 4451.376807246988, 4507.278835386355, 4508.368828364031, 4512.751798651073, 2842.0905310300714, 2961.0, 3030.575719399286, 3032.2267821705545, 3041.3309072004345, 974.2352253480983, 980.2011360740973, 988.8813342398886, 997.6059456514708, 1009.3489699144085, 9639.277054220962, 9727.65953191635, 9808.558614862277, 9814.705558833246, 9830.754231144207, 3892.9805350973065, 3940.192260586573, 4034.8789536313957, 4064.8170832312617, 4072.5927407259037, 8454.070052294242, 8477.533735644598, 8477.618507167192, 8487.405881588229, 8499.957500212584, 4347.174036932973, 4354.542773008852, 4358.21552120615, 4361.498427680794, 4361.80371883266, 3351.396748585278, 3527.647235276503, 3931.0, 3944.230874979409, 3984.764722935899, 3532.897925734184, 3600.531930848973, 3709.9629003710156, 3717.237966216919, 3727.142757165867, 1132.5469812075237, 1150.7295785490403, 1151.758130792543, 1156.4160099149876, 1187.0978056676988, 772.8454309138195, 823.4482896459386, 824.2499325613662, 851.3317046118767, 864.148813418782, 5161.81933632321, 5220.738963051908, 5260.316158899395, 5295.576353891679, 5347.51872331492, 917.5824999625155, 942.7643089227693, 956.9904300956902, 969.2730452160879, 990.6334656177116, 3596.496490491333, 3636.781793092423, 3679.2273622539565, 3713.665770080706, 3904.7657140571655, 9284.62861485533, 9701.6604418845, 9708.660196893215, 9721.125098741148, 9734.41593504392, 9630.662926797528, 9644.469554174448, 9644.565994530123, 9649.13157815786, 9660.855087173699, 6859.691313890887, 7186.640667966581, 7190.496665233488, 7254.455915806336, 7355.485116041933, 5281.298477162431, 5371.62398632092, 5388.757505912322, 5408.918866217088, 5705.0, 8668.176523230282, 8895.24390426795, 8918.10818918103, 8966.641334346554, 9041.23149532297, 7648.273414025881, 8737.0, 9176.908230917605, 9203.217726493323, 9212.769680758034, 5633.718314084362, 5915.378885217162, 6754.18949726036, 6897.620630865351, 6900.30996900326, 7430.182679905098, 7525.6989720410575, 7533.472656913963, 7535.54786712799, 7544.471886968079, 6651.235107962646, 6672.633005184762, 6792.0, 6832.7950161493245, 6897.55165914214, 6529.608223506605, 6577.210734711865, 6604.075429439787, 6621.404073633396, 6672.866542669217, 6312.968435157794, 6506.577072490273, 6533.542652014314, 6585.868282634417, 6586.209654841258, 4512.729236245705, 4559.38448309474, 4641.11822716224, 4664.953350466588, 4683.625309975262, 4621.32990716351, 4685.437747470325, 4757.976210118927, 4772.331873537777, 4851.151048566416], "value": 4088.744636973338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.3959787602171, 290.1542005055264, 294.31571596039214, 296.3243804126592, 296.37612825003373, 4803.303520989454, 4914.361133052698, 4923.630727695424, 4942.9258561121615, 4956.430010548788, 4702.177119004169, 4805.855824325267, 4822.4213094428715, 4826.179549476588, 4861.100696371165, 3817.3701339278987, 3827.1771569112634, 3848.2495913296916, 3855.4024126260333, 3858.5369755629363, 3597.172650290435, 3844.615538446161, 3854.2249580302278, 3859.36320507116, 3880.2821478026513, 3566.197605538746, 3718.7396882218254, 3751.6623503884643, 3753.6058713835064, 3771.717121215906, 3760.135168911152, 3760.3607386744184, 3767.2653832502397, 3767.3407153747985, 3775.9811200944096, 3320.767546271738, 3326.3846188454972, 3336.849841757127, 3343.8160901150427, 3347.6317605063423, 4588.141802569964, 4775.689580177277, 4781.904361912742, 4784.5933095686905, 4801.831935882262, 4273.687891883815, 4289.721168124062, 4295.763732994684, 4299.247631664478, 4300.591443812833, 5048.8697007855, 5060.924086138711, 5068.594512438996, 5072.34059572257, 5114.897702045975, 3328.6172090209693, 3604.9279014419567, 3605.1888325126897, 3615.783053016801, 3627.8004709740953, 5318.627696061278, 5328.6269961102735, 5332.92000619991, 5334.813281535127, 5335.439778823245, 3665.890023299305, 3670.7430479866152, 3673.9081522961606, 3698.5746639136305, 3705.629437056327, 3725.9441108383394, 3750.5499340079364, 3751.2122454284904, 3752.437134429803, 3752.7560708553856, 4194.601512856274, 4264.573542645772, 4277.224951645095, 4292.227399068198, 4314.590113939171, 5085.821996230115, 5097.464766199496, 5102.209157580581, 5102.413222479388, 5102.846914592568, 1219.5000049979467, 1238.3127364312713, 1278.7058976435471, 1301.9869801302054, 1302.6222395505388, 816.848882956655, 833.8999320081629, 836.5691668790578, 837.67962743201, 841.5539763925129, 4484.497693272725, 4523.88690282739, 4527.049319642846, 4532.4334458192725, 4536.251518499476, 5226.5818734501145, 5233.947660523422, 5242.213667949838, 5249.343832020997, 5254.448282930313, 4357.193919124972, 4467.5755803198645, 4488.169688607618, 4513.323001549728, 4516.683832131719, 2425.2966639674296, 2457.004913010234, 2457.8525288482747, 2458.2300743464675, 2466.839655422392, 4339.652827773771, 4357.237483440385, 4364.672649551297, 4364.886953826754, 4366.0, 4314.331278651814, 4597.908041839144, 4627.3521706961055, 4649.674522783373, 4689.921318096857, 4305.634021108178, 4310.017391999652, 4336.241157797373, 4338.327559228324, 4349.02147016925, 4580.839670611513, 4612.563640088156, 4614.976925115353, 4615.353850460871, 4638.0, 4242.639375653104, 4514.751688657024, 4517.864464066083, 4529.592336689714, 4548.587869766321, 4342.522322544454, 4345.130973805189, 4381.364702118239, 4388.0, 4409.889752756207, 3307.007897630653, 3318.4856347266214, 3321.7709447504576, 3348.464245720673, 3363.3105213431677, 4375.649948004216, 4630.1942242524765, 4636.93044604338, 4639.188142075056, 4681.438227412732, 4417.359482875029, 4425.668074894332, 4428.387251521618, 4429.712068715523, 4435.157320109169, 4404.383386325853, 4430.357598148186, 4433.955660443355, 4461.330800379969, 4489.842855500042, 4428.2914733642465, 4446.53311402311, 4460.085682435158, 4756.167670657552, 4900.411950565955, 4750.738709370879, 4960.72716000609, 4990.975045124751, 5042.445331013512, 5094.1849304111165, 4921.975390123026, 4961.355023846877, 4981.327520784647, 4997.85006449807, 5006.424261210008], "value": 3664.99856405063, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.1065075589361, 652.7617419641831, 660.8281846719855, 677.4783416769085, 688.9724411023559, 12706.936465317673, 14081.29593520325, 14088.295585220736, 14097.647558811022, 14099.78850317246, 12270.631881043582, 12331.136820422575, 12335.876641233584, 12354.629361119181, 12361.134720569564, 621.4500167351881, 749.7375918428534, 755.7543798265572, 779.2908453307491, 782.5617654113714, 776.3827756933251, 780.6916268074108, 781.679511400326, 782.1982467970319, 782.7221336425572, 823.6705317872869, 824.6412810427453, 824.8886400335967, 825.2119226139052, 825.3685930263354, 660.0956689335617, 791.3945831438954, 816.1797393619433, 820.5938060659952, 824.5135370131591, 601.3835818286248, 601.9247594050744, 602.7408214467777, 603.2971588099858, 603.4629180029777, 13103.737925241441, 13111.278879661615, 13124.081314308003, 13133.868661313456, 13137.146085504508, 11213.663590092228, 11993.820092698617, 12342.81485777714, 12640.620781376574, 12966.416511256923, 11579.710507237301, 11917.940410297893, 12110.091743119214, 12411.565595204125, 12632.873671263262, 3871.3031654302495, 3952.7430717003303, 3993.2412841560013, 4055.229506393776, 4063.045184381668, 53370.46629533694, 54530.45469545333, 67891.66054169697, 68045.25751083689, 68682.19224654276, 10203.744906377251, 10366.0, 10537.789244215226, 10761.192910531741, 11284.774304513863, 19275.036248187535, 19283.325083622007, 19290.131944062272, 19309.131089101025, 19313.324033659035, 7060.6116663584, 7183.46124040699, 7196.028536147658, 7203.783886483414, 7266.527675701062, 3845.9230815383535, 3871.070942973666, 3905.414187871785, 3959.3862951242604, 3993.940090898639, 2902.4050069735654, 2969.5545668149516, 2986.671466138723, 3000.819950802959, 3029.5001324781606, 496.2481840012384, 498.1083859890755, 503.2702581257192, 508.329005712456, 517.6298946253447, 514.5960421069517, 534.4415086234894, 561.9743967259685, 576.8615532272308, 623.1680706257107, 8144.714934977366, 8508.702195423131, 8573.699920502753, 8700.825983480296, 8714.4838873864, 532.475511621053, 558.8467614534029, 574.6006525464762, 615.9353267906805, 621.2234706616729, 4034.757914525138, 4100.528439229467, 4176.812043458051, 4231.7672528010635, 4252.383404406344, 100011.0, 104472.0, 105513.0, 110341.44829275802, 110847.0, 87706.0, 90365.99999999869, 90534.54732726295, 91311.54344228236, 92435.0, 64931.67534162299, 74108.62945685237, 77466.0, 79776.60111699405, 80649.0, 7672.693092276247, 7985.920140798517, 8010.679572817022, 8132.67469301245, 8236.629351679068, 48324.7583762093, 48601.513984861114, 48681.269780954026, 49431.25853112278, 49432.75283623559, 39467.0, 39712.80143599264, 40081.599184008955, 54523.45476545184, 67229.0, 9295.953520232355, 10120.84818727705, 10214.182865370902, 10282.228832837716, 10379.481025948824, 11012.119030477383, 11028.944855275673, 11180.0, 11223.382713950485, 11343.546258149581, 10554.472276385997, 10752.946235268773, 10826.296290741077, 10845.783084338427, 11233.66299011031, 10754.838677419688, 11370.374629395463, 11670.358130302915, 12161.0, 12180.93909530482, 12298.631041068782, 12423.254604723745, 12547.560835370718, 12671.556495522613, 12691.301978391277, 10387.169026478015, 10551.0, 10601.575936962743, 11301.830472543083, 11382.886171138514, 9076.0, 9366.859497107413, 10936.617218397318, 11228.214025018497, 11243.100551955988], "value": 6605.8257577499735, "unit": "score"}], "name": "dromaeo_css", "value": 6362.334289102399, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 124.0, 192.0, 121.0, 126.0, 146.0, 123.0, 185.0, 122.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 162.0, 162.0, 161.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 113.0, 76.0, 76.0, 76.0, 76.0, 109.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 123.0, 85.0, 86.0, 85.0, 124.0, 83.0, 84.0, 121.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 79.0, 79.0, 79.0, 79.0, 81.0, 80.0, 81.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 140.0, 130.0, 130.0, 138.0, 130.0, 130.0, 146.0, 139.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 168.0, 170.0, 166.0, 165.0, 166.0, 173.0, 167.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 67.0, 67.0, 69.0, 75.0, 70.0, 70.0, 67.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1531.3, "alertThreshold": 2.0}]} 16:45:57 INFO - Return code: 0 16:45:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:45:57 INFO - # TBPL SUCCESS # 16:45:57 INFO - Running post-action listener: _resource_record_post_action 16:45:57 INFO - [mozharness: 2016-08-11 23:45:57.662693Z] Finished run-tests step (success) 16:45:57 INFO - Running post-run listener: _resource_record_post_run 16:45:57 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 16384; Write bytes: 396926976; Read time: 288; Write time: 270000 16:45:57 INFO - TinderboxPrint: CPU usage
13.1% 16:45:57 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 288 16:45:57 INFO - TinderboxPrint: I/O write bytes / time
396,926,976 / 270,000 16:45:57 INFO - TinderboxPrint: CPU idle
8,333.6 (86.9%) 16:45:57 INFO - TinderboxPrint: CPU user
1,207.0 (12.6%) 16:45:57 INFO - TinderboxPrint: Swap in / out
0 / 0 16:45:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114720768; Read time: 120; Write time: 94756 16:45:57 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282206208; Read time: 156; Write time: 175244 16:45:58 INFO - Running post-run listener: _upload_blobber_files 16:45:58 INFO - Blob upload gear active. 16:45:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:45:58 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 16:45:58 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'] 16:45:58 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 16:45:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:59 INFO - (blobuploader) - INFO - Done attempting. 16:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:46:03 INFO - (blobuploader) - INFO - Done attempting. 16:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:46:04 INFO - (blobuploader) - INFO - Done attempting. 16:46:04 INFO - (blobuploader) - INFO - Iteration through files over. 16:46:04 INFO - Return code: 0 16:46:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:46:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:46:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e8226797db7a0d86e32ed9bcb14e4bb827b10db40ad72dcf2e668579753ea46b1023e26c3664b5553efb9320496ffec7725509bf611d107785ddbe3d16388ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0a6633910bcf7f71f2311d1b1fe9fe27a4b2eee66c38fb0104dfc045338fae8d4132c74267156b0ae665af7d67ca59257014d8360eeada6ba3f5da295f37c3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f32f78998a630db21e3bf80cc0287d6e8c11728563462c3082a8025f0474154823157cc0c6351b15906b6bc95842071e6820c411ac7716f99e4dc5c91d2968"} 16:46:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:46:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:46:04 INFO - Contents: 16:46:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e8226797db7a0d86e32ed9bcb14e4bb827b10db40ad72dcf2e668579753ea46b1023e26c3664b5553efb9320496ffec7725509bf611d107785ddbe3d16388ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0a6633910bcf7f71f2311d1b1fe9fe27a4b2eee66c38fb0104dfc045338fae8d4132c74267156b0ae665af7d67ca59257014d8360eeada6ba3f5da295f37c3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f32f78998a630db21e3bf80cc0287d6e8c11728563462c3082a8025f0474154823157cc0c6351b15906b6bc95842071e6820c411ac7716f99e4dc5c91d2968"} 16:46:04 INFO - Running post-run listener: copy_logs_to_upload_dir 16:46:04 INFO - Copying logs to upload dir... 16:46:04 INFO - mkdir: /builds/slave/test/build/upload/logs 16:46:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.207873 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-08-11 16:46:04.907562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 16:46:04.910789) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186 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/e8226797db7a0d86e32ed9bcb14e4bb827b10db40ad72dcf2e668579753ea46b1023e26c3664b5553efb9320496ffec7725509bf611d107785ddbe3d16388ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0a6633910bcf7f71f2311d1b1fe9fe27a4b2eee66c38fb0104dfc045338fae8d4132c74267156b0ae665af7d67ca59257014d8360eeada6ba3f5da295f37c3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f32f78998a630db21e3bf80cc0287d6e8c11728563462c3082a8025f0474154823157cc0c6351b15906b6bc95842071e6820c411ac7716f99e4dc5c91d2968"} build_url:https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/fhMEl8soQ5-yVaGum7LhvQ/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/e8226797db7a0d86e32ed9bcb14e4bb827b10db40ad72dcf2e668579753ea46b1023e26c3664b5553efb9320496ffec7725509bf611d107785ddbe3d16388ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0a6633910bcf7f71f2311d1b1fe9fe27a4b2eee66c38fb0104dfc045338fae8d4132c74267156b0ae665af7d67ca59257014d8360eeada6ba3f5da295f37c3a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f32f78998a630db21e3bf80cc0287d6e8c11728563462c3082a8025f0474154823157cc0c6351b15906b6bc95842071e6820c411ac7716f99e4dc5c91d2968"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 16:46:04.936037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:46:04.936325) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1470957493.797218-692681186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:46:05.022620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 16:46:05.022966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 16:46:05.023326) ========= ========= Total master_lag: 0.25 =========