builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1472532515.55 results: success (0) buildid: 20160829203021 builduid: a43b82262b184c149afbebf601e330d8 revision: c218b89925e01d7265f71a8f20b702ff3d1b7326 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.550929) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.551491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.551889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.605331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.605705) ========= 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=920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 21:48:36-- 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% 224M=0s 2016-08-29 21:48:36 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.833603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.834298) ========= 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=920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014712 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.884556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:35.884952) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c218b89925e01d7265f71a8f20b702ff3d1b7326 --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 c218b89925e01d7265f71a8f20b702ff3d1b7326 --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=920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 21:48:36,408 truncating revision to first 12 chars 2016-08-29 21:48:36,408 Setting DEBUG logging. 2016-08-29 21:48:36,409 attempt 1/10 2016-08-29 21:48:36,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c218b89925e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 21:48:36,713 unpacking tar archive at: autoland-c218b89925e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625906 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:36.528335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:36.528900) ========= script_repo_revision: c218b89925e01d7265f71a8f20b702ff3d1b7326 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:36.529547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:36.529994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 21:48:36.541605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-29 21:48:36.542081) ========= /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=920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:48:37 INFO - MultiFileLogger online at 20160829 21:48:37 in /builds/slave/test 21:48:37 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 21:48:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:48:37 INFO - {'append_to_log': False, 21:48:37 INFO - 'base_work_dir': '/builds/slave/test', 21:48:37 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:48:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:48:37 INFO - 'branch': 'Autoland-Non-PGO', 21:48:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:48:37 INFO - 'config_files': ('talos/linux_config.py',), 21:48:37 INFO - 'default_actions': ('clobber', 21:48:37 INFO - 'read-buildbot-config', 21:48:37 INFO - 'download-and-extract', 21:48:37 INFO - 'populate-webroot', 21:48:37 INFO - 'create-virtualenv', 21:48:37 INFO - 'install', 21:48:37 INFO - 'run-tests'), 21:48:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:48:37 INFO - 'download_minidump_stackwalk': True, 21:48:37 INFO - 'download_symbols': 'ondemand', 21:48:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:48:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:48:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:48:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:48:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:48:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:48:37 INFO - 'installer_path': 'installer.exe', 21:48:37 INFO - 'log_level': 'info', 21:48:37 INFO - 'log_name': 'talos', 21:48:37 INFO - 'log_to_console': True, 21:48:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:48:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:48:37 INFO - 'opt_config_files': (), 21:48:37 INFO - 'pip_index': False, 21:48:37 INFO - 'sps_profile': False, 21:48:37 INFO - 'sps_profile_interval': 0, 21:48:37 INFO - 'suite': 'dromaeojs', 21:48:37 INFO - 'system_bits': '32', 21:48:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:48:37 INFO - 'title': 'talos-linux64-ix-053', 21:48:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:48:37 INFO - 'use_talos_json': True, 21:48:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:48:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:48:37 INFO - 'work_dir': 'build'} 21:48:37 INFO - [mozharness: 2016-08-30 04:48:37.156983Z] Running clobber step. 21:48:37 INFO - Running pre-action listener: _resource_record_pre_action 21:48:37 INFO - Running main action method: clobber 21:48:37 INFO - rmtree: /builds/slave/test/build 21:48:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:48:37 INFO - Running post-action listener: _resource_record_post_action 21:48:37 INFO - [mozharness: 2016-08-30 04:48:37.614942Z] Finished clobber step (success) 21:48:37 INFO - [mozharness: 2016-08-30 04:48:37.615045Z] Running read-buildbot-config step. 21:48:37 INFO - Running pre-action listener: _resource_record_pre_action 21:48:37 INFO - Running main action method: read_buildbot_config 21:48:37 INFO - Using buildbot properties: 21:48:37 INFO - { 21:48:37 INFO - "project": "", 21:48:37 INFO - "product": "firefox", 21:48:37 INFO - "script_repo_revision": "production", 21:48:37 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:48:37 INFO - "repository": "", 21:48:37 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 21:48:37 INFO - "buildid": "20160829203021", 21:48:37 INFO - "pgo_build": "False", 21:48:37 INFO - "basedir": "/builds/slave/test", 21:48:37 INFO - "buildnumber": 382, 21:48:37 INFO - "slavename": "talos-linux64-ix-053", 21:48:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:48:37 INFO - "platform": "ubuntu64_hw", 21:48:37 INFO - "scheduler": "tests-autoland-linux64-talos", 21:48:37 INFO - "branch": "autoland", 21:48:37 INFO - "repo_path": "integration/autoland", 21:48:37 INFO - "revision": "c218b89925e01d7265f71a8f20b702ff3d1b7326", 21:48:37 INFO - "stage_platform": "linux64", 21:48:37 INFO - "builduid": "a43b82262b184c149afbebf601e330d8", 21:48:37 INFO - "slavebuilddir": "test" 21:48:37 INFO - } 21:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:48:37 INFO - Running post-action listener: _resource_record_post_action 21:48:37 INFO - [mozharness: 2016-08-30 04:48:37.617497Z] Finished read-buildbot-config step (success) 21:48:37 INFO - [mozharness: 2016-08-30 04:48:37.617585Z] Running download-and-extract step. 21:48:37 INFO - Running pre-action listener: _resource_record_pre_action 21:48:37 INFO - Running main action method: download_and_extract 21:48:37 INFO - mkdir: /builds/slave/test/build/tests 21:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:37 INFO - trying https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:48:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:38 INFO - Downloaded 1361 bytes. 21:48:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:48:38 INFO - Using the following test package requirements: 21:48:38 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:48:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:48:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'jsshell-linux-x86_64.zip'], 21:48:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:48:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:48:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:48:38 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:48:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:48:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:48:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:48:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:48: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')]} 21:48:38 INFO - trying https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:48:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:40 INFO - Downloaded 20316003 bytes. 21:48:40 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 21:48:44 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 21:48:44 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')]} 21:48:44 INFO - trying https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:48:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:45 INFO - Downloaded 20316003 bytes. 21:48:45 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 21:48:49 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')]} 21:48:49 INFO - trying https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:51 INFO - Downloaded 14413998 bytes. 21:48:51 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 21:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:51 INFO - trying https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:48:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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 21:48:53 INFO - Downloaded 55851910 bytes. 21:48:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:48:53 INFO - mkdir: /builds/slave/test/properties 21:48:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:48:53 INFO - Writing to file /builds/slave/test/properties/build_url 21:48:53 INFO - Contents: 21:48:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:48:54 INFO - Running post-action listener: _resource_record_post_action 21:48:54 INFO - Running post-action listener: set_extra_try_arguments 21:48:54 INFO - [mozharness: 2016-08-30 04:48:54.237877Z] Finished download-and-extract step (success) 21:48:54 INFO - [mozharness: 2016-08-30 04:48:54.238105Z] Running populate-webroot step. 21:48:54 INFO - Running pre-action listener: _resource_record_pre_action 21:48:54 INFO - Running main action method: populate_webroot 21:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:48:54 INFO - '--tppagecycles', 21:48:54 INFO - '7'], 21:48:54 INFO - 'tests': ['tsvgm']}}, 21:48:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:48:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:48:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:48:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:48:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['damp', 'tps']}, 21:48:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'tests': ['damp', 'tps']}, 21:48:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['dromaeo_dom']}, 21:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:48:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['basic_compositor_video']}, 21:48:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:48:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['a11yr', 21:48:54 INFO - 'ts_paint', 21:48:54 INFO - 'tpaint', 21:48:54 INFO - 'sessionrestore', 21:48:54 INFO - 'sessionrestore_no_auto_restore', 21:48:54 INFO - 'tabpaint']}, 21:48:54 INFO - 'other-e10s': {'tests': ['a11yr', 21:48:54 INFO - 'ts_paint', 21:48:54 INFO - 'tpaint', 21:48:54 INFO - 'sessionrestore', 21:48:54 INFO - 'sessionrestore_no_auto_restore', 21:48:54 INFO - 'tabpaint']}, 21:48:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:48:54 INFO - 'ts_paint', 21:48:54 INFO - 'tpaint', 21:48:54 INFO - 'sessionrestore', 21:48:54 INFO - 'sessionrestore_no_auto_restore', 21:48:54 INFO - 'tabpaint']}, 21:48:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:48:54 INFO - 'ts_paint', 21:48:54 INFO - 'tpaint', 21:48:54 INFO - 'sessionrestore', 21:48:54 INFO - 'sessionrestore_no_auto_restore', 21:48:54 INFO - 'tabpaint']}, 21:48:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['a11yr', 21:48:54 INFO - 'ts_paint', 21:48:54 INFO - 'tpaint', 21:48:54 INFO - 'sessionrestore', 21:48:54 INFO - 'sessionrestore_no_auto_restore', 21:48:54 INFO - 'tabpaint']}, 21:48:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['a11yr', 21:48:54 INFO - 'ts_paint', 21:48:54 INFO - 'tpaint', 21:48:54 INFO - 'sessionrestore', 21:48:54 INFO - 'sessionrestore_no_auto_restore', 21:48:54 INFO - 'tabpaint']}, 21:48:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['tsvgx', 21:48:54 INFO - 'tsvgr_opacity', 21:48:54 INFO - 'tart', 21:48:54 INFO - 'tscrollx', 21:48:54 INFO - 'cart']}, 21:48:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:48:54 INFO - 'tsvgr_opacity', 21:48:54 INFO - 'tart', 21:48:54 INFO - 'tscrollx', 21:48:54 INFO - 'cart']}, 21:48:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'talos_options': ['--disable-e10s'], 21:48:54 INFO - 'tests': ['tp5o']}, 21:48:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'tests': ['tp5o']}, 21:48:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'talos_options': ['--disable-e10s', 21:48:54 INFO - '--xperf_path', 21:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:54 INFO - 'tests': ['tp5n']}, 21:48:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:54 INFO - 'talos_options': ['--xperf_path', 21:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:54 INFO - 'tests': ['tp5n']}}, 21:48:54 INFO - 'talos.zip': {'path': '', 21:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:48:54 INFO - Running post-action listener: _resource_record_post_action 21:48:54 INFO - [mozharness: 2016-08-30 04:48:54.254613Z] Finished populate-webroot step (success) 21:48:54 INFO - [mozharness: 2016-08-30 04:48:54.254703Z] Running create-virtualenv step. 21:48:54 INFO - Running pre-action listener: _resource_record_pre_action 21:48:54 INFO - Running main action method: create_virtualenv 21:48:54 INFO - Creating virtualenv /builds/slave/test/build/venv 21:48:54 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 21:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:48:54 INFO - Using real prefix '/usr' 21:48:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:48:54 INFO - Installing distribute.............................................................................................................................................................................................done. 21:48:56 INFO - Installing pip.................done. 21:48:56 INFO - Return code: 0 21:48:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:48:56 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')]} 21:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:56 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')]} 21:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:56 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:48:56 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 21:48:56 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 21:48:56 INFO - Using env: {'DISPLAY': ':0', 21:48:56 INFO - 'HOME': '/home/cltbld', 21:48:56 INFO - 'LANG': 'en_US.UTF-8', 21:48:56 INFO - 'LANGUAGE': 'en_US:en', 21:48:56 INFO - 'LOGNAME': 'cltbld', 21:48:56 INFO - 'MAIL': '/var/mail/cltbld', 21:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:56 INFO - 'MOZ_NO_REMOTE': '1', 21:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:56 INFO - 'NO_EM_RESTART': '1', 21:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:56 INFO - 'PWD': '/builds/slave/test', 21:48:56 INFO - 'SHELL': '/bin/bash', 21:48:56 INFO - 'SHLVL': '1', 21:48:56 INFO - 'TERM': 'linux', 21:48:56 INFO - 'TMOUT': '86400', 21:48:56 INFO - 'USER': 'cltbld', 21:48:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:56 INFO - '_': '/tools/buildbot/bin/python'} 21:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:57 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 21:48:57 INFO - Cleaning up... 21:48:57 INFO - Return code: 0 21:48:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:57 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:48:57 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 21:48:57 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 21:48:57 INFO - Using env: {'DISPLAY': ':0', 21:48:57 INFO - 'HOME': '/home/cltbld', 21:48:57 INFO - 'LANG': 'en_US.UTF-8', 21:48:57 INFO - 'LANGUAGE': 'en_US:en', 21:48:57 INFO - 'LOGNAME': 'cltbld', 21:48:57 INFO - 'MAIL': '/var/mail/cltbld', 21:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:57 INFO - 'MOZ_NO_REMOTE': '1', 21:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:57 INFO - 'NO_EM_RESTART': '1', 21:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:57 INFO - 'PWD': '/builds/slave/test', 21:48:57 INFO - 'SHELL': '/bin/bash', 21:48:57 INFO - 'SHLVL': '1', 21:48:57 INFO - 'TERM': 'linux', 21:48:57 INFO - 'TMOUT': '86400', 21:48:57 INFO - 'USER': 'cltbld', 21:48:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:57 INFO - '_': '/tools/buildbot/bin/python'} 21:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:57 INFO - Downloading/unpacking psutil>=3.1.1 21:48:57 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 21:48:57 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 21:48:57 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 21:48:57 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 21:48:57 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 21:48:57 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 21:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:59 INFO - Installing collected packages: psutil 21:48:59 INFO - Running setup.py install for psutil 21:48:59 INFO - building 'psutil._psutil_linux' extension 21:48:59 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 21:48:59 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 21:48:59 INFO - building 'psutil._psutil_posix' extension 21:48:59 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 21:48:59 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 21:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:59 INFO - Successfully installed psutil 21:48:59 INFO - Cleaning up... 21:48:59 INFO - Return code: 0 21:48:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:48:59 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')]} 21:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:59 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')]} 21:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:59 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:48:59 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 21:48:59 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 21:48:59 INFO - Using env: {'DISPLAY': ':0', 21:48:59 INFO - 'HOME': '/home/cltbld', 21:48:59 INFO - 'LANG': 'en_US.UTF-8', 21:48:59 INFO - 'LANGUAGE': 'en_US:en', 21:48:59 INFO - 'LOGNAME': 'cltbld', 21:48:59 INFO - 'MAIL': '/var/mail/cltbld', 21:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:59 INFO - 'MOZ_NO_REMOTE': '1', 21:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:59 INFO - 'NO_EM_RESTART': '1', 21:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:59 INFO - 'PWD': '/builds/slave/test', 21:48:59 INFO - 'SHELL': '/bin/bash', 21:48:59 INFO - 'SHLVL': '1', 21:48:59 INFO - 'TERM': 'linux', 21:48:59 INFO - 'TMOUT': '86400', 21:48:59 INFO - 'USER': 'cltbld', 21:48:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:59 INFO - '_': '/tools/buildbot/bin/python'} 21:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:49:00 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 21:49:00 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 21:49:00 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 21:49:00 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 21:49:00 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 21:49:00 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 21:49:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:49:01 INFO - Installing collected packages: mozsystemmonitor 21:49:01 INFO - Running setup.py install for mozsystemmonitor 21:49:02 INFO - Successfully installed mozsystemmonitor 21:49:02 INFO - Cleaning up... 21:49:02 INFO - Return code: 0 21:49:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:49:02 INFO - Using env: {'DISPLAY': ':0', 21:49:02 INFO - 'HOME': '/home/cltbld', 21:49:02 INFO - 'LANG': 'en_US.UTF-8', 21:49:02 INFO - 'LANGUAGE': 'en_US:en', 21:49:02 INFO - 'LOGNAME': 'cltbld', 21:49:02 INFO - 'MAIL': '/var/mail/cltbld', 21:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:02 INFO - 'MOZ_NO_REMOTE': '1', 21:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:02 INFO - 'NO_EM_RESTART': '1', 21:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:02 INFO - 'PWD': '/builds/slave/test', 21:49:02 INFO - 'SHELL': '/bin/bash', 21:49:02 INFO - 'SHLVL': '1', 21:49:02 INFO - 'TERM': 'linux', 21:49:02 INFO - 'TMOUT': '86400', 21:49:02 INFO - 'USER': 'cltbld', 21:49:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:02 INFO - '_': '/tools/buildbot/bin/python'} 21:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:02 INFO - Downloading/unpacking jsonschema==2.5.1 21:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:49:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:49:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:49:04 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 21:49:04 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 21:49:04 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 21:49:04 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 21:49:04 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 21:49:04 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 21:49:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:49:04 INFO - warning: no files found matching '*.txt' 21:49:04 INFO - no previously-included directories found matching 'build' 21:49:04 INFO - no previously-included directories found matching 'dist' 21:49:04 INFO - no previously-included directories found matching '.git*' 21:49:04 INFO - Installing collected packages: jsonschema, functools32 21:49:04 INFO - Running setup.py install for functools32 21:49:04 INFO - warning: no files found matching '*.txt' 21:49:04 INFO - no previously-included directories found matching 'build' 21:49:04 INFO - no previously-included directories found matching 'dist' 21:49:04 INFO - no previously-included directories found matching '.git*' 21:49:04 INFO - Successfully installed jsonschema functools32 21:49:04 INFO - Cleaning up... 21:49:04 INFO - Return code: 0 21:49:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:49:04 INFO - Using env: {'DISPLAY': ':0', 21:49:04 INFO - 'HOME': '/home/cltbld', 21:49:04 INFO - 'LANG': 'en_US.UTF-8', 21:49:04 INFO - 'LANGUAGE': 'en_US:en', 21:49:04 INFO - 'LOGNAME': 'cltbld', 21:49:04 INFO - 'MAIL': '/var/mail/cltbld', 21:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:04 INFO - 'MOZ_NO_REMOTE': '1', 21:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:04 INFO - 'NO_EM_RESTART': '1', 21:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:04 INFO - 'PWD': '/builds/slave/test', 21:49:04 INFO - 'SHELL': '/bin/bash', 21:49:04 INFO - 'SHLVL': '1', 21:49:04 INFO - 'TERM': 'linux', 21:49:04 INFO - 'TMOUT': '86400', 21:49:04 INFO - 'USER': 'cltbld', 21:49:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:04 INFO - '_': '/tools/buildbot/bin/python'} 21:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:49:04 INFO - Cleaning up... 21:49:04 INFO - Return code: 0 21:49:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:49:04 INFO - Using env: {'DISPLAY': ':0', 21:49:04 INFO - 'HOME': '/home/cltbld', 21:49:04 INFO - 'LANG': 'en_US.UTF-8', 21:49:04 INFO - 'LANGUAGE': 'en_US:en', 21:49:04 INFO - 'LOGNAME': 'cltbld', 21:49:04 INFO - 'MAIL': '/var/mail/cltbld', 21:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:04 INFO - 'MOZ_NO_REMOTE': '1', 21:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:04 INFO - 'NO_EM_RESTART': '1', 21:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:04 INFO - 'PWD': '/builds/slave/test', 21:49:04 INFO - 'SHELL': '/bin/bash', 21:49:04 INFO - 'SHLVL': '1', 21:49:04 INFO - 'TERM': 'linux', 21:49:04 INFO - 'TMOUT': '86400', 21:49:04 INFO - 'USER': 'cltbld', 21:49:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:04 INFO - '_': '/tools/buildbot/bin/python'} 21:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:49:05 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 21:49:05 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 21:49:05 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 21:49:05 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 21:49:05 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 21:49:05 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 21:49:06 INFO - Downloading blobuploader-1.2.4.tar.gz 21:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:49:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:49:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 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 21:49:07 INFO - Downloading docopt-0.6.1.tar.gz 21:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:49:07 INFO - Installing collected packages: blobuploader, requests, docopt 21:49:07 INFO - Running setup.py install for blobuploader 21:49:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:49:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:49:07 INFO - Running setup.py install for requests 21:49:08 INFO - Running setup.py install for docopt 21:49:08 INFO - Successfully installed blobuploader requests docopt 21:49:08 INFO - Cleaning up... 21:49:08 INFO - Return code: 0 21:49:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:08 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:08 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 21:49:08 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 21:49:08 INFO - Using env: {'DISPLAY': ':0', 21:49:08 INFO - 'HOME': '/home/cltbld', 21:49:08 INFO - 'LANG': 'en_US.UTF-8', 21:49:08 INFO - 'LANGUAGE': 'en_US:en', 21:49:08 INFO - 'LOGNAME': 'cltbld', 21:49:08 INFO - 'MAIL': '/var/mail/cltbld', 21:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:08 INFO - 'MOZ_NO_REMOTE': '1', 21:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:08 INFO - 'NO_EM_RESTART': '1', 21:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:08 INFO - 'PWD': '/builds/slave/test', 21:49:08 INFO - 'SHELL': '/bin/bash', 21:49:08 INFO - 'SHLVL': '1', 21:49:08 INFO - 'TERM': 'linux', 21:49:08 INFO - 'TMOUT': '86400', 21:49:08 INFO - 'USER': 'cltbld', 21:49:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:08 INFO - '_': '/tools/buildbot/bin/python'} 21:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:08 INFO - Running setup.py (path:/tmp/pip-XeBsIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:08 INFO - Running setup.py (path:/tmp/pip-2xGi_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:08 INFO - Running setup.py (path:/tmp/pip-Vfhnr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:08 INFO - Running setup.py (path:/tmp/pip-fRi_ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:08 INFO - Running setup.py (path:/tmp/pip-3Nkq2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:08 INFO - Running setup.py (path:/tmp/pip-ZCLvHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:08 INFO - Running setup.py (path:/tmp/pip-7te3SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:09 INFO - Running setup.py (path:/tmp/pip-QnOv_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:09 INFO - Running setup.py (path:/tmp/pip-KYlr62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:09 INFO - Running setup.py (path:/tmp/pip-cfeF6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:09 INFO - Running setup.py (path:/tmp/pip-fIaBS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:09 INFO - Running setup.py (path:/tmp/pip-5RsCzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:09 INFO - Running setup.py (path:/tmp/pip-_Aen8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:09 INFO - Running setup.py (path:/tmp/pip-F750IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:09 INFO - Running setup.py (path:/tmp/pip-e7wUZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:09 INFO - Running setup.py (path:/tmp/pip-TGV7Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:09 INFO - Running setup.py (path:/tmp/pip-5KoWtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:49:09 INFO - Running setup.py install for manifestparser 21:49:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:49:09 INFO - Running setup.py install for mozcrash 21:49:09 INFO - Running setup.py install for mozdebug 21:49:10 INFO - Running setup.py install for mozdevice 21:49:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Running setup.py install for mozfile 21:49:10 INFO - Running setup.py install for mozhttpd 21:49:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Running setup.py install for mozinfo 21:49:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Running setup.py install for mozInstall 21:49:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Running setup.py install for mozleak 21:49:10 INFO - Running setup.py install for mozlog 21:49:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Running setup.py install for moznetwork 21:49:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:49:10 INFO - Running setup.py install for mozprocess 21:49:11 INFO - Running setup.py install for mozprofile 21:49:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:49:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:49:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:49:11 INFO - Running setup.py install for mozrunner 21:49:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:49:11 INFO - Running setup.py install for mozscreenshot 21:49:11 INFO - Running setup.py install for moztest 21:49:11 INFO - Running setup.py install for mozversion 21:49:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:49:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:49:11 INFO - Cleaning up... 21:49:11 INFO - Return code: 0 21:49:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:11 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')]} 21:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:11 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')]} 21:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:11 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:11 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 21:49:11 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 21:49:11 INFO - Using env: {'DISPLAY': ':0', 21:49:11 INFO - 'HOME': '/home/cltbld', 21:49:11 INFO - 'LANG': 'en_US.UTF-8', 21:49:11 INFO - 'LANGUAGE': 'en_US:en', 21:49:11 INFO - 'LOGNAME': 'cltbld', 21:49:11 INFO - 'MAIL': '/var/mail/cltbld', 21:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:11 INFO - 'MOZ_NO_REMOTE': '1', 21:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:11 INFO - 'NO_EM_RESTART': '1', 21:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:11 INFO - 'PWD': '/builds/slave/test', 21:49:11 INFO - 'SHELL': '/bin/bash', 21:49:11 INFO - 'SHLVL': '1', 21:49:11 INFO - 'TERM': 'linux', 21:49:11 INFO - 'TMOUT': '86400', 21:49:11 INFO - 'USER': 'cltbld', 21:49:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:11 INFO - '_': '/tools/buildbot/bin/python'} 21:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:49:11 INFO - Running setup.py (path:/tmp/pip-3f6jR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:49:11 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)) 21:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:49:11 INFO - Running setup.py (path:/tmp/pip-a73oli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:49:11 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)) 21:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:49:11 INFO - Running setup.py (path:/tmp/pip-tghkDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:49:11 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)) 21:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:49:12 INFO - Running setup.py (path:/tmp/pip-4Ec24a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:49:12 INFO - Running setup.py (path:/tmp/pip-pcFLA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:49:12 INFO - Running setup.py (path:/tmp/pip-fepeq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:49:12 INFO - Running setup.py (path:/tmp/pip-90BPLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:49:12 INFO - Running setup.py (path:/tmp/pip-MhNyYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:49:12 INFO - Running setup.py (path:/tmp/pip-JhIYJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:49:12 INFO - Running setup.py (path:/tmp/pip-qoxl8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:49:12 INFO - Running setup.py (path:/tmp/pip-v0PNOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:49:12 INFO - Running setup.py (path:/tmp/pip-npGlS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:49:12 INFO - Running setup.py (path:/tmp/pip-hHZZRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:49:12 INFO - Running setup.py (path:/tmp/pip-LUPo6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:12 INFO - Running setup.py (path:/tmp/pip-k7vgHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:49:12 INFO - Running setup.py (path:/tmp/pip-g5Cta2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:49:12 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)) 21:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:49:12 INFO - Running setup.py (path:/tmp/pip-OYme2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:49:13 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)) 21:49:13 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)) 21:49:13 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)) 21:49:13 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)) 21:49:13 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)) 21:49:13 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)) 21:49:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:49:13 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 21:49:13 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 21:49:13 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 21:49:13 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 21:49:13 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 21:49:13 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 21:49:14 INFO - Downloading blessings-1.6.tar.gz 21:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:49:14 INFO - Installing collected packages: blessings 21:49:14 INFO - Running setup.py install for blessings 21:49:15 INFO - Successfully installed blessings 21:49:15 INFO - Cleaning up... 21:49:15 INFO - Return code: 0 21:49:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:49:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:15 INFO - Reading from file tmpfile_stdout 21:49:15 INFO - Current package versions: 21:49:15 INFO - argparse == 1.2.1 21:49:15 INFO - blessings == 1.6 21:49:15 INFO - blobuploader == 1.2.4 21:49:15 INFO - docopt == 0.6.1 21:49:15 INFO - functools32 == 3.2.3-2 21:49:15 INFO - jsonschema == 2.5.1 21:49:15 INFO - manifestparser == 1.1 21:49:15 INFO - mozInstall == 1.12 21:49:15 INFO - mozcrash == 0.17 21:49:15 INFO - mozdebug == 0.1 21:49:15 INFO - mozdevice == 0.48 21:49:15 INFO - mozfile == 1.2 21:49:15 INFO - mozhttpd == 0.7 21:49:15 INFO - mozinfo == 0.9 21:49:15 INFO - mozleak == 0.1 21:49:15 INFO - mozlog == 3.3 21:49:15 INFO - moznetwork == 0.27 21:49:15 INFO - mozprocess == 0.23 21:49:15 INFO - mozprofile == 0.28 21:49:15 INFO - mozrunner == 6.12 21:49:15 INFO - mozscreenshot == 0.1 21:49:15 INFO - mozsystemmonitor == 0.3 21:49:15 INFO - moztest == 0.7 21:49:15 INFO - mozversion == 1.4 21:49:15 INFO - psutil == 3.1.1 21:49:15 INFO - requests == 1.2.3 21:49:15 INFO - wsgiref == 0.1.2 21:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:15 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:15 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 21:49:15 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 21:49:15 INFO - Using env: {'DISPLAY': ':0', 21:49:15 INFO - 'HOME': '/home/cltbld', 21:49:15 INFO - 'LANG': 'en_US.UTF-8', 21:49:15 INFO - 'LANGUAGE': 'en_US:en', 21:49:15 INFO - 'LOGNAME': 'cltbld', 21:49:15 INFO - 'MAIL': '/var/mail/cltbld', 21:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:15 INFO - 'MOZ_NO_REMOTE': '1', 21:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:15 INFO - 'NO_EM_RESTART': '1', 21:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:15 INFO - 'PWD': '/builds/slave/test', 21:49:15 INFO - 'SHELL': '/bin/bash', 21:49:15 INFO - 'SHLVL': '1', 21:49:15 INFO - 'TERM': 'linux', 21:49:15 INFO - 'TMOUT': '86400', 21:49:15 INFO - 'USER': 'cltbld', 21:49:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:15 INFO - '_': '/tools/buildbot/bin/python'} 21:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 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)) 21:49:15 INFO - Cleaning up... 21:49:15 INFO - Return code: 0 21:49:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:49:15 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 0x7f6d22e84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, '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': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', '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 21:49:15 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 21:49:15 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 21:49:15 INFO - Using env: {'DISPLAY': ':0', 21:49:15 INFO - 'HOME': '/home/cltbld', 21:49:15 INFO - 'LANG': 'en_US.UTF-8', 21:49:15 INFO - 'LANGUAGE': 'en_US:en', 21:49:15 INFO - 'LOGNAME': 'cltbld', 21:49:15 INFO - 'MAIL': '/var/mail/cltbld', 21:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:15 INFO - 'MOZ_NO_REMOTE': '1', 21:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:15 INFO - 'NO_EM_RESTART': '1', 21:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:15 INFO - 'PWD': '/builds/slave/test', 21:49:15 INFO - 'SHELL': '/bin/bash', 21:49:15 INFO - 'SHLVL': '1', 21:49:15 INFO - 'TERM': 'linux', 21:49:15 INFO - 'TMOUT': '86400', 21:49:15 INFO - 'USER': 'cltbld', 21:49:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:15 INFO - '_': '/tools/buildbot/bin/python'} 21:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:49:15 INFO - Cleaning up... 21:49:15 INFO - Return code: 0 21:49:15 INFO - Running post-action listener: _resource_record_post_action 21:49:15 INFO - Running post-action listener: _start_resource_monitoring 21:49:15 INFO - Starting resource monitoring. 21:49:15 INFO - [mozharness: 2016-08-30 04:49:15.821332Z] Finished create-virtualenv step (success) 21:49:15 INFO - [mozharness: 2016-08-30 04:49:15.821796Z] Running install step. 21:49:15 INFO - Running pre-action listener: _resource_record_pre_action 21:49:15 INFO - Running main action method: install 21:49:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:49:16 INFO - Reading from file tmpfile_stdout 21:49:16 INFO - Detecting whether we're running mozinstall >=1.0... 21:49:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:49:16 INFO - Reading from file tmpfile_stdout 21:49:16 INFO - Output received: 21:49:16 INFO - Usage: mozinstall [options] installer 21:49:16 INFO - Options: 21:49:16 INFO - -h, --help show this help message and exit 21:49:16 INFO - -d DEST, --destination=DEST 21:49:16 INFO - Directory to install application into. [default: 21:49:16 INFO - "/builds/slave/test"] 21:49:16 INFO - --app=APP Application being installed. [default: firefox] 21:49:16 INFO - mkdir: /builds/slave/test/build/application 21:49:16 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'] 21:49:16 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 21:49:32 INFO - Reading from file tmpfile_stdout 21:49:32 INFO - Output received: 21:49:32 INFO - /builds/slave/test/build/application/firefox/firefox 21:49:32 INFO - Running post-action listener: _resource_record_post_action 21:49:32 INFO - [mozharness: 2016-08-30 04:49:32.260895Z] Finished install step (success) 21:49:32 INFO - [mozharness: 2016-08-30 04:49:32.261177Z] Running run-tests step. 21:49:32 INFO - Running pre-action listener: _resource_record_pre_action 21:49:32 INFO - Running main action method: run_tests 21:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:49:32 INFO - Python 2.7.3 21:49:32 INFO - Return code: 0 21:49:32 INFO - grabbing minidump binary from tooltool 21:49:32 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')]} 21:49:32 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 0x155c090>, '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 0x155f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:49:32 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 21:49:32 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 21:49:32 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 21:49:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:49:32 INFO - Return code: 0 21:49:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:49:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:49:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:49:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:49:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:49:32 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/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 21:49:32 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/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 21:49:32 INFO - Using env: {'DISPLAY': ':0', 21:49:32 INFO - 'HOME': '/home/cltbld', 21:49:32 INFO - 'LANG': 'en_US.UTF-8', 21:49:32 INFO - 'LANGUAGE': 'en_US:en', 21:49:32 INFO - 'LOGNAME': 'cltbld', 21:49:32 INFO - 'MAIL': '/var/mail/cltbld', 21:49:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:49:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:49:32 INFO - 'MOZ_NO_REMOTE': '1', 21:49:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:49:32 INFO - 'NO_EM_RESTART': '1', 21:49:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:49:32 INFO - 'PWD': '/builds/slave/test', 21:49:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:49:32 INFO - 'SHELL': '/bin/bash', 21:49:32 INFO - 'SHLVL': '1', 21:49:32 INFO - 'TERM': 'linux', 21:49:32 INFO - 'TMOUT': '86400', 21:49:32 INFO - 'USER': 'cltbld', 21:49:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869', 21:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:49:32 INFO - '_': '/tools/buildbot/bin/python'} 21:49:32 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/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 21:49:32 INFO - mozversion application_buildid: 20160829203021 21:49:32 INFO - mozversion application_changeset: c218b89925e01d7265f71a8f20b702ff3d1b7326 21:49:32 INFO - mozversion application_display_name: Nightly 21:49:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:49:32 INFO - mozversion application_name: Firefox 21:49:32 INFO - mozversion application_remotingname: firefox 21:49:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:49:32 INFO - mozversion application_vendor: Mozilla 21:49:32 INFO - mozversion application_version: 51.0a1 21:49:32 INFO - mozversion platform_buildid: 20160829203021 21:49:32 INFO - mozversion platform_changeset: c218b89925e01d7265f71a8f20b702ff3d1b7326 21:49:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:49:32 INFO - mozversion platform_version: 51.0a1 21:49:32 INFO - using testdate: 1472532572 21:49:32 INFO - actual date: 1472532572 21:49:32 INFO - starting webserver on 'localhost:52281' 21:49:32 INFO - SUITE-START | Running 2 tests 21:49:32 INFO - TEST-START | dromaeo_css 21:49:32 INFO - operating with platform_type : linux_ 21:49:32 INFO - Initialising browser for dromaeo_css test... 21:49:32 INFO - TEST-INFO | started process 10962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxa6clk/profile http://localhost:52281/getInfo.html) 21:49:36 INFO - PROCESS | 10962 | __metrics Screen width/height:1600/1200 21:49:36 INFO - PROCESS | 10962 | colorDepth:24 21:49:36 INFO - PROCESS | 10962 | Browser inner width/height: 1024/697 21:49:36 INFO - PROCESS | 10962 | __metrics 21:49:37 INFO - PROCESS | 10962 | 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" 21:49:37 INFO - PROCESS | 10962 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:49:38 INFO - PROCESS | 10962 | console.error: PushService: 21:49:38 INFO - PROCESS | 10962 | stateChangeProcessEnqueue: Error transitioning state 21:49:38 INFO - PROCESS | 10962 | UnknownError 21:49:38 INFO - TEST-INFO | 10962: exit 0 21:49:38 INFO - Browser initialized. 21:49:38 INFO - Running cycle 1/1 for dromaeo_css test... 21:49:38 INFO - TEST-INFO | started process 11041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxa6clk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:51 INFO - PROCESS | 11041 | RSS: Main: 182435840 21:49:51 INFO - PROCESS | 11041 | 21:50:42 INFO - PROCESS | 11041 | 1472532642278 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] 21:52:55 INFO - PROCESS | 11041 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52281/tests/dromaeo/cssquery-ext.html) 21:52:56 INFO - PROCESS | 11041 | RSS: Main: 278978560 21:52:56 INFO - PROCESS | 11041 | 21:55:59 INFO - PROCESS | 11041 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-ext.html (next: http://localhost:52281/tests/dromaeo/cssquery-jquery.html) 21:55:59 INFO - PROCESS | 11041 | RSS: Main: 276324352 21:55:59 INFO - PROCESS | 11041 | 21:59:02 INFO - PROCESS | 11041 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52281/tests/dromaeo/cssquery-mootools.html) 21:59:02 INFO - PROCESS | 11041 | RSS: Main: 219254784 21:59:02 INFO - PROCESS | 11041 | 22:02:05 INFO - PROCESS | 11041 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52281/tests/dromaeo/cssquery-prototype.html) 22:02:05 INFO - PROCESS | 11041 | RSS: Main: 219250688 22:02:05 INFO - PROCESS | 11041 | 22:05:08 INFO - PROCESS | 11041 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52281/tests/dromaeo/cssquery-yui.html) 22:05:09 INFO - PROCESS | 11041 | RSS: Main: 218828800 22:05:09 INFO - PROCESS | 11041 | 22:08:12 INFO - PROCESS | 11041 | Cycle 1(1): loaded http://localhost:52281/tests/dromaeo/cssquery-yui.html (next: http://localhost:52281/tests/dromaeo/cssquery-dojo.html) 22:08:13 INFO - PROCESS | 11041 | RSS: Main: 308228096 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | __start_tp_report 22:08:13 INFO - PROCESS | 11041 | _x_x_mozilla_page_load 22:08:13 INFO - PROCESS | 11041 | _x_x_mozilla_page_load_details 22:08:13 INFO - PROCESS | 11041 | |i|pagename|runs| 22:08:13 INFO - PROCESS | 11041 | |0;dojo.html;2566.987165064175;2572.369769406496;2584.6123081537767;2600.1939398786376;2606.335384476958;4600.1259760645535;4620.237660785971;4632.606228470584;4711.151992641323;4744.810207591697;4610.9308360374625;4653.395058642372;4661.207594708899;4691.812327506904;4732.36113124728;4258.318669012959;4269.423627810237;4333.696641235115;4386.802593883267;4462.709923854955;4376.540463251376;4396.428464299653;4412.227860124482;4426.645868330525;4450.643948484129;4249.150169966019;4292.399064131024;4304.849330273425;4330.198913201068;4339.869803905888;4268.829246830123;4269.679774016961;4275.786210689453;4387.539308372607;4417;4284.186004659136;4298.828046878152;4312.676549258818;4327.870163895088;4360.411344468488;4606.286025665993;4654.069186162781;4655.534446555352;4719.834805781816;4749.525047495223;5039.84880453587;5058.064258112261;5071.391433028023;5073.264376665363;5128.051310507568;5055.090083784918;5083.593312535026;5095.515925987025;5098.209777484496;5144.4083930348115;4615.492295847454;4675.696079754805;4711.458182309044;4711.858644240679;4713.787879545429;5144.356955380577;5166.896662066738;5171.818986335536;5173.81891633791;5219.765110570033;4940.382452193476;4949.356583644103;4951.034548263126;4951.3810773653295;5009.874753131128;4915.287283343967;4975.726335051607;5005.949940500621;5008.198688209869;5035.496450354935;5000.124978128885;5002.624803139779;5003.099442100457;5004.024215278058;5042.672226305279;4991.775370108354;4998.70007799526;5001.699898006132;5010.048090862724;5051.722155281422;4084.673226141961;4118.814653340607;4118.855840045644;4169;4321.978390108029;3676.9632303677154;3681.9815900920325;3702.4816525686424;3762.2475504898584;3795;4369.563043695605;4370.147821174904;4377.233984052778;4420.602145806893;4429.202743506135;5067.239914012927;5078.339815823993;5078.4413714491375;5080;5131.435542090367;4245.957540424556;4282.336237883133;4297.634701050383;4342.109867477159;4352.434183556181;4540.341650460665;4540.477845047796;4543.136804007228;4585.70192937458;4595.1269258841385;4684.320773487893;4688.9296660549435;4692.343071969859;4696.107739529479;4751.026039661931;4944.233643785219;4968.27959945813;4977.8257760978195;4985.451600324034;5028.9245661315845;4626.606738427136;4642.7446490442;4661.883452913568;4699.6240300776535;4706.8117275308605;4893.853184404474;4898.755062246944;4905.484924083063;4906.83787097855;4968.329275547755;4836.854894353175;4932.21084626458;4973.35346404965;5026.472220416804;5028.170351892043;4899.387576552931;4915.631327650369;4918.704877707349;4919.901601968012;4955.5044495550155;4914.803407863646;4917.606591472745;4920.6801557898625;4921.581665558468;4965.975170124127;4758.619310455225;4773.164696178224;4815.927761083657;4838.516148385133;4908.533689299511;4934.309196712391;4944.060628480721;4952.876178095432;4955.132851751001;5002.624803139852;4810.39870016248;4812.205986012269;4832.49258827818;4854.053459575349;4891.9755401222765 22:08:13 INFO - PROCESS | 11041 | |1;ext.html;547.5482726750431;551.8123837895115;566.1507738392411;567.7056311609529;579.1341943794029;27513.449731005367;38694.41958370623;40247.79876100619;40293.798531007305;43991;39396.60603393965;39483.210335793265;39802;39837;39880.604178853675;7665.961670191655;7814.921850781477;7815.101263354702;7818.33544148748;7823.491473054261;7727.304542591194;7808.375329973588;7815.491993020435;7818.6872525098925;7821.687132514721;7812.609369531529;7839.412044096687;7844.843103137934;7846.764597062097;7855.410844186709;7793.103793063813;7824.647890844925;7833.686652533892;7834.764957051298;7836.843263134734;7721;7783.377329813601;7783.53298802068;7783.571903545303;7786.805329866742;38384.23231535354;38670.80664596659;38704.22591548153;38709;38736.22527549462;2675.1974407677617;2708.444768822387;2741.876615552305;2761.613374127624;2815.085097343351;27904.441911161866;28440.857795711097;28735.56896646552;28986;30283.697163028308;3419.2135808764124;3548.3790336690977;3627.8004709740953;3653.6163702811355;3763.604821493731;187194.06402968033;187637;187667;188627;190136;49819.25271120936;51541;51571.48428515742;51623.48376516262;51624.28884245024;48914.26628600574;52814.47185528096;53581.73209133929;54013.45986540163;54097.729511352976;13950.162990220619;14377.496787612383;14406.279686015658;14412.423503059761;14423.78364324536;10947.178961577914;11126.443677816076;11135.109191264679;11148.219624626197;11154.832677509843;14070.929645351707;14466.493672721404;14490.85509144916;16132.193390330436;16416.75374869378;5291.708956007456;6351.252116834273;6395.936040639534;6414.422701956753;6538.215414150237;791.2957467853615;833.4041160570222;872.8647059705755;892.9732108036769;905.8233644439402;27264.45471090567;27324.72675273222;27362.315942101606;27650.308742281202;27745.722542774718;948.1561410344799;966.4008314844841;974.4104816586005;990.3859607043679;1021.6015753856002;14005.649858753613;14553.19957402353;14582.41670333196;14678.779818302733;14692.191929443983;359380;365291;365455.4907861961;368083;368128;48681;48811;48812.51187488151;48940.26589601159;49039.264411033866;1135.5911871726007;1157.5659127827064;1171.2328424881716;1171.84765980422;1177.9293242405483;25551.361215969748;26206.86896565505;26888.462230754885;27366.863165684044;27744.306392339546;42092.579074210094;42625.5737442634;42666;42685.35971960485;42745.78627106844;262809;262997;263228;263958;264002;30557.23606909845;31020.844895775375;32683.673163269013;36234.8188259057;36692.08269793277;40082.39876401915;40117.398239027025;40427.59572404238;40657;41028.79485602553;34296.485552717226;34717;34878.302433951685;35055.29889402249;35644.82177589095;35098;35685;35687;36080.27839443249;36233.81883090568;33648;34502.82748586241;34602.30795384028;35297.47053794144;35431;27868.16395508138;32287.35425291434;32357;32674.83662581767;32779.67220327766;24309.878450607634;24602.876985614956;24605.753942460346;24847.503049939263;25032.249032529053 22:08:13 INFO - PROCESS | 11041 | |2;jquery.html;344.85860797073207;354.1306093540357;370.28719714549493;374.67964890019044;394.74341677909354;12844.486220551178;14032.859671403283;16244.675106497863;17055.57361065974;17169.57076073099;15691.60770980726;16857.24142413591;16963.151842407893;17097;17108.144592770375;4977.55202031817;5230.084735171349;5236;5241.397239317489;5245.816396426126;3682.5396825396824;4869.293952376903;5241.580673546107;5793.159991801186;6122.448979591836;6157.599756015845;6189.690515474231;6198.4731297839735;6201.379862013808;6212.161358216651;5927.436893495111;6073.1497590337385;6128.3258841527395;6133.386661333876;6135.6625385603775;5184.326037615124;5384.488473595002;5389.110796718537;5393.298871146726;5398.757055932492;20392.490187745276;20686.482837929023;20701.58596828055;20717.27489537874;20762.896185518977;1918.5875036867;1924.220690620287;1955.6773132433132;2036.9694454583193;2466.8775707053246;12720.173188742701;12828.871711282862;12954.870451295461;13535.458581656721;13573.185608863401;1634.6894090122958;1678.8321167883237;1714.459945117284;1724.5171352021455;1749.8425141737305;53666.40769736432;59250.40749592535;62961.68519157421;64072.35927640757;64969.23992855754;10043.899561004297;10142.594296228215;10204;10229.74425639365;10423.635172768916;13744.793828092586;13791.793123103162;13818.378172982038;13829.377678004514;13837.792433113511;6813.693383797741;6989.231184569693;7137.250588688113;7380.520266182681;7387.372073373824;6712.39588437043;6728.428083612947;6737.09049278351;6910.101686780787;6925.515213935077;4328.04782947751;4363.647269346513;4364.367166760802;4408.360787685768;4441.422615060022;1821.8633602479867;1822.2528763207022;1835.2475485051066;1839.0988415676222;1864.4686264414847;802.4663598706911;809.753025327269;850.1583432402001;852.3266619370628;901.3420203251663;16152.434664786677;17268.136593170544;17408.564785880455;17630;17766.555836103944;808.6280311056979;810.4124509730516;828.4863384701404;837.6272558711315;850.6767428377177;9185.678501252423;9374.484403357881;9533.761655958657;9748.463834489172;9863.506824658738;356044;362935;363179;363567;364010;73955;74347.62826185835;75608.24391756122;75937;76333.23666763373;869.1135042256863;886.6409104312763;904.1726819959663;905.2079430498314;907.0566610724904;14966.310893805077;14981.250937453302;15123.16822574769;15601.141937193563;15758.527244182693;34568.82715586507;35220.82389588138;35310.823445882605;35756.82121589375;37214.62785372112;50757.492425075274;51180.74409627928;51929.740351298;52021.47978520166;53028.46971530235;4581.244094724333;6631.6736652670625;7299.197088320174;7663.846723065619;7827.217278272355;10038.247131465316;11923.224990375598;11982.64052078439;12194.939025304817;12473.251604903735;9803.16673082796;9861.260405469475;10097.848532272168;10295.227857910537;10323.32898361604;9892.071046145933;10348.586056557955;10432.217583681102;10553.947230263799;10593.682189534326;10341.63804266847;10413;10502.52738626779;10641;10700.732481688021;7515.286047825448;7588.27911348421;7609.885851712118;7645.885311720217;7810.062792464941;9511.239100872051;10105.292629515863;10342.37945723259;10556.524956377136;10884.673459796219 22:08:13 INFO - PROCESS | 11041 | |3;mootools.html;1200.4717924113395;1329.5014369611392;1355.2139758939816;1417.8723914847662;1662.3018332300433;6704.463642908568;7492.962535187323;7738.303552680258;7788.454808163431;7943.92056079439;7798.92201077989;7838.176991415905;7864.685412583504;7865.764027079197;7866.331361834236;2185.7377114746214;2205.5809396214668;2210.3810932938804;2211.3255457085584;2212.4468882779306;2072.067569593681;2126.8936553172357;2184.5740080684272;2184.945376365588;2188.616992026397;2168.6746987951774;2185.3443966809973;2202.3503066595395;2202.7797220277926;2210.690503329527;2137.1985505435464;2139.914403423861;2143.5391390850887;2145.5839146163457;2146.602878467481;2093.1208892265286;2148.7099241602496;2149.1725685611154;2153.4508700281485;2157.0616781699855;7809.219078092202;7844.803879903048;7854.882176767296;7856.057273127204;7874.5668988205625;4403.955960440387;4591.403117594725;4603.9769801151115;4661.673682842203;4668;2784.317842128671;2919.5474701421313;2952.4833154198145;2973.613430254075;2978.2107741448535;969.0890562870949;970.257752819094;973.776031512756;989.3865803202061;1012.427978192319;10471.94764026175;10543.630972915988;10544.947275263574;10545.894541054568;10556.049955503964;3955.4462375267485;4087.550369459357;4127.050778321003;4240.91518169641;4272.786360681954;8891.066438024043;9263.629454821732;9265.629374824932;9265.629374824932;9270.258379329638;4590.517995610479;4601.194790911577;4623.86128416148;4625.236835922103;4625.514320996247;3663.2856592964117;3760.8683696070507;3768.6419790119894;4201.432806571073;4206.074663574009;3584.8207589620415;3673.94489082664;3705.203381273039;3777.225668737902;3781.3760729479877;1187.9821802672966;1217.9756404871853;1224.8407706998032;1230.6431134970758;1241.391718058145;742.4728442805668;765.6095391350451;780.441983981456;785.5834024401718;808.292743849132;4891.315215869781;4937.654364194472;4965.503449655005;5035.82374616894;5247.685138891678;373.70290618957995;401.3498133024519;405.331203514198;412.8069383320017;419.2139737991266;3017.336186039068;3113.6886311369135;3224.27453822888;3239.3845169417737;3269.558609587723;9245;9735.269854760922;9740.17208537268;9771.31600787938;9773.706788796348;9659.082387173208;9700.708978730509;9703.417794932328;9714.465704386326;9716.757081072888;7221.963890180516;7304.050473438419;7369.22623124575;7372.299631534996;7391.223921488274;4789.473157952692;4810.4467986182035;4827.637927155548;4942.061008408391;5076.898462030813;8686.78283042929;8827.69103081389;8894.288456923301;8927.419717718327;8945;7930.246626570467;8896.199342058986;9023.142801433853;9076.047015063587;9106.089391061107;6218.502519798315;6388.840278993062;6432.195975503062;6556.442702370352;6556.868862622816;7476.962615186889;7489.475736698379;7545.811354716176;7548.433867459853;7563.130240022248;6519.7392104315295;6539.378759017885;6565.540412171103;6718.966405167943;6737.764178253738;4264.275073237495;5197.974010129925;6447.2263328400895;6472.838179045373;6547.541672082908;5952.642841429528;5959.67221802805;6006.909896351471;6016.759329626766;6024.90962635552;4288.442502474658;4353.216421044242;4372.256716358163;4414.66889983259;4449.466064072332;4299.376590394313;4374.387585737935;4436.423264975661;4499.392582001388;4577.633789296915 22:08:13 INFO - PROCESS | 11041 | |4;prototype.html;269.1400973888426;269.4637671034642;279.183388588379;280.16091805043897;282.21403391554526;4598.632109431246;4671.672982891199;4738.938561725652;4775.235962246042;4799.856004319871;4632.351470794091;4702.929456058153;4703.200455922492;4704.670673052888;4707.317438971347;3442.414789485781;3548.4854696069056;3691.8338674759702;3697.3159965406353;3706.2580587124007;3692.5938146803965;3710.4619830124616;3712.4616930545053;3715.071232191952;3728.6830619397247;3676.7058635309113;3679.208970071434;3679.8528058877614;3680.466332381803;3685.281370132825;3678.7057035437233;3679.3377192105545;3683.918585998902;3705.888823335304;3722.683571896392;3161.4824884055784;3203.7116659500757;3226.1450715560395;3244.967550324514;3261.575995120643;4628.791704373311;4630.050839577879;4630.421197350332;4630.791614377327;4647.326137710047;4159.9376009359885;4170.416141740159;4170.895727606834;4178.1643671265865;4179.247735407625;4741.620670346399;4938.580220681247;4939.58013568847;4943.505649435064;4954.529319714621;3399.7280217582534;3425.451927691582;3432.673895979878;3433.1588760753525;3437.1750779812915;5173.844784656466;5186.055229289017;5194.740262986873;5217.713025783581;5218.634695571312;3389.8135602542097;3462.671046250602;3468.6531346865113;3477.913052173665;3488.7963652539834;3507.193345530542;3516.261585067113;3517.0152357339985;3522.661388672288;3523.1896663767475;4085.3259212230246;4088.6729061674996;4094.3244364679495;4106.486689163855;4112.979435102805;4653.255479123324;4693;4946.777395017233;4949.34761324354;4958.157113290749;1184.1888306510068;1201.6575276046285;1202.1765090912752;1204.6085022367765;1207.776561336138;735.0481126940518;756.9848603027908;771.4291424345944;771.7800426878425;773.3542492019114;3931.3709806430834;3944.5069366329208;3948.7364043505804;3959.524857017119;4009.6391324780325;4542;4563.657725670588;4574.513283182979;4576.4508259009135;4577.267637178035;3994.9014021143835;3996.900077498086;3998.7400818946676;4001.1797581495725;4010.47863777707;2333.241696448661;2334.9299521014395;2407.831451798357;2412.8672922989404;2450.2159309020944;4282.250606143913;4290.227759003347;4298.4412026436985;4311.814251080978;4320.546342634041;4641.280601506772;4646.442426908792;4647.953520464752;4655.208614535537;4664.930026049612;4293.892652683708;4294.871153865389;4298.570142985676;4425.822967081345;4811.4362832080415;5186.4035635902355;5188.922166167435;5199.168133098686;5201.453847346125;5206.193040078794;5094.719790411563;5096.617753668564;5097.337346144977;5097.898042039064;5105;4618.676692631483;4785.9042819144115;4789.658895509263;4844.660873738804;4858.6356023297685;3480.9477857832658;3485.1461391959133;3485.1809824691686;3498.5451891253974;3516.487910198639;4911.4106307243355;5079.72061536619;5105.668131571436;5107.821226257063;5126.871828204325;4834.371531700856;4958.8760280993265;4970.676906001098;4979.278004689228;4988.802687355082;4972.65191436596;4973.751312434436;4974.129527332775;4974.433053588108;5018.949810501995;4793.113274044313;4914.631402644744;4918.901621967612;4943.728094954812;4951.8266860659705;5003.424606170337;5006.674566153334;5015.464097810962;5043.621728370314;5057.519535644108;4868.756562171807;4889.559939605452;4889.608831293559;4893.7797799099835;4903 22:08:13 INFO - PROCESS | 11041 | |5;yui.html;606.6572386601573;613.4356392119253;621.2296752027486;721.6067243352372;737.3621817128184;13388.7322253555;14396.856031439682;14416.855831441682;14418.13491190528;14427.711445771078;12046.939765301184;12081.395930203498;12088.69778255544;12102.636920892366;12141.696457588565;590.4862769390614;712.1632082303299;716.147784136878;730.9561426314411;732.5458215906145;728.890666400039;731.2687312687312;731.5756861020595;731.6634348199834;731.9451041171933;780.7033327335633;780.7813812132612;780.8711562592165;781.7420251317052;782.0185666987923;621.8321053315625;747.7532414303321;766.9923300767033;768.078306032763;778.5756762564416;561.9859503512445;561.9887602247932;562.0838034004587;562.4122791682702;564.5145175149369;12804.295763732991;13015.479380824756;13028.153170044012;13037.348132593428;13044.217346959118;11990.460429280703;12377.93811030948;12645.241285522807;12731.363431828464;12979.610611681665;11806.232594881305;11884.940575297154;12100.939495302555;12156.696082597917;12472.314022728746;4112.321466957948;4113.341865301567;4148.958510414887;4339.305711086211;4344.522102568747;64694.35305646931;64927.350726493074;65046.02430963587;65205.34794652087;65417.345826541605;10020.549075291628;10032.799344013225;10327.173826093895;10341.224408169417;10727.141828653688;18523.629527409375;18526.351577694717;18539.165737541844;18542.629147417247;18569.44291671252;6810.148731408574;6878.312168783182;7008.7546935857;7183.604901730455;7192;3661.9816900915325;3689.6863766579604;3704.351738445815;3714.0714821294678;3772.4529943158636;2630.092618046771;2741.4928238275984;2745.0666773297175;2749.958750618742;2755.1734479656425;471.83014114918603;478.33511419126745;479.82486392467194;488.8606747077066;495.2571143285072;376.69475268195833;433.43436814956783;449.42024788023735;462.3365470549772;497.1374664956298;6602.405783479414;6770.932290677129;6835.179778426521;6854.931450685429;6937.236903940562;454.52956190343497;472.47319239048903;473.78679594182756;478.1226449465201;480.46428232520486;3328;3344.448166052574;3525.8765943191866;3588.2285308658766;3673;75767.62116189495;79131.60434197792;79153.60423197963;88313;105652;75521;76812.61593692108;77506.22493775103;78436.6078169617;78504.28974261563;45825;66379.66810165918;69044.30955690479;71737;72251.27748722445;7556.811079723051;7577.431692623186;7854.253845884632;8004.639791209293;8063.637136328762;42227.55448910169;42767;43881;44287.55712442963;45096;54622;60912.69543652253;61303.693481532304;61323.38676613177;63019.6849015752;11143.888561114609;11213.159013074215;11368.488418021043;11476.655700329004;11990.520379184734;11305.886941130813;11445.828312575484;11606.709832253924;11781.175317727677;11813.940930295294;10993.395363254778;11418.200725949104;11521.366324852213;11910;11924.76150477003;11078.723031924266;11423.371714555778;11981.221220620631;11987.76024479523;12013.219140755822;11433.1996760226;12165.817512737493;12495.58525799505;12573.371331433575;12606.180598261451;9353.692404168656;9739.513024348897;9977.501124943868;10352.171826254033;10383.376997380181;9420.62317507292;9499.335046546952;9686.9031309686;9785.266105042008;9915.30592858493 22:08:13 INFO - PROCESS | 11041 | __end_tp_report 22:08:13 INFO - PROCESS | 11041 | __start_cc_report 22:08:13 INFO - PROCESS | 11041 | _x_x_mozilla_cycle_collect,1010 22:08:13 INFO - PROCESS | 11041 | __end_cc_report 22:08:13 INFO - PROCESS | 11041 | __startTimestamp1472533693160__endTimestamp 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | ------- Summary: start ------- 22:08:13 INFO - PROCESS | 11041 | Number of tests: 6 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | [#0] dojo.html Cycles:165 Average:4642.96 Median:4744.81 stddev:493.74 (10.4%) stddev-sans-first:467.62 22:08:13 INFO - PROCESS | 11041 | Values: 2567.0 2572.4 2584.6 2600.2 2606.3 4600.1 4620.2 4632.6 4711.2 4744.8 4610.9 4653.4 4661.2 4691.8 4732.4 4258.3 4269.4 4333.7 4386.8 4462.7 4376.5 4396.4 4412.2 4426.6 4450.6 4249.2 4292.4 4304.8 4330.2 4339.9 4268.8 4269.7 4275.8 4387.5 4417.0 4284.2 4298.8 4312.7 4327.9 4360.4 4606.3 4654.1 4655.5 4719.8 4749.5 5039.8 5058.1 5071.4 5073.3 5128.1 5055.1 5083.6 5095.5 5098.2 5144.4 4615.5 4675.7 4711.5 4711.9 4713.8 5144.4 5166.9 5171.8 5173.8 5219.8 4940.4 4949.4 4951.0 4951.4 5009.9 4915.3 4975.7 5005.9 5008.2 5035.5 5000.1 5002.6 5003.1 5004.0 5042.7 4991.8 4998.7 5001.7 5010.0 5051.7 4084.7 4118.8 4118.9 4169.0 4322.0 3677.0 3682.0 3702.5 3762.2 3795.0 4369.6 4370.1 4377.2 4420.6 4429.2 5067.2 5078.3 5078.4 5080.0 5131.4 4246.0 4282.3 4297.6 4342.1 4352.4 4540.3 4540.5 4543.1 4585.7 4595.1 4684.3 4688.9 4692.3 4696.1 4751.0 4944.2 4968.3 4977.8 4985.5 5028.9 4626.6 4642.7 4661.9 4699.6 4706.8 4893.9 4898.8 4905.5 4906.8 4968.3 4836.9 4932.2 4973.4 5026.5 5028.2 4899.4 4915.6 4918.7 4919.9 4955.5 4914.8 4917.6 4920.7 4921.6 4966.0 4758.6 4773.2 4815.9 4838.5 4908.5 4934.3 4944.1 4952.9 4955.1 5002.6 4810.4 4812.2 4832.5 4854.1 4892.0 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | [#1] ext.html Cycles:180 Average:43264.61 Median:184472.31 stddev:74093.63 (40.2%) stddev-sans-first:74232.06 22:08:13 INFO - PROCESS | 11041 | Values: 547.5 551.8 566.2 567.7 579.1 27513.4 38694.4 40247.8 40293.8 43991.0 39396.6 39483.2 39802.0 39837.0 39880.6 7666.0 7814.9 7815.1 7818.3 7823.5 7727.3 7808.4 7815.5 7818.7 7821.7 7812.6 7839.4 7844.8 7846.8 7855.4 7793.1 7824.6 7833.7 7834.8 7836.8 7721.0 7783.4 7783.5 7783.6 7786.8 38384.2 38670.8 38704.2 38709.0 38736.2 2675.2 2708.4 2741.9 2761.6 2815.1 27904.4 28440.9 28735.6 28986.0 30283.7 3419.2 3548.4 3627.8 3653.6 3763.6 187194.1 187637.0 187667.0 188627.0 190136.0 49819.3 51541.0 51571.5 51623.5 51624.3 48914.3 52814.5 53581.7 54013.5 54097.7 13950.2 14377.5 14406.3 14412.4 14423.8 10947.2 11126.4 11135.1 11148.2 11154.8 14070.9 14466.5 14490.9 16132.2 16416.8 5291.7 6351.3 6395.9 6414.4 6538.2 791.3 833.4 872.9 893.0 905.8 27264.5 27324.7 27362.3 27650.3 27745.7 948.2 966.4 974.4 990.4 1021.6 14005.6 14553.2 14582.4 14678.8 14692.2 359380.0 365291.0 365455.5 368083.0 368128.0 48681.0 48811.0 48812.5 48940.3 49039.3 1135.6 1157.6 1171.2 1171.8 1177.9 25551.4 26206.9 26888.5 27366.9 27744.3 42092.6 42625.6 42666.0 42685.4 42745.8 262809.0 262997.0 263228.0 263958.0 264002.0 30557.2 31020.8 32683.7 36234.8 36692.1 40082.4 40117.4 40427.6 40657.0 41028.8 34296.5 34717.0 34878.3 35055.3 35644.8 35098.0 35685.0 35687.0 36080.3 36233.8 33648.0 34502.8 34602.3 35297.5 35431.0 27868.2 32287.4 32357.0 32674.8 32779.7 24309.9 24602.9 24605.8 24847.5 25032.2 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | [#2] jquery.html Cycles:180 Average:23328.90 Median:384.71 stddev:59740.39 (15528.6%) stddev-sans-first:59883.05 22:08:13 INFO - PROCESS | 11041 | Values: 344.9 354.1 370.3 374.7 394.7 12844.5 14032.9 16244.7 17055.6 17169.6 15691.6 16857.2 16963.2 17097.0 17108.1 4977.6 5230.1 5236.0 5241.4 5245.8 3682.5 4869.3 5241.6 5793.2 6122.4 6157.6 6189.7 6198.5 6201.4 6212.2 5927.4 6073.1 6128.3 6133.4 6135.7 5184.3 5384.5 5389.1 5393.3 5398.8 20392.5 20686.5 20701.6 20717.3 20762.9 1918.6 1924.2 1955.7 2037.0 2466.9 12720.2 12828.9 12954.9 13535.5 13573.2 1634.7 1678.8 1714.5 1724.5 1749.8 53666.4 59250.4 62961.7 64072.4 64969.2 10043.9 10142.6 10204.0 10229.7 10423.6 13744.8 13791.8 13818.4 13829.4 13837.8 6813.7 6989.2 7137.3 7380.5 7387.4 6712.4 6728.4 6737.1 6910.1 6925.5 4328.0 4363.6 4364.4 4408.4 4441.4 1821.9 1822.3 1835.2 1839.1 1864.5 802.5 809.8 850.2 852.3 901.3 16152.4 17268.1 17408.6 17630.0 17766.6 808.6 810.4 828.5 837.6 850.7 9185.7 9374.5 9533.8 9748.5 9863.5 356044.0 362935.0 363179.0 363567.0 364010.0 73955.0 74347.6 75608.2 75937.0 76333.2 869.1 886.6 904.2 905.2 907.1 14966.3 14981.3 15123.2 15601.1 15758.5 34568.8 35220.8 35310.8 35756.8 37214.6 50757.5 51180.7 51929.7 52021.5 53028.5 4581.2 6631.7 7299.2 7663.8 7827.2 10038.2 11923.2 11982.6 12194.9 12473.3 9803.2 9861.3 10097.8 10295.2 10323.3 9892.1 10348.6 10432.2 10553.9 10593.7 10341.6 10413.0 10502.5 10641.0 10700.7 7515.3 7588.3 7609.9 7645.9 7810.1 9511.2 10105.3 10342.4 10556.5 10884.7 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | [#3] mootools.html Cycles:180 Average:5028.61 Median:4664.84 stddev:2886.43 (61.9%) stddev-sans-first:2880.19 22:08:13 INFO - PROCESS | 11041 | Values: 1200.5 1329.5 1355.2 1417.9 1662.3 6704.5 7493.0 7738.3 7788.5 7943.9 7798.9 7838.2 7864.7 7865.8 7866.3 2185.7 2205.6 2210.4 2211.3 2212.4 2072.1 2126.9 2184.6 2184.9 2188.6 2168.7 2185.3 2202.4 2202.8 2210.7 2137.2 2139.9 2143.5 2145.6 2146.6 2093.1 2148.7 2149.2 2153.5 2157.1 7809.2 7844.8 7854.9 7856.1 7874.6 4404.0 4591.4 4604.0 4661.7 4668.0 2784.3 2919.5 2952.5 2973.6 2978.2 969.1 970.3 973.8 989.4 1012.4 10471.9 10543.6 10544.9 10545.9 10556.0 3955.4 4087.6 4127.1 4240.9 4272.8 8891.1 9263.6 9265.6 9265.6 9270.3 4590.5 4601.2 4623.9 4625.2 4625.5 3663.3 3760.9 3768.6 4201.4 4206.1 3584.8 3673.9 3705.2 3777.2 3781.4 1188.0 1218.0 1224.8 1230.6 1241.4 742.5 765.6 780.4 785.6 808.3 4891.3 4937.7 4965.5 5035.8 5247.7 373.7 401.3 405.3 412.8 419.2 3017.3 3113.7 3224.3 3239.4 3269.6 9245.0 9735.3 9740.2 9771.3 9773.7 9659.1 9700.7 9703.4 9714.5 9716.8 7222.0 7304.1 7369.2 7372.3 7391.2 4789.5 4810.4 4827.6 4942.1 5076.9 8686.8 8827.7 8894.3 8927.4 8945.0 7930.2 8896.2 9023.1 9076.0 9106.1 6218.5 6388.8 6432.2 6556.4 6556.9 7477.0 7489.5 7545.8 7548.4 7563.1 6519.7 6539.4 6565.5 6719.0 6737.8 4264.3 5198.0 6447.2 6472.8 6547.5 5952.6 5959.7 6006.9 6016.8 6024.9 4288.4 4353.2 4372.3 4414.7 4449.5 4299.4 4374.4 4436.4 4499.4 4577.6 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | [#4] prototype.html Cycles:180 Average:4013.48 Median:4569.09 stddev:1197.71 (26.2%) stddev-sans-first:1167.63 22:08:13 INFO - PROCESS | 11041 | Values: 269.1 269.5 279.2 280.2 282.2 4598.6 4671.7 4738.9 4775.2 4799.9 4632.4 4702.9 4703.2 4704.7 4707.3 3442.4 3548.5 3691.8 3697.3 3706.3 3692.6 3710.5 3712.5 3715.1 3728.7 3676.7 3679.2 3679.9 3680.5 3685.3 3678.7 3679.3 3683.9 3705.9 3722.7 3161.5 3203.7 3226.1 3245.0 3261.6 4628.8 4630.1 4630.4 4630.8 4647.3 4159.9 4170.4 4170.9 4178.2 4179.2 4741.6 4938.6 4939.6 4943.5 4954.5 3399.7 3425.5 3432.7 3433.2 3437.2 5173.8 5186.1 5194.7 5217.7 5218.6 3389.8 3462.7 3468.7 3477.9 3488.8 3507.2 3516.3 3517.0 3522.7 3523.2 4085.3 4088.7 4094.3 4106.5 4113.0 4653.3 4693.0 4946.8 4949.3 4958.2 1184.2 1201.7 1202.2 1204.6 1207.8 735.0 757.0 771.4 771.8 773.4 3931.4 3944.5 3948.7 3959.5 4009.6 4542.0 4563.7 4574.5 4576.5 4577.3 3994.9 3996.9 3998.7 4001.2 4010.5 2333.2 2334.9 2407.8 2412.9 2450.2 4282.3 4290.2 4298.4 4311.8 4320.5 4641.3 4646.4 4648.0 4655.2 4664.9 4293.9 4294.9 4298.6 4425.8 4811.4 5186.4 5188.9 5199.2 5201.5 5206.2 5094.7 5096.6 5097.3 5097.9 5105.0 4618.7 4785.9 4789.7 4844.7 4858.6 3480.9 3485.1 3485.2 3498.5 3516.5 4911.4 5079.7 5105.7 5107.8 5126.9 4834.4 4958.9 4970.7 4979.3 4988.8 4972.7 4973.8 4974.1 4974.4 5018.9 4793.1 4914.6 4918.9 4943.7 4951.8 5003.4 5006.7 5015.5 5043.6 5057.5 4868.8 4889.6 4889.6 4893.8 4903.0 22:08:13 INFO - PROCESS | 11041 | 22:08:13 INFO - PROCESS | 11041 | [#5] yui.html Cycles:180 Average:16921.85 Median:22775.26 stddev:23390.62 (102.7%) stddev-sans-first:23424.16 22:08:13 INFO - PROCESS | 11041 | Values: 606.7 613.4 621.2 721.6 737.4 13388.7 14396.9 14416.9 14418.1 14427.7 12046.9 12081.4 12088.7 12102.6 12141.7 590.5 712.2 716.1 731.0 732.5 728.9 731.3 731.6 731.7 731.9 780.7 780.8 780.9 781.7 782.0 621.8 747.8 767.0 768.1 778.6 562.0 562.0 562.1 562.4 564.5 12804.3 13015.5 13028.2 13037.3 13044.2 11990.5 12377.9 12645.2 12731.4 12979.6 11806.2 11884.9 12100.9 12156.7 12472.3 4112.3 4113.3 4149.0 4339.3 4344.5 64694.4 64927.4 65046.0 65205.3 65417.3 10020.5 10032.8 10327.2 10341.2 10727.1 18523.6 18526.4 18539.2 18542.6 18569.4 6810.1 6878.3 7008.8 7183.6 7192.0 3662.0 3689.7 3704.4 3714.1 3772.5 2630.1 2741.5 2745.1 2750.0 2755.2 471.8 478.3 479.8 488.9 495.3 376.7 433.4 449.4 462.3 497.1 6602.4 6770.9 6835.2 6854.9 6937.2 454.5 472.5 473.8 478.1 480.5 3328.0 3344.4 3525.9 3588.2 3673.0 75767.6 79131.6 79153.6 88313.0 105652.0 75521.0 76812.6 77506.2 78436.6 78504.3 45825.0 66379.7 69044.3 71737.0 72251.3 7556.8 7577.4 7854.3 8004.6 8063.6 42227.6 42767.0 43881.0 44287.6 45096.0 54622.0 60912.7 61303.7 61323.4 63019.7 11143.9 11213.2 11368.5 11476.7 11990.5 11305.9 11445.8 11606.7 11781.2 11813.9 10993.4 11418.2 11521.4 11910.0 11924.8 11078.7 11423.4 11981.2 11987.8 12013.2 11433.2 12165.8 12495.6 12573.4 12606.2 9353.7 9739.5 9977.5 10352.2 10383.4 9420.6 9499.3 9686.9 9785.3 9915.3 22:08:13 INFO - PROCESS | 11041 | -------- Summary: end -------- 22:08:13 INFO - PROCESS | 11041 | 22:08:14 INFO - TEST-INFO | 11041: exit 0 22:08:14 INFO - TEST-OK | dromaeo_css | took 1121625ms 22:08:14 INFO - TEST-START | kraken 22:08:14 INFO - operating with platform_type : linux_ 22:08:14 INFO - Initialising browser for kraken test... 22:08:14 INFO - TEST-INFO | started process 11343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdfuLn/profile http://localhost:52281/getInfo.html) 22:08:18 INFO - PROCESS | 11343 | __metrics Screen width/height:1600/1200 22:08:18 INFO - PROCESS | 11343 | colorDepth:24 22:08:18 INFO - PROCESS | 11343 | Browser inner width/height: 1024/697 22:08:18 INFO - PROCESS | 11343 | __metrics 22:08:19 INFO - PROCESS | 11343 | 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" 22:08:19 INFO - PROCESS | 11343 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:08:19 INFO - PROCESS | 11343 | console.error: PushService: 22:08:19 INFO - PROCESS | 11343 | stateChangeProcessEnqueue: Error transitioning state 22:08:19 INFO - PROCESS | 11343 | UnknownError 22:08:20 INFO - TEST-INFO | 11343: exit 0 22:08:20 INFO - Browser initialized. 22:08:20 INFO - Running cycle 1/1 for kraken test... 22:08:20 INFO - TEST-INFO | started process 11422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdfuLn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:32 INFO - PROCESS | 11422 | RSS: Main: 182194176 22:08:32 INFO - PROCESS | 11422 | 22:08:35 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-beat-detection) 22:08:36 INFO - PROCESS | 11422 | RSS: Main: 235180032 22:08:36 INFO - PROCESS | 11422 | 22:08:39 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-dft) 22:08:39 INFO - PROCESS | 11422 | RSS: Main: 225865728 22:08:39 INFO - PROCESS | 11422 | 22:08:43 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-fft) 22:08:43 INFO - PROCESS | 11422 | RSS: Main: 302919680 22:08:43 INFO - PROCESS | 11422 | 22:08:45 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52281/tests/kraken/driver.html?testName=audio-oscillator) 22:08:46 INFO - PROCESS | 11422 | RSS: Main: 213508096 22:08:46 INFO - PROCESS | 11422 | 22:08:48 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:49 INFO - PROCESS | 11422 | RSS: Main: 214827008 22:08:49 INFO - PROCESS | 11422 | 22:08:52 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52281/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:52 INFO - PROCESS | 11422 | RSS: Main: 253095936 22:08:52 INFO - PROCESS | 11422 | 22:08:56 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52281/tests/kraken/driver.html?testName=imaging-desaturate) 22:08:56 INFO - PROCESS | 11422 | RSS: Main: 252653568 22:08:56 INFO - PROCESS | 11422 | 22:08:59 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52281/tests/kraken/driver.html?testName=json-parse-financial) 22:09:00 INFO - PROCESS | 11422 | RSS: Main: 252600320 22:09:00 INFO - PROCESS | 11422 | 22:09:02 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:09:02 INFO - PROCESS | 11422 | RSS: Main: 215220224 22:09:02 INFO - PROCESS | 11422 | 22:09:04 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:09:05 INFO - PROCESS | 11422 | RSS: Main: 222425088 22:09:05 INFO - PROCESS | 11422 | 22:09:07 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:09:08 INFO - PROCESS | 11422 | RSS: Main: 223526912 22:09:08 INFO - PROCESS | 11422 | 22:09:11 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:09:11 INFO - PROCESS | 11422 | RSS: Main: 224559104 22:09:11 INFO - PROCESS | 11422 | 22:09:14 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:09:15 INFO - PROCESS | 11422 | RSS: Main: 222425088 22:09:15 INFO - PROCESS | 11422 | 22:09:16 INFO - PROCESS | 11422 | Cycle 1(1): loaded http://localhost:52281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52281/tests/kraken/driver.html?testName=ai-astar) 22:09:17 INFO - PROCESS | 11422 | RSS: Main: 272478208 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | __start_tp_report 22:09:17 INFO - PROCESS | 11422 | _x_x_mozilla_page_load 22:09:17 INFO - PROCESS | 11422 | _x_x_mozilla_page_load_details 22:09:17 INFO - PROCESS | 11422 | |i|pagename|runs| 22:09:17 INFO - PROCESS | 11422 | |0;ai-astar;115;114;132;114;116;115;115;116;113;116 22:09:17 INFO - PROCESS | 11422 | |1;audio-beat-detection;157;128;148;190;124;164;150;130;182;122 22:09:17 INFO - PROCESS | 11422 | |2;audio-dft;162;164;162;161;161;162;162;162;163;162 22:09:17 INFO - PROCESS | 11422 | |3;audio-fft;76;76;74;167;76;76;76;76;153;76 22:09:17 INFO - PROCESS | 11422 | |4;audio-oscillator;84;83;136;83;83;83;148;83;83;128 22:09:17 INFO - PROCESS | 11422 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;116;117;117 22:09:17 INFO - PROCESS | 11422 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;147;146 22:09:17 INFO - PROCESS | 11422 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;95 22:09:17 INFO - PROCESS | 11422 | |8;json-parse-financial;64;66;65;66;65;65;65;65;66;67 22:09:17 INFO - PROCESS | 11422 | |9;json-stringify-tinderbox;66;65;66;66;65;65;67;66;70;65 22:09:17 INFO - PROCESS | 11422 | |10;stanford-crypto-aes;83;83;90;82;80;82;85;82;83;82 22:09:17 INFO - PROCESS | 11422 | |11;stanford-crypto-ccm;133;129;142;136;138;142;133;140;172;133 22:09:17 INFO - PROCESS | 11422 | |12;stanford-crypto-pbkdf2;177;174;169;170;171;170;170;172;171;174 22:09:17 INFO - PROCESS | 11422 | |13;stanford-crypto-sha256-iterative;71;72;69;68;68;68;68;70;68;67 22:09:17 INFO - PROCESS | 11422 | __end_tp_report 22:09:17 INFO - PROCESS | 11422 | __start_cc_report 22:09:17 INFO - PROCESS | 11422 | _x_x_mozilla_cycle_collect,1979 22:09:17 INFO - PROCESS | 11422 | __end_cc_report 22:09:17 INFO - PROCESS | 11422 | __startTimestamp1472533757207__endTimestamp 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | ------- Summary: start ------- 22:09:17 INFO - PROCESS | 11422 | Number of tests: 14 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#0] ai-astar Cycles:10 Average:116.60 Median:115.50 stddev:5.50 (4.8%) stddev-sans-first:5.80 22:09:17 INFO - PROCESS | 11422 | Values: 115.0 114.0 132.0 114.0 116.0 115.0 115.0 116.0 113.0 116.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:153.50 stddev:24.07 (15.7%) stddev-sans-first:25.38 22:09:17 INFO - PROCESS | 11422 | Values: 157.0 128.0 148.0 190.0 124.0 164.0 150.0 130.0 182.0 122.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 22:09:17 INFO - PROCESS | 11422 | Values: 162.0 164.0 162.0 161.0 161.0 162.0 162.0 162.0 163.0 162.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.68 (46.9%) stddev-sans-first:37.34 22:09:17 INFO - PROCESS | 11422 | Values: 76.0 76.0 74.0 167.0 76.0 76.0 76.0 76.0 153.0 76.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#4] audio-oscillator Cycles:10 Average:99.40 Median:83.00 stddev:26.60 (32.1%) stddev-sans-first:27.63 22:09:17 INFO - PROCESS | 11422 | Values: 84.0 83.0 136.0 83.0 83.0 83.0 148.0 83.0 83.0 128.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:09:17 INFO - PROCESS | 11422 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 22:09:17 INFO - PROCESS | 11422 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:09:17 INFO - PROCESS | 11422 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 22:09:17 INFO - PROCESS | 11422 | Values: 64.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 66.0 67.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 22:09:17 INFO - PROCESS | 11422 | Values: 66.0 65.0 66.0 66.0 65.0 65.0 67.0 66.0 70.0 65.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.70 (3.3%) stddev-sans-first:2.86 22:09:17 INFO - PROCESS | 11422 | Values: 83.0 83.0 90.0 82.0 80.0 82.0 85.0 82.0 83.0 82.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.00 stddev:12.11 (8.7%) stddev-sans-first:12.59 22:09:17 INFO - PROCESS | 11422 | Values: 133.0 129.0 142.0 136.0 138.0 142.0 133.0 140.0 172.0 133.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:171.50 stddev:2.49 (1.4%) stddev-sans-first:1.79 22:09:17 INFO - PROCESS | 11422 | Values: 177.0 174.0 169.0 170.0 171.0 170.0 170.0 172.0 171.0 174.0 22:09:17 INFO - PROCESS | 11422 | 22:09:17 INFO - PROCESS | 11422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:1.60 (2.3%) stddev-sans-first:1.50 22:09:17 INFO - PROCESS | 11422 | Values: 71.0 72.0 69.0 68.0 68.0 68.0 68.0 70.0 68.0 67.0 22:09:17 INFO - PROCESS | 11422 | -------- Summary: end -------- 22:09:17 INFO - PROCESS | 11422 | 22:09:18 INFO - TEST-INFO | 11422: exit 0 22:09:18 INFO - TEST-OK | kraken | took 64233ms 22:09:18 INFO - SUITE-END | took 1185s 22:09:18 INFO - Completed test suite (00:19:46) 22:09:18 INFO - javascript benchmark 22:09:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.987165064175, 2572.369769406496, 2584.6123081537767, 2600.1939398786376, 2606.335384476958, 4600.1259760645535, 4620.237660785971, 4632.606228470584, 4711.151992641323, 4744.810207591697, 4610.9308360374625, 4653.395058642372, 4661.207594708899, 4691.812327506904, 4732.36113124728, 4258.318669012959, 4269.423627810237, 4333.696641235115, 4386.802593883267, 4462.709923854955, 4376.540463251376, 4396.428464299653, 4412.227860124482, 4426.645868330525, 4450.643948484129, 4249.150169966019, 4292.399064131024, 4304.849330273425, 4330.198913201068, 4339.869803905888, 4268.829246830123, 4269.679774016961, 4275.786210689453, 4387.539308372607, 4417.0, 4284.186004659136, 4298.828046878152, 4312.676549258818, 4327.870163895088, 4360.411344468488, 4606.286025665993, 4654.069186162781, 4655.534446555352, 4719.834805781816, 4749.525047495223, 5039.84880453587, 5058.064258112261, 5071.391433028023, 5073.264376665363, 5128.051310507568, 5055.090083784918, 5083.593312535026, 5095.515925987025, 5098.209777484496, 5144.4083930348115, 4615.492295847454, 4675.696079754805, 4711.458182309044, 4711.858644240679, 4713.787879545429, 5144.356955380577, 5166.896662066738, 5171.818986335536, 5173.81891633791, 5219.765110570033, 4940.382452193476, 4949.356583644103, 4951.034548263126, 4951.3810773653295, 5009.874753131128, 4915.287283343967, 4975.726335051607, 5005.949940500621, 5008.198688209869, 5035.496450354935, 5000.124978128885, 5002.624803139779, 5003.099442100457, 5004.024215278058, 5042.672226305279, 4991.775370108354, 4998.70007799526, 5001.699898006132, 5010.048090862724, 5051.722155281422, 4084.673226141961, 4118.814653340607, 4118.855840045644, 4169.0, 4321.978390108029, 3676.9632303677154, 3681.9815900920325, 3702.4816525686424, 3762.2475504898584, 3795.0, 4369.563043695605, 4370.147821174904, 4377.233984052778, 4420.602145806893, 4429.202743506135, 5067.239914012927, 5078.339815823993, 5078.4413714491375, 5080.0, 5131.435542090367, 4245.957540424556, 4282.336237883133, 4297.634701050383, 4342.109867477159, 4352.434183556181, 4540.341650460665, 4540.477845047796, 4543.136804007228, 4585.70192937458, 4595.1269258841385, 4684.320773487893, 4688.9296660549435, 4692.343071969859, 4696.107739529479, 4751.026039661931, 4944.233643785219, 4968.27959945813, 4977.8257760978195, 4985.451600324034, 5028.9245661315845, 4626.606738427136, 4642.7446490442, 4661.883452913568, 4699.6240300776535, 4706.8117275308605, 4893.853184404474, 4898.755062246944, 4905.484924083063, 4906.83787097855, 4968.329275547755, 4836.854894353175, 4932.21084626458, 4973.35346404965, 5026.472220416804, 5028.170351892043, 4899.387576552931, 4915.631327650369, 4918.704877707349, 4919.901601968012, 4955.5044495550155, 4914.803407863646, 4917.606591472745, 4920.6801557898625, 4921.581665558468, 4965.975170124127, 4758.619310455225, 4773.164696178224, 4815.927761083657, 4838.516148385133, 4908.533689299511, 4934.309196712391, 4944.060628480721, 4952.876178095432, 4955.132851751001, 5002.624803139852, 4810.39870016248, 4812.205986012269, 4832.49258827818, 4854.053459575349, 4891.9755401222765], "value": 4610.710481466016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.5482726750431, 551.8123837895115, 566.1507738392411, 567.7056311609529, 579.1341943794029, 27513.449731005367, 38694.41958370623, 40247.79876100619, 40293.798531007305, 43991.0, 39396.60603393965, 39483.210335793265, 39802.0, 39837.0, 39880.604178853675, 7665.961670191655, 7814.921850781477, 7815.101263354702, 7818.33544148748, 7823.491473054261, 7727.304542591194, 7808.375329973588, 7815.491993020435, 7818.6872525098925, 7821.687132514721, 7812.609369531529, 7839.412044096687, 7844.843103137934, 7846.764597062097, 7855.410844186709, 7793.103793063813, 7824.647890844925, 7833.686652533892, 7834.764957051298, 7836.843263134734, 7721.0, 7783.377329813601, 7783.53298802068, 7783.571903545303, 7786.805329866742, 38384.23231535354, 38670.80664596659, 38704.22591548153, 38709.0, 38736.22527549462, 2675.1974407677617, 2708.444768822387, 2741.876615552305, 2761.613374127624, 2815.085097343351, 27904.441911161866, 28440.857795711097, 28735.56896646552, 28986.0, 30283.697163028308, 3419.2135808764124, 3548.3790336690977, 3627.8004709740953, 3653.6163702811355, 3763.604821493731, 187194.06402968033, 187637.0, 187667.0, 188627.0, 190136.0, 49819.25271120936, 51541.0, 51571.48428515742, 51623.48376516262, 51624.28884245024, 48914.26628600574, 52814.47185528096, 53581.73209133929, 54013.45986540163, 54097.729511352976, 13950.162990220619, 14377.496787612383, 14406.279686015658, 14412.423503059761, 14423.78364324536, 10947.178961577914, 11126.443677816076, 11135.109191264679, 11148.219624626197, 11154.832677509843, 14070.929645351707, 14466.493672721404, 14490.85509144916, 16132.193390330436, 16416.75374869378, 5291.708956007456, 6351.252116834273, 6395.936040639534, 6414.422701956753, 6538.215414150237, 791.2957467853615, 833.4041160570222, 872.8647059705755, 892.9732108036769, 905.8233644439402, 27264.45471090567, 27324.72675273222, 27362.315942101606, 27650.308742281202, 27745.722542774718, 948.1561410344799, 966.4008314844841, 974.4104816586005, 990.3859607043679, 1021.6015753856002, 14005.649858753613, 14553.19957402353, 14582.41670333196, 14678.779818302733, 14692.191929443983, 359380.0, 365291.0, 365455.4907861961, 368083.0, 368128.0, 48681.0, 48811.0, 48812.51187488151, 48940.26589601159, 49039.264411033866, 1135.5911871726007, 1157.5659127827064, 1171.2328424881716, 1171.84765980422, 1177.9293242405483, 25551.361215969748, 26206.86896565505, 26888.462230754885, 27366.863165684044, 27744.306392339546, 42092.579074210094, 42625.5737442634, 42666.0, 42685.35971960485, 42745.78627106844, 262809.0, 262997.0, 263228.0, 263958.0, 264002.0, 30557.23606909845, 31020.844895775375, 32683.673163269013, 36234.8188259057, 36692.08269793277, 40082.39876401915, 40117.398239027025, 40427.59572404238, 40657.0, 41028.79485602553, 34296.485552717226, 34717.0, 34878.302433951685, 35055.29889402249, 35644.82177589095, 35098.0, 35685.0, 35687.0, 36080.27839443249, 36233.81883090568, 33648.0, 34502.82748586241, 34602.30795384028, 35297.47053794144, 35431.0, 27868.16395508138, 32287.35425291434, 32357.0, 32674.83662581767, 32779.67220327766, 24309.878450607634, 24602.876985614956, 24605.753942460346, 24847.503049939263, 25032.249032529053], "value": 16998.15590930448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.85860797073207, 354.1306093540357, 370.28719714549493, 374.67964890019044, 394.74341677909354, 12844.486220551178, 14032.859671403283, 16244.675106497863, 17055.57361065974, 17169.57076073099, 15691.60770980726, 16857.24142413591, 16963.151842407893, 17097.0, 17108.144592770375, 4977.55202031817, 5230.084735171349, 5236.0, 5241.397239317489, 5245.816396426126, 3682.5396825396824, 4869.293952376903, 5241.580673546107, 5793.159991801186, 6122.448979591836, 6157.599756015845, 6189.690515474231, 6198.4731297839735, 6201.379862013808, 6212.161358216651, 5927.436893495111, 6073.1497590337385, 6128.3258841527395, 6133.386661333876, 6135.6625385603775, 5184.326037615124, 5384.488473595002, 5389.110796718537, 5393.298871146726, 5398.757055932492, 20392.490187745276, 20686.482837929023, 20701.58596828055, 20717.27489537874, 20762.896185518977, 1918.5875036867, 1924.220690620287, 1955.6773132433132, 2036.9694454583193, 2466.8775707053246, 12720.173188742701, 12828.871711282862, 12954.870451295461, 13535.458581656721, 13573.185608863401, 1634.6894090122958, 1678.8321167883237, 1714.459945117284, 1724.5171352021455, 1749.8425141737305, 53666.40769736432, 59250.40749592535, 62961.68519157421, 64072.35927640757, 64969.23992855754, 10043.899561004297, 10142.594296228215, 10204.0, 10229.74425639365, 10423.635172768916, 13744.793828092586, 13791.793123103162, 13818.378172982038, 13829.377678004514, 13837.792433113511, 6813.693383797741, 6989.231184569693, 7137.250588688113, 7380.520266182681, 7387.372073373824, 6712.39588437043, 6728.428083612947, 6737.09049278351, 6910.101686780787, 6925.515213935077, 4328.04782947751, 4363.647269346513, 4364.367166760802, 4408.360787685768, 4441.422615060022, 1821.8633602479867, 1822.2528763207022, 1835.2475485051066, 1839.0988415676222, 1864.4686264414847, 802.4663598706911, 809.753025327269, 850.1583432402001, 852.3266619370628, 901.3420203251663, 16152.434664786677, 17268.136593170544, 17408.564785880455, 17630.0, 17766.555836103944, 808.6280311056979, 810.4124509730516, 828.4863384701404, 837.6272558711315, 850.6767428377177, 9185.678501252423, 9374.484403357881, 9533.761655958657, 9748.463834489172, 9863.506824658738, 356044.0, 362935.0, 363179.0, 363567.0, 364010.0, 73955.0, 74347.62826185835, 75608.24391756122, 75937.0, 76333.23666763373, 869.1135042256863, 886.6409104312763, 904.1726819959663, 905.2079430498314, 907.0566610724904, 14966.310893805077, 14981.250937453302, 15123.16822574769, 15601.141937193563, 15758.527244182693, 34568.82715586507, 35220.82389588138, 35310.823445882605, 35756.82121589375, 37214.62785372112, 50757.492425075274, 51180.74409627928, 51929.740351298, 52021.47978520166, 53028.46971530235, 4581.244094724333, 6631.6736652670625, 7299.197088320174, 7663.846723065619, 7827.217278272355, 10038.247131465316, 11923.224990375598, 11982.64052078439, 12194.939025304817, 12473.251604903735, 9803.16673082796, 9861.260405469475, 10097.848532272168, 10295.227857910537, 10323.32898361604, 9892.071046145933, 10348.586056557955, 10432.217583681102, 10553.947230263799, 10593.682189534326, 10341.63804266847, 10413.0, 10502.52738626779, 10641.0, 10700.732481688021, 7515.286047825448, 7588.27911348421, 7609.885851712118, 7645.885311720217, 7810.062792464941, 9511.239100872051, 10105.292629515863, 10342.37945723259, 10556.524956377136, 10884.673459796219], "value": 8227.22008768838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.4717924113395, 1329.5014369611392, 1355.2139758939816, 1417.8723914847662, 1662.3018332300433, 6704.463642908568, 7492.962535187323, 7738.303552680258, 7788.454808163431, 7943.92056079439, 7798.92201077989, 7838.176991415905, 7864.685412583504, 7865.764027079197, 7866.331361834236, 2185.7377114746214, 2205.5809396214668, 2210.3810932938804, 2211.3255457085584, 2212.4468882779306, 2072.067569593681, 2126.8936553172357, 2184.5740080684272, 2184.945376365588, 2188.616992026397, 2168.6746987951774, 2185.3443966809973, 2202.3503066595395, 2202.7797220277926, 2210.690503329527, 2137.1985505435464, 2139.914403423861, 2143.5391390850887, 2145.5839146163457, 2146.602878467481, 2093.1208892265286, 2148.7099241602496, 2149.1725685611154, 2153.4508700281485, 2157.0616781699855, 7809.219078092202, 7844.803879903048, 7854.882176767296, 7856.057273127204, 7874.5668988205625, 4403.955960440387, 4591.403117594725, 4603.9769801151115, 4661.673682842203, 4668.0, 2784.317842128671, 2919.5474701421313, 2952.4833154198145, 2973.613430254075, 2978.2107741448535, 969.0890562870949, 970.257752819094, 973.776031512756, 989.3865803202061, 1012.427978192319, 10471.94764026175, 10543.630972915988, 10544.947275263574, 10545.894541054568, 10556.049955503964, 3955.4462375267485, 4087.550369459357, 4127.050778321003, 4240.91518169641, 4272.786360681954, 8891.066438024043, 9263.629454821732, 9265.629374824932, 9265.629374824932, 9270.258379329638, 4590.517995610479, 4601.194790911577, 4623.86128416148, 4625.236835922103, 4625.514320996247, 3663.2856592964117, 3760.8683696070507, 3768.6419790119894, 4201.432806571073, 4206.074663574009, 3584.8207589620415, 3673.94489082664, 3705.203381273039, 3777.225668737902, 3781.3760729479877, 1187.9821802672966, 1217.9756404871853, 1224.8407706998032, 1230.6431134970758, 1241.391718058145, 742.4728442805668, 765.6095391350451, 780.441983981456, 785.5834024401718, 808.292743849132, 4891.315215869781, 4937.654364194472, 4965.503449655005, 5035.82374616894, 5247.685138891678, 373.70290618957995, 401.3498133024519, 405.331203514198, 412.8069383320017, 419.2139737991266, 3017.336186039068, 3113.6886311369135, 3224.27453822888, 3239.3845169417737, 3269.558609587723, 9245.0, 9735.269854760922, 9740.17208537268, 9771.31600787938, 9773.706788796348, 9659.082387173208, 9700.708978730509, 9703.417794932328, 9714.465704386326, 9716.757081072888, 7221.963890180516, 7304.050473438419, 7369.22623124575, 7372.299631534996, 7391.223921488274, 4789.473157952692, 4810.4467986182035, 4827.637927155548, 4942.061008408391, 5076.898462030813, 8686.78283042929, 8827.69103081389, 8894.288456923301, 8927.419717718327, 8945.0, 7930.246626570467, 8896.199342058986, 9023.142801433853, 9076.047015063587, 9106.089391061107, 6218.502519798315, 6388.840278993062, 6432.195975503062, 6556.442702370352, 6556.868862622816, 7476.962615186889, 7489.475736698379, 7545.811354716176, 7548.433867459853, 7563.130240022248, 6519.7392104315295, 6539.378759017885, 6565.540412171103, 6718.966405167943, 6737.764178253738, 4264.275073237495, 5197.974010129925, 6447.2263328400895, 6472.838179045373, 6547.541672082908, 5952.642841429528, 5959.67221802805, 6006.909896351471, 6016.759329626766, 6024.90962635552, 4288.442502474658, 4353.216421044242, 4372.256716358163, 4414.66889983259, 4449.466064072332, 4299.376590394313, 4374.387585737935, 4436.423264975661, 4499.392582001388, 4577.633789296915], "value": 3974.4119091477455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.1400973888426, 269.4637671034642, 279.183388588379, 280.16091805043897, 282.21403391554526, 4598.632109431246, 4671.672982891199, 4738.938561725652, 4775.235962246042, 4799.856004319871, 4632.351470794091, 4702.929456058153, 4703.200455922492, 4704.670673052888, 4707.317438971347, 3442.414789485781, 3548.4854696069056, 3691.8338674759702, 3697.3159965406353, 3706.2580587124007, 3692.5938146803965, 3710.4619830124616, 3712.4616930545053, 3715.071232191952, 3728.6830619397247, 3676.7058635309113, 3679.208970071434, 3679.8528058877614, 3680.466332381803, 3685.281370132825, 3678.7057035437233, 3679.3377192105545, 3683.918585998902, 3705.888823335304, 3722.683571896392, 3161.4824884055784, 3203.7116659500757, 3226.1450715560395, 3244.967550324514, 3261.575995120643, 4628.791704373311, 4630.050839577879, 4630.421197350332, 4630.791614377327, 4647.326137710047, 4159.9376009359885, 4170.416141740159, 4170.895727606834, 4178.1643671265865, 4179.247735407625, 4741.620670346399, 4938.580220681247, 4939.58013568847, 4943.505649435064, 4954.529319714621, 3399.7280217582534, 3425.451927691582, 3432.673895979878, 3433.1588760753525, 3437.1750779812915, 5173.844784656466, 5186.055229289017, 5194.740262986873, 5217.713025783581, 5218.634695571312, 3389.8135602542097, 3462.671046250602, 3468.6531346865113, 3477.913052173665, 3488.7963652539834, 3507.193345530542, 3516.261585067113, 3517.0152357339985, 3522.661388672288, 3523.1896663767475, 4085.3259212230246, 4088.6729061674996, 4094.3244364679495, 4106.486689163855, 4112.979435102805, 4653.255479123324, 4693.0, 4946.777395017233, 4949.34761324354, 4958.157113290749, 1184.1888306510068, 1201.6575276046285, 1202.1765090912752, 1204.6085022367765, 1207.776561336138, 735.0481126940518, 756.9848603027908, 771.4291424345944, 771.7800426878425, 773.3542492019114, 3931.3709806430834, 3944.5069366329208, 3948.7364043505804, 3959.524857017119, 4009.6391324780325, 4542.0, 4563.657725670588, 4574.513283182979, 4576.4508259009135, 4577.267637178035, 3994.9014021143835, 3996.900077498086, 3998.7400818946676, 4001.1797581495725, 4010.47863777707, 2333.241696448661, 2334.9299521014395, 2407.831451798357, 2412.8672922989404, 2450.2159309020944, 4282.250606143913, 4290.227759003347, 4298.4412026436985, 4311.814251080978, 4320.546342634041, 4641.280601506772, 4646.442426908792, 4647.953520464752, 4655.208614535537, 4664.930026049612, 4293.892652683708, 4294.871153865389, 4298.570142985676, 4425.822967081345, 4811.4362832080415, 5186.4035635902355, 5188.922166167435, 5199.168133098686, 5201.453847346125, 5206.193040078794, 5094.719790411563, 5096.617753668564, 5097.337346144977, 5097.898042039064, 5105.0, 4618.676692631483, 4785.9042819144115, 4789.658895509263, 4844.660873738804, 4858.6356023297685, 3480.9477857832658, 3485.1461391959133, 3485.1809824691686, 3498.5451891253974, 3516.487910198639, 4911.4106307243355, 5079.72061536619, 5105.668131571436, 5107.821226257063, 5126.871828204325, 4834.371531700856, 4958.8760280993265, 4970.676906001098, 4979.278004689228, 4988.802687355082, 4972.65191436596, 4973.751312434436, 4974.129527332775, 4974.433053588108, 5018.949810501995, 4793.113274044313, 4914.631402644744, 4918.901621967612, 4943.728094954812, 4951.8266860659705, 5003.424606170337, 5006.674566153334, 5015.464097810962, 5043.621728370314, 5057.519535644108, 4868.756562171807, 4889.559939605452, 4889.608831293559, 4893.7797799099835, 4903.0], "value": 3624.913351683288, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.6572386601573, 613.4356392119253, 621.2296752027486, 721.6067243352372, 737.3621817128184, 13388.7322253555, 14396.856031439682, 14416.855831441682, 14418.13491190528, 14427.711445771078, 12046.939765301184, 12081.395930203498, 12088.69778255544, 12102.636920892366, 12141.696457588565, 590.4862769390614, 712.1632082303299, 716.147784136878, 730.9561426314411, 732.5458215906145, 728.890666400039, 731.2687312687312, 731.5756861020595, 731.6634348199834, 731.9451041171933, 780.7033327335633, 780.7813812132612, 780.8711562592165, 781.7420251317052, 782.0185666987923, 621.8321053315625, 747.7532414303321, 766.9923300767033, 768.078306032763, 778.5756762564416, 561.9859503512445, 561.9887602247932, 562.0838034004587, 562.4122791682702, 564.5145175149369, 12804.295763732991, 13015.479380824756, 13028.153170044012, 13037.348132593428, 13044.217346959118, 11990.460429280703, 12377.93811030948, 12645.241285522807, 12731.363431828464, 12979.610611681665, 11806.232594881305, 11884.940575297154, 12100.939495302555, 12156.696082597917, 12472.314022728746, 4112.321466957948, 4113.341865301567, 4148.958510414887, 4339.305711086211, 4344.522102568747, 64694.35305646931, 64927.350726493074, 65046.02430963587, 65205.34794652087, 65417.345826541605, 10020.549075291628, 10032.799344013225, 10327.173826093895, 10341.224408169417, 10727.141828653688, 18523.629527409375, 18526.351577694717, 18539.165737541844, 18542.629147417247, 18569.44291671252, 6810.148731408574, 6878.312168783182, 7008.7546935857, 7183.604901730455, 7192.0, 3661.9816900915325, 3689.6863766579604, 3704.351738445815, 3714.0714821294678, 3772.4529943158636, 2630.092618046771, 2741.4928238275984, 2745.0666773297175, 2749.958750618742, 2755.1734479656425, 471.83014114918603, 478.33511419126745, 479.82486392467194, 488.8606747077066, 495.2571143285072, 376.69475268195833, 433.43436814956783, 449.42024788023735, 462.3365470549772, 497.1374664956298, 6602.405783479414, 6770.932290677129, 6835.179778426521, 6854.931450685429, 6937.236903940562, 454.52956190343497, 472.47319239048903, 473.78679594182756, 478.1226449465201, 480.46428232520486, 3328.0, 3344.448166052574, 3525.8765943191866, 3588.2285308658766, 3673.0, 75767.62116189495, 79131.60434197792, 79153.60423197963, 88313.0, 105652.0, 75521.0, 76812.61593692108, 77506.22493775103, 78436.6078169617, 78504.28974261563, 45825.0, 66379.66810165918, 69044.30955690479, 71737.0, 72251.27748722445, 7556.811079723051, 7577.431692623186, 7854.253845884632, 8004.639791209293, 8063.637136328762, 42227.55448910169, 42767.0, 43881.0, 44287.55712442963, 45096.0, 54622.0, 60912.69543652253, 61303.693481532304, 61323.38676613177, 63019.6849015752, 11143.888561114609, 11213.159013074215, 11368.488418021043, 11476.655700329004, 11990.520379184734, 11305.886941130813, 11445.828312575484, 11606.709832253924, 11781.175317727677, 11813.940930295294, 10993.395363254778, 11418.200725949104, 11521.366324852213, 11910.0, 11924.76150477003, 11078.723031924266, 11423.371714555778, 11981.221220620631, 11987.76024479523, 12013.219140755822, 11433.1996760226, 12165.817512737493, 12495.58525799505, 12573.371331433575, 12606.180598261451, 9353.692404168656, 9739.513024348897, 9977.501124943868, 10352.171826254033, 10383.376997380181, 9420.62317507292, 9499.335046546952, 9686.9031309686, 9785.266105042008, 9915.30592858493], "value": 6306.3965741921675, "unit": "score"}], "name": "dromaeo_css", "value": 6232.148842049557, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 132.0, 114.0, 116.0, 115.0, 115.0, 116.0, 113.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 148.0, 190.0, 124.0, 164.0, 150.0, 130.0, 182.0, 122.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 167.0, 76.0, 76.0, 76.0, 76.0, 153.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 136.0, 83.0, 83.0, 83.0, 148.0, 83.0, 83.0, 128.0], "value": 99.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 70.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 90.0, 82.0, 80.0, 82.0, 85.0, 82.0, 83.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 142.0, 136.0, 138.0, 142.0, 133.0, 140.0, 172.0, 133.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 169.0, 170.0, 171.0, 170.0, 170.0, 172.0, 171.0, 174.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 69.0, 68.0, 68.0, 68.0, 68.0, 70.0, 68.0, 67.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1572.9, "alertThreshold": 2.0}]} 22:09:18 INFO - Return code: 0 22:09:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:09:19 INFO - # TBPL SUCCESS # 22:09:19 INFO - Running post-action listener: _resource_record_post_action 22:09:19 INFO - [mozharness: 2016-08-30 05:09:19.039861Z] Finished run-tests step (success) 22:09:19 INFO - Running post-run listener: _resource_record_post_run 22:09:19 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407998464; Read time: 28; Write time: 309664 22:09:19 INFO - TinderboxPrint: CPU usage
13.0% 22:09:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 22:09:19 INFO - TinderboxPrint: I/O write bytes / time
407,998,464 / 309,664 22:09:19 INFO - TinderboxPrint: CPU idle
8,345.6 (86.9%) 22:09:19 INFO - TinderboxPrint: CPU user
1,203.5 (12.5%) 22:09:19 INFO - TinderboxPrint: Swap in / out
0 / 0 22:09:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114479104; Read time: 0; Write time: 116032 22:09:19 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293519360; Read time: 16; Write time: 193632 22:09:19 INFO - Running post-run listener: _upload_blobber_files 22:09:19 INFO - Blob upload gear active. 22:09:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:09:19 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 22:09:19 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'] 22:09:19 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 22:09:20 INFO - (blobuploader) - INFO - Open directory for files ... 22:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:09:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:20 INFO - (blobuploader) - INFO - Done attempting. 22:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:09:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:25 INFO - (blobuploader) - INFO - Done attempting. 22:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:09:26 INFO - (blobuploader) - INFO - Done attempting. 22:09:26 INFO - (blobuploader) - INFO - Iteration through files over. 22:09:26 INFO - Return code: 0 22:09:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:09:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:09:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6aa24afe3a773493593e73c016072b524bfb9c0c6560d570c330b91132924b5d10ff5928a20931fd95c32a22ab632a57ecdce91d8e700738acf61a25a2a6fea6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80b7021162e098085771f5f9caccdda18bc10d451bead6f11625291ebca70829afe6b7cd7cb6ec2512be63038d57b6245a3c6b7f9033d5aed6aefb59ccfdf6d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9a26c6afbc2abe1cd828c7258dbd7cb839e7735e35f3107e2a0c7f030b27e9c5cee023d1df88f6139e8a4f094844ac8903da7ae80372ead1cc4de3d7ba24a6d7"} 22:09:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:09:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:09:26 INFO - Contents: 22:09:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6aa24afe3a773493593e73c016072b524bfb9c0c6560d570c330b91132924b5d10ff5928a20931fd95c32a22ab632a57ecdce91d8e700738acf61a25a2a6fea6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80b7021162e098085771f5f9caccdda18bc10d451bead6f11625291ebca70829afe6b7cd7cb6ec2512be63038d57b6245a3c6b7f9033d5aed6aefb59ccfdf6d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9a26c6afbc2abe1cd828c7258dbd7cb839e7735e35f3107e2a0c7f030b27e9c5cee023d1df88f6139e8a4f094844ac8903da7ae80372ead1cc4de3d7ba24a6d7"} 22:09:26 INFO - Running post-run listener: copy_logs_to_upload_dir 22:09:26 INFO - Copying logs to upload dir... 22:09:26 INFO - mkdir: /builds/slave/test/build/upload/logs 22:09:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.164488 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-29 22:09:25.720437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 22:09:25.724045) ========= 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=920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869 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/6aa24afe3a773493593e73c016072b524bfb9c0c6560d570c330b91132924b5d10ff5928a20931fd95c32a22ab632a57ecdce91d8e700738acf61a25a2a6fea6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80b7021162e098085771f5f9caccdda18bc10d451bead6f11625291ebca70829afe6b7cd7cb6ec2512be63038d57b6245a3c6b7f9033d5aed6aefb59ccfdf6d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9a26c6afbc2abe1cd828c7258dbd7cb839e7735e35f3107e2a0c7f030b27e9c5cee023d1df88f6139e8a4f094844ac8903da7ae80372ead1cc4de3d7ba24a6d7"} build_url:https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/Z_zUaHLXRZG593i64K3q0Q/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/6aa24afe3a773493593e73c016072b524bfb9c0c6560d570c330b91132924b5d10ff5928a20931fd95c32a22ab632a57ecdce91d8e700738acf61a25a2a6fea6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80b7021162e098085771f5f9caccdda18bc10d451bead6f11625291ebca70829afe6b7cd7cb6ec2512be63038d57b6245a3c6b7f9033d5aed6aefb59ccfdf6d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9a26c6afbc2abe1cd828c7258dbd7cb839e7735e35f3107e2a0c7f030b27e9c5cee023d1df88f6139e8a4f094844ac8903da7ae80372ead1cc4de3d7ba24a6d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 22:09:25.752342) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 22:09:25.753082) ========= 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=920470bf432669ad7e3a5387000001ca-1472532022.742497-1483830869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 22:09:25.838721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 22:09:25.839402) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 22:09:25.840115) ========= ========= Total master_lag: 0.19 =========