builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1474654804.69 results: success (0) buildid: 20160923094624 builduid: 69aaccf3cbba451f8082e030b2a3c9a8 revision: a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:04.694030) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:04.694562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:04.694898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:04.709851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:04.710191) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 11:20:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-09-23 11:20:05 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.349211 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.073838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.074220) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.124450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.124886) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5 --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 a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5 --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=9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 11:20:05,675 truncating revision to first 12 chars 2016-09-23 11:20:05,676 Setting DEBUG logging. 2016-09-23 11:20:05,676 attempt 1/10 2016-09-23 11:20:05,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a33dcaa0f804?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 11:20:05,978 unpacking tar archive at: autoland-a33dcaa0f804/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.806776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.807132) ========= script_repo_revision: a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.807638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.807952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:20:05.818015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-23 11:20:05.818364) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:06 INFO - MultiFileLogger online at 20160923 11:20:06 in /builds/slave/test 11:20:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:20:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:06 INFO - {'append_to_log': False, 11:20:06 INFO - 'base_work_dir': '/builds/slave/test', 11:20:06 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:20:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:06 INFO - 'branch': 'Autoland-Non-PGO', 11:20:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:06 INFO - 'config_files': ('talos/linux_config.py',), 11:20:06 INFO - 'default_actions': ('clobber', 11:20:06 INFO - 'read-buildbot-config', 11:20:06 INFO - 'download-and-extract', 11:20:06 INFO - 'populate-webroot', 11:20:06 INFO - 'create-virtualenv', 11:20:06 INFO - 'install', 11:20:06 INFO - 'run-tests'), 11:20:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:06 INFO - 'download_minidump_stackwalk': True, 11:20:06 INFO - 'download_symbols': 'ondemand', 11:20:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:06 INFO - 'installer_path': 'installer.exe', 11:20:06 INFO - 'log_level': 'info', 11:20:06 INFO - 'log_name': 'talos', 11:20:06 INFO - 'log_to_console': True, 11:20:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:06 INFO - 'opt_config_files': (), 11:20:06 INFO - 'pip_index': False, 11:20:06 INFO - 'sps_profile': False, 11:20:06 INFO - 'sps_profile_interval': 0, 11:20:06 INFO - 'suite': 'dromaeojs', 11:20:06 INFO - 'system_bits': '32', 11:20:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:06 INFO - 'title': 'talos-linux64-ix-040', 11:20:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:06 INFO - 'use_talos_json': True, 11:20:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:06 INFO - 'work_dir': 'build'} 11:20:06 INFO - [mozharness: 2016-09-23 18:20:06.466643Z] Running clobber step. 11:20:06 INFO - Running pre-action listener: _resource_record_pre_action 11:20:06 INFO - Running main action method: clobber 11:20:06 INFO - rmtree: /builds/slave/test/build 11:20:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:07 INFO - Running post-action listener: _resource_record_post_action 11:20:07 INFO - [mozharness: 2016-09-23 18:20:07.435089Z] Finished clobber step (success) 11:20:07 INFO - [mozharness: 2016-09-23 18:20:07.435191Z] Running read-buildbot-config step. 11:20:07 INFO - Running pre-action listener: _resource_record_pre_action 11:20:07 INFO - Running main action method: read_buildbot_config 11:20:07 INFO - Using buildbot properties: 11:20:07 INFO - { 11:20:07 INFO - "project": "", 11:20:07 INFO - "product": "firefox", 11:20:07 INFO - "script_repo_revision": "production", 11:20:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:20:07 INFO - "repository": "", 11:20:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:20:07 INFO - "buildid": "20160923094624", 11:20:07 INFO - "pgo_build": "False", 11:20:07 INFO - "basedir": "/builds/slave/test", 11:20:07 INFO - "buildnumber": 512, 11:20:07 INFO - "slavename": "talos-linux64-ix-040", 11:20:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:20:07 INFO - "platform": "ubuntu64_hw", 11:20:07 INFO - "scheduler": "tests-autoland-linux64-talos", 11:20:07 INFO - "branch": "autoland", 11:20:07 INFO - "repo_path": "integration/autoland", 11:20:07 INFO - "revision": "a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5", 11:20:07 INFO - "stage_platform": "linux64", 11:20:07 INFO - "builduid": "69aaccf3cbba451f8082e030b2a3c9a8", 11:20:07 INFO - "slavebuilddir": "test" 11:20:07 INFO - } 11:20:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:20:07 INFO - Running post-action listener: _resource_record_post_action 11:20:07 INFO - [mozharness: 2016-09-23 18:20:07.437640Z] Finished read-buildbot-config step (success) 11:20:07 INFO - [mozharness: 2016-09-23 18:20:07.437730Z] Running download-and-extract step. 11:20:07 INFO - Running pre-action listener: _resource_record_pre_action 11:20:07 INFO - Running main action method: download_and_extract 11:20:07 INFO - mkdir: /builds/slave/test/build/tests 11:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:07 INFO - trying https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:20:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:20:07 INFO - Downloaded 1361 bytes. 11:20:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:20:07 INFO - Using the following test package requirements: 11:20:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:20:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:07 INFO - u'jsshell-linux-x86_64.zip'], 11:20:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:20:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:20:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:20:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:20:08 INFO - Expected file size: 20377419 11:20:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:20:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:20:13 INFO - Expected file size: 20377419 11:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:20:18 INFO - Expected file size: 14414059 11:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:19 INFO - trying https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:20:20 INFO - Downloaded 55730461 bytes. 11:20:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:20 INFO - mkdir: /builds/slave/test/properties 11:20:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:20 INFO - Contents: 11:20:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:20 INFO - Running post-action listener: _resource_record_post_action 11:20:20 INFO - Running post-action listener: set_extra_try_arguments 11:20:20 INFO - [mozharness: 2016-09-23 18:20:20.839824Z] Finished download-and-extract step (success) 11:20:20 INFO - [mozharness: 2016-09-23 18:20:20.840054Z] Running populate-webroot step. 11:20:20 INFO - Running pre-action listener: _resource_record_pre_action 11:20:20 INFO - Running main action method: populate_webroot 11:20:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:20 INFO - '--tppagecycles', 11:20:20 INFO - '7'], 11:20:20 INFO - 'tests': ['tsvgm']}}, 11:20:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['damp', 'tps']}, 11:20:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'tests': ['damp', 'tps']}, 11:20:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['dromaeo_dom']}, 11:20:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['basic_compositor_video']}, 11:20:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:20:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['a11yr', 11:20:20 INFO - 'ts_paint', 11:20:20 INFO - 'tpaint', 11:20:20 INFO - 'sessionrestore', 11:20:20 INFO - 'sessionrestore_no_auto_restore', 11:20:20 INFO - 'tabpaint']}, 11:20:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:20 INFO - 'ts_paint', 11:20:20 INFO - 'tpaint', 11:20:20 INFO - 'sessionrestore', 11:20:20 INFO - 'sessionrestore_no_auto_restore', 11:20:20 INFO - 'tabpaint']}, 11:20:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:20 INFO - 'ts_paint', 11:20:20 INFO - 'tpaint', 11:20:20 INFO - 'sessionrestore', 11:20:20 INFO - 'sessionrestore_no_auto_restore', 11:20:20 INFO - 'tabpaint']}, 11:20:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:20 INFO - 'ts_paint', 11:20:20 INFO - 'tpaint', 11:20:20 INFO - 'sessionrestore', 11:20:20 INFO - 'sessionrestore_no_auto_restore', 11:20:20 INFO - 'tabpaint']}, 11:20:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['a11yr', 11:20:20 INFO - 'ts_paint', 11:20:20 INFO - 'tpaint', 11:20:20 INFO - 'sessionrestore', 11:20:20 INFO - 'sessionrestore_no_auto_restore', 11:20:20 INFO - 'tabpaint']}, 11:20:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['a11yr', 11:20:20 INFO - 'ts_paint', 11:20:20 INFO - 'tpaint', 11:20:20 INFO - 'sessionrestore', 11:20:20 INFO - 'sessionrestore_no_auto_restore', 11:20:20 INFO - 'tabpaint']}, 11:20:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['tsvgx', 11:20:20 INFO - 'tsvgr_opacity', 11:20:20 INFO - 'tart', 11:20:20 INFO - 'tscrollx', 11:20:20 INFO - 'cart']}, 11:20:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:20 INFO - 'tsvgr_opacity', 11:20:20 INFO - 'tart', 11:20:20 INFO - 'tscrollx', 11:20:20 INFO - 'cart']}, 11:20:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'talos_options': ['--disable-e10s'], 11:20:20 INFO - 'tests': ['tp5o']}, 11:20:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'tests': ['tp5o']}, 11:20:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'talos_options': ['--disable-e10s', 11:20:20 INFO - '--xperf_path', 11:20:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:20 INFO - 'tests': ['tp5n']}, 11:20:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:20 INFO - 'talos_options': ['--xperf_path', 11:20:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:20 INFO - 'tests': ['tp5n']}}, 11:20:20 INFO - 'talos.zip': {'path': '', 11:20:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:20 INFO - Running post-action listener: _resource_record_post_action 11:20:20 INFO - [mozharness: 2016-09-23 18:20:20.855693Z] Finished populate-webroot step (success) 11:20:20 INFO - [mozharness: 2016-09-23 18:20:20.855784Z] Running create-virtualenv step. 11:20:20 INFO - Running pre-action listener: _resource_record_pre_action 11:20:20 INFO - Running main action method: create_virtualenv 11:20:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:20 INFO - Using real prefix '/usr' 11:20:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:23 INFO - Installing pip.................done. 11:20:23 INFO - Return code: 0 11:20:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:23 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:23 INFO - Using env: {'DISPLAY': ':0', 11:20:23 INFO - 'HOME': '/home/cltbld', 11:20:23 INFO - 'LANG': 'en_US.UTF-8', 11:20:23 INFO - 'LANGUAGE': 'en_US:en', 11:20:23 INFO - 'LOGNAME': 'cltbld', 11:20:23 INFO - 'MAIL': '/var/mail/cltbld', 11:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:23 INFO - 'MOZ_NO_REMOTE': '1', 11:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:23 INFO - 'NO_EM_RESTART': '1', 11:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:23 INFO - 'PWD': '/builds/slave/test', 11:20:23 INFO - 'SHELL': '/bin/bash', 11:20:23 INFO - 'SHLVL': '1', 11:20:23 INFO - 'TERM': 'linux', 11:20:23 INFO - 'TMOUT': '86400', 11:20:23 INFO - 'USER': 'cltbld', 11:20:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:23 INFO - '_': '/tools/buildbot/bin/python'} 11:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:20:23 INFO - Cleaning up... 11:20:23 INFO - Return code: 0 11:20:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:23 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:23 INFO - Using env: {'DISPLAY': ':0', 11:20:23 INFO - 'HOME': '/home/cltbld', 11:20:23 INFO - 'LANG': 'en_US.UTF-8', 11:20:23 INFO - 'LANGUAGE': 'en_US:en', 11:20:23 INFO - 'LOGNAME': 'cltbld', 11:20:23 INFO - 'MAIL': '/var/mail/cltbld', 11:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:23 INFO - 'MOZ_NO_REMOTE': '1', 11:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:23 INFO - 'NO_EM_RESTART': '1', 11:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:23 INFO - 'PWD': '/builds/slave/test', 11:20:23 INFO - 'SHELL': '/bin/bash', 11:20:23 INFO - 'SHLVL': '1', 11:20:23 INFO - 'TERM': 'linux', 11:20:23 INFO - 'TMOUT': '86400', 11:20:23 INFO - 'USER': 'cltbld', 11:20:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:23 INFO - '_': '/tools/buildbot/bin/python'} 11:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:23 INFO - Downloading/unpacking psutil>=3.1.1 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:26 INFO - Installing collected packages: psutil 11:20:26 INFO - Running setup.py install for psutil 11:20:26 INFO - building 'psutil._psutil_linux' extension 11:20:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:27 INFO - building 'psutil._psutil_posix' extension 11:20:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:27 INFO - Successfully installed psutil 11:20:27 INFO - Cleaning up... 11:20:27 INFO - Return code: 0 11:20:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:27 INFO - Using env: {'DISPLAY': ':0', 11:20:27 INFO - 'HOME': '/home/cltbld', 11:20:27 INFO - 'LANG': 'en_US.UTF-8', 11:20:27 INFO - 'LANGUAGE': 'en_US:en', 11:20:27 INFO - 'LOGNAME': 'cltbld', 11:20:27 INFO - 'MAIL': '/var/mail/cltbld', 11:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:27 INFO - 'MOZ_NO_REMOTE': '1', 11:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:27 INFO - 'NO_EM_RESTART': '1', 11:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:27 INFO - 'PWD': '/builds/slave/test', 11:20:27 INFO - 'SHELL': '/bin/bash', 11:20:27 INFO - 'SHLVL': '1', 11:20:27 INFO - 'TERM': 'linux', 11:20:27 INFO - 'TMOUT': '86400', 11:20:27 INFO - 'USER': 'cltbld', 11:20:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:27 INFO - '_': '/tools/buildbot/bin/python'} 11:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:29 INFO - Installing collected packages: mozsystemmonitor 11:20:29 INFO - Running setup.py install for mozsystemmonitor 11:20:29 INFO - Successfully installed mozsystemmonitor 11:20:29 INFO - Cleaning up... 11:20:29 INFO - Return code: 0 11:20:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:29 INFO - Using env: {'DISPLAY': ':0', 11:20:29 INFO - 'HOME': '/home/cltbld', 11:20:29 INFO - 'LANG': 'en_US.UTF-8', 11:20:29 INFO - 'LANGUAGE': 'en_US:en', 11:20:29 INFO - 'LOGNAME': 'cltbld', 11:20:29 INFO - 'MAIL': '/var/mail/cltbld', 11:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:29 INFO - 'MOZ_NO_REMOTE': '1', 11:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:29 INFO - 'NO_EM_RESTART': '1', 11:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:29 INFO - 'PWD': '/builds/slave/test', 11:20:29 INFO - 'SHELL': '/bin/bash', 11:20:29 INFO - 'SHLVL': '1', 11:20:29 INFO - 'TERM': 'linux', 11:20:29 INFO - 'TMOUT': '86400', 11:20:29 INFO - 'USER': 'cltbld', 11:20:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:29 INFO - '_': '/tools/buildbot/bin/python'} 11:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:29 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:32 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:32 INFO - warning: no files found matching '*.txt' 11:20:32 INFO - no previously-included directories found matching 'build' 11:20:32 INFO - no previously-included directories found matching 'dist' 11:20:32 INFO - no previously-included directories found matching '.git*' 11:20:32 INFO - Installing collected packages: jsonschema, functools32 11:20:32 INFO - Running setup.py install for functools32 11:20:32 INFO - warning: no files found matching '*.txt' 11:20:32 INFO - no previously-included directories found matching 'build' 11:20:32 INFO - no previously-included directories found matching 'dist' 11:20:32 INFO - no previously-included directories found matching '.git*' 11:20:32 INFO - Successfully installed jsonschema functools32 11:20:32 INFO - Cleaning up... 11:20:32 INFO - Return code: 0 11:20:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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')]} 11:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:32 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:20:32 INFO - Using env: {'DISPLAY': ':0', 11:20:32 INFO - 'HOME': '/home/cltbld', 11:20:32 INFO - 'LANG': 'en_US.UTF-8', 11:20:32 INFO - 'LANGUAGE': 'en_US:en', 11:20:32 INFO - 'LOGNAME': 'cltbld', 11:20:32 INFO - 'MAIL': '/var/mail/cltbld', 11:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:32 INFO - 'MOZ_NO_REMOTE': '1', 11:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:32 INFO - 'NO_EM_RESTART': '1', 11:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:32 INFO - 'PWD': '/builds/slave/test', 11:20:32 INFO - 'SHELL': '/bin/bash', 11:20:32 INFO - 'SHLVL': '1', 11:20:32 INFO - 'TERM': 'linux', 11:20:32 INFO - 'TMOUT': '86400', 11:20:32 INFO - 'USER': 'cltbld', 11:20:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:32 INFO - '_': '/tools/buildbot/bin/python'} 11:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:32 INFO - Cleaning up... 11:20:32 INFO - Return code: 0 11:20:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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')]} 11:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:32 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:20:32 INFO - Using env: {'DISPLAY': ':0', 11:20:32 INFO - 'HOME': '/home/cltbld', 11:20:32 INFO - 'LANG': 'en_US.UTF-8', 11:20:32 INFO - 'LANGUAGE': 'en_US:en', 11:20:32 INFO - 'LOGNAME': 'cltbld', 11:20:32 INFO - 'MAIL': '/var/mail/cltbld', 11:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:32 INFO - 'MOZ_NO_REMOTE': '1', 11:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:32 INFO - 'NO_EM_RESTART': '1', 11:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:32 INFO - 'PWD': '/builds/slave/test', 11:20:32 INFO - 'SHELL': '/bin/bash', 11:20:32 INFO - 'SHLVL': '1', 11:20:32 INFO - 'TERM': 'linux', 11:20:32 INFO - 'TMOUT': '86400', 11:20:32 INFO - 'USER': 'cltbld', 11:20:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:32 INFO - '_': '/tools/buildbot/bin/python'} 11:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:32 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:35 INFO - Downloading docopt-0.6.1.tar.gz 11:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:35 INFO - Running setup.py install for blobuploader 11:20:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:35 INFO - Running setup.py install for requests 11:20:35 INFO - Running setup.py install for docopt 11:20:35 INFO - Successfully installed blobuploader requests docopt 11:20:36 INFO - Cleaning up... 11:20:36 INFO - Return code: 0 11:20:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:36 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:36 INFO - Using env: {'DISPLAY': ':0', 11:20:36 INFO - 'HOME': '/home/cltbld', 11:20:36 INFO - 'LANG': 'en_US.UTF-8', 11:20:36 INFO - 'LANGUAGE': 'en_US:en', 11:20:36 INFO - 'LOGNAME': 'cltbld', 11:20:36 INFO - 'MAIL': '/var/mail/cltbld', 11:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:36 INFO - 'MOZ_NO_REMOTE': '1', 11:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:36 INFO - 'NO_EM_RESTART': '1', 11:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:36 INFO - 'PWD': '/builds/slave/test', 11:20:36 INFO - 'SHELL': '/bin/bash', 11:20:36 INFO - 'SHLVL': '1', 11:20:36 INFO - 'TERM': 'linux', 11:20:36 INFO - 'TMOUT': '86400', 11:20:36 INFO - 'USER': 'cltbld', 11:20:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:36 INFO - '_': '/tools/buildbot/bin/python'} 11:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:36 INFO - Running setup.py (path:/tmp/pip-f5olcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:36 INFO - Running setup.py (path:/tmp/pip-2HFMdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:36 INFO - Running setup.py (path:/tmp/pip-eckaUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:36 INFO - Running setup.py (path:/tmp/pip-NTu6BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:36 INFO - Running setup.py (path:/tmp/pip-ZHnw8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:36 INFO - Running setup.py (path:/tmp/pip-AaAgJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:36 INFO - Running setup.py (path:/tmp/pip-dJ_yNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:36 INFO - Running setup.py (path:/tmp/pip-PQEO2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:36 INFO - Running setup.py (path:/tmp/pip-KAOkzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:36 INFO - Running setup.py (path:/tmp/pip-8fMk79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:36 INFO - Running setup.py (path:/tmp/pip-GITyWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:37 INFO - Running setup.py (path:/tmp/pip-3nr1Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:37 INFO - Running setup.py (path:/tmp/pip-Q0bR0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:37 INFO - Running setup.py (path:/tmp/pip-aCw3dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:37 INFO - Running setup.py (path:/tmp/pip-rtKe4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:37 INFO - Running setup.py (path:/tmp/pip-68kJ2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:37 INFO - Running setup.py (path:/tmp/pip-fc20Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:37 INFO - Running setup.py install for manifestparser 11:20:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Running setup.py install for mozcrash 11:20:37 INFO - Running setup.py install for mozdebug 11:20:37 INFO - Running setup.py install for mozdevice 11:20:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for mozfile 11:20:38 INFO - Running setup.py install for mozhttpd 11:20:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for mozinfo 11:20:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for mozInstall 11:20:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for mozleak 11:20:38 INFO - Running setup.py install for mozlog 11:20:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for moznetwork 11:20:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for mozprocess 11:20:38 INFO - Running setup.py install for mozprofile 11:20:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:38 INFO - Running setup.py install for mozrunner 11:20:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:39 INFO - Running setup.py install for mozscreenshot 11:20:39 INFO - Running setup.py install for moztest 11:20:39 INFO - Running setup.py install for mozversion 11:20:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:39 INFO - Cleaning up... 11:20:39 INFO - Return code: 0 11:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:39 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:39 INFO - Using env: {'DISPLAY': ':0', 11:20:39 INFO - 'HOME': '/home/cltbld', 11:20:39 INFO - 'LANG': 'en_US.UTF-8', 11:20:39 INFO - 'LANGUAGE': 'en_US:en', 11:20:39 INFO - 'LOGNAME': 'cltbld', 11:20:39 INFO - 'MAIL': '/var/mail/cltbld', 11:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:39 INFO - 'MOZ_NO_REMOTE': '1', 11:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:39 INFO - 'NO_EM_RESTART': '1', 11:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:39 INFO - 'PWD': '/builds/slave/test', 11:20:39 INFO - 'SHELL': '/bin/bash', 11:20:39 INFO - 'SHLVL': '1', 11:20:39 INFO - 'TERM': 'linux', 11:20:39 INFO - 'TMOUT': '86400', 11:20:39 INFO - 'USER': 'cltbld', 11:20:39 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:39 INFO - '_': '/tools/buildbot/bin/python'} 11:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:39 INFO - Running setup.py (path:/tmp/pip-t4MVGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:39 INFO - Running setup.py (path:/tmp/pip-DCuawJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:39 INFO - Running setup.py (path:/tmp/pip-iMb93v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:39 INFO - Running setup.py (path:/tmp/pip-LCzVwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:39 INFO - Running setup.py (path:/tmp/pip-9RivQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:40 INFO - Running setup.py (path:/tmp/pip-v1QsUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:40 INFO - Running setup.py (path:/tmp/pip-M3YDsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:40 INFO - Running setup.py (path:/tmp/pip-oE7Wzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:40 INFO - Running setup.py (path:/tmp/pip-gnf1tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:40 INFO - Running setup.py (path:/tmp/pip-a9qjbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:40 INFO - Running setup.py (path:/tmp/pip-uoDCGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:40 INFO - Running setup.py (path:/tmp/pip-FgkH4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:40 INFO - Running setup.py (path:/tmp/pip-3DDxUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:40 INFO - Running setup.py (path:/tmp/pip-BnAyV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:40 INFO - Running setup.py (path:/tmp/pip-sHL5DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:40 INFO - Running setup.py (path:/tmp/pip-TGQKqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:40 INFO - Running setup.py (path:/tmp/pip-650QSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:20:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:42 INFO - Downloading blessings-1.6.tar.gz 11:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:42 INFO - Installing collected packages: blessings 11:20:42 INFO - Running setup.py install for blessings 11:20:42 INFO - Successfully installed blessings 11:20:42 INFO - Cleaning up... 11:20:43 INFO - Return code: 0 11:20:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:43 INFO - Reading from file tmpfile_stdout 11:20:43 INFO - Current package versions: 11:20:43 INFO - argparse == 1.2.1 11:20:43 INFO - blessings == 1.6 11:20:43 INFO - blobuploader == 1.2.4 11:20:43 INFO - docopt == 0.6.1 11:20:43 INFO - functools32 == 3.2.3-2 11:20:43 INFO - jsonschema == 2.5.1 11:20:43 INFO - manifestparser == 1.1 11:20:43 INFO - mozInstall == 1.12 11:20:43 INFO - mozcrash == 0.17 11:20:43 INFO - mozdebug == 0.1 11:20:43 INFO - mozdevice == 0.48 11:20:43 INFO - mozfile == 1.2 11:20:43 INFO - mozhttpd == 0.7 11:20:43 INFO - mozinfo == 0.9 11:20:43 INFO - mozleak == 0.1 11:20:43 INFO - mozlog == 3.4 11:20:43 INFO - moznetwork == 0.27 11:20:43 INFO - mozprocess == 0.23 11:20:43 INFO - mozprofile == 0.28 11:20:43 INFO - mozrunner == 6.12 11:20:43 INFO - mozscreenshot == 0.1 11:20:43 INFO - mozsystemmonitor == 0.3 11:20:43 INFO - moztest == 0.7 11:20:43 INFO - mozversion == 1.4 11:20:43 INFO - psutil == 3.1.1 11:20:43 INFO - requests == 1.2.3 11:20:43 INFO - wsgiref == 0.1.2 11:20:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 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 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:43 INFO - Using env: {'DISPLAY': ':0', 11:20:43 INFO - 'HOME': '/home/cltbld', 11:20:43 INFO - 'LANG': 'en_US.UTF-8', 11:20:43 INFO - 'LANGUAGE': 'en_US:en', 11:20:43 INFO - 'LOGNAME': 'cltbld', 11:20:43 INFO - 'MAIL': '/var/mail/cltbld', 11:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:43 INFO - 'MOZ_NO_REMOTE': '1', 11:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:43 INFO - 'NO_EM_RESTART': '1', 11:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:43 INFO - 'PWD': '/builds/slave/test', 11:20:43 INFO - 'SHELL': '/bin/bash', 11:20:43 INFO - 'SHLVL': '1', 11:20:43 INFO - 'TERM': 'linux', 11:20:43 INFO - 'TMOUT': '86400', 11:20:43 INFO - 'USER': 'cltbld', 11:20:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:43 INFO - '_': '/tools/buildbot/bin/python'} 11:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:20:43 INFO - Cleaning up... 11:20:43 INFO - Return code: 0 11:20:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d8e41af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:20:43 INFO - Using env: {'DISPLAY': ':0', 11:20:43 INFO - 'HOME': '/home/cltbld', 11:20:43 INFO - 'LANG': 'en_US.UTF-8', 11:20:43 INFO - 'LANGUAGE': 'en_US:en', 11:20:43 INFO - 'LOGNAME': 'cltbld', 11:20:43 INFO - 'MAIL': '/var/mail/cltbld', 11:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:43 INFO - 'MOZ_NO_REMOTE': '1', 11:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:43 INFO - 'NO_EM_RESTART': '1', 11:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:43 INFO - 'PWD': '/builds/slave/test', 11:20:43 INFO - 'SHELL': '/bin/bash', 11:20:43 INFO - 'SHLVL': '1', 11:20:43 INFO - 'TERM': 'linux', 11:20:43 INFO - 'TMOUT': '86400', 11:20:43 INFO - 'USER': 'cltbld', 11:20:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:43 INFO - '_': '/tools/buildbot/bin/python'} 11:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:20:43 INFO - Cleaning up... 11:20:43 INFO - Return code: 0 11:20:43 INFO - Running post-action listener: _resource_record_post_action 11:20:43 INFO - Running post-action listener: _start_resource_monitoring 11:20:43 INFO - Starting resource monitoring. 11:20:43 INFO - [mozharness: 2016-09-23 18:20:43.695028Z] Finished create-virtualenv step (success) 11:20:43 INFO - [mozharness: 2016-09-23 18:20:43.695520Z] Running install step. 11:20:43 INFO - Running pre-action listener: _resource_record_pre_action 11:20:43 INFO - Running main action method: install 11:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:43 INFO - Reading from file tmpfile_stdout 11:20:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:20:43 INFO - Reading from file tmpfile_stdout 11:20:43 INFO - Output received: 11:20:43 INFO - Usage: mozinstall [options] installer 11:20:43 INFO - Options: 11:20:43 INFO - -h, --help show this help message and exit 11:20:43 INFO - -d DEST, --destination=DEST 11:20:43 INFO - Directory to install application into. [default: 11:20:43 INFO - "/builds/slave/test"] 11:20:43 INFO - --app=APP Application being installed. [default: firefox] 11:20:43 INFO - mkdir: /builds/slave/test/build/application 11:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:21:00 INFO - Reading from file tmpfile_stdout 11:21:00 INFO - Output received: 11:21:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:00 INFO - Running post-action listener: _resource_record_post_action 11:21:00 INFO - [mozharness: 2016-09-23 18:21:00.104046Z] Finished install step (success) 11:21:00 INFO - [mozharness: 2016-09-23 18:21:00.104290Z] Running run-tests step. 11:21:00 INFO - Running pre-action listener: _resource_record_pre_action 11:21:00 INFO - Running main action method: run_tests 11:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:00 INFO - Python 2.7.3 11:21:00 INFO - Return code: 0 11:21:00 INFO - grabbing minidump binary from tooltool 11:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:00 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 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:00 INFO - Return code: 0 11:21:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:00 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/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:21:00 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/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 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/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:21:00 INFO - mozversion application_buildid: 20160923094624 11:21:00 INFO - mozversion application_changeset: a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5 11:21:00 INFO - mozversion application_display_name: Nightly 11:21:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:00 INFO - mozversion application_name: Firefox 11:21:00 INFO - mozversion application_remotingname: firefox 11:21:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:21:00 INFO - mozversion application_vendor: Mozilla 11:21:00 INFO - mozversion application_version: 52.0a1 11:21:00 INFO - mozversion platform_buildid: 20160923094624 11:21:00 INFO - mozversion platform_changeset: a33dcaa0f804a2114f13aa4a77affd8bf4cff5b5 11:21:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:21:00 INFO - mozversion platform_version: 52.0a1 11:21:00 INFO - using testdate: 1474654860 11:21:00 INFO - actual date: 1474654860 11:21:00 INFO - starting webserver on 'localhost:50921' 11:21:00 INFO - SUITE-START | Running 2 tests 11:21:00 INFO - TEST-START | dromaeo_css 11:21:00 INFO - operating with platform_type : linux_ 11:21:00 INFO - Initialising browser for dromaeo_css test... 11:21:00 INFO - TEST-INFO | started process 27763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQQUrg/profile http://localhost:50921/getInfo.html) 11:21:05 INFO - PROCESS | 27763 | __metrics Screen width/height:1600/1200 11:21:05 INFO - PROCESS | 27763 | colorDepth:24 11:21:05 INFO - PROCESS | 27763 | Browser inner width/height: 1024/697 11:21:05 INFO - PROCESS | 27763 | __metrics 11:21:05 INFO - PROCESS | 27763 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:05 INFO - PROCESS | 27763 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:06 INFO - PROCESS | 27763 | console.error: PushService: 11:21:06 INFO - PROCESS | 27763 | stateChangeProcessEnqueue: Error transitioning state 11:21:06 INFO - PROCESS | 27763 | UnknownError 11:21:06 INFO - TEST-INFO | 27763: exit 0 11:21:06 INFO - Browser initialized. 11:21:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:06 INFO - TEST-INFO | started process 27846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQQUrg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:19 INFO - PROCESS | 27846 | RSS: Main: 175403008 11:21:19 INFO - PROCESS | 27846 | 11:22:09 INFO - PROCESS | 27846 | 1474654929897 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:24:23 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:50921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50921/tests/dromaeo/cssquery-ext.html) 11:24:24 INFO - PROCESS | 27846 | RSS: Main: 271876096 11:24:24 INFO - PROCESS | 27846 | 11:27:26 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:50921/tests/dromaeo/cssquery-ext.html (next: http://localhost:50921/tests/dromaeo/cssquery-jquery.html) 11:27:27 INFO - PROCESS | 27846 | RSS: Main: 273715200 11:27:27 INFO - PROCESS | 27846 | 11:30:29 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:50921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50921/tests/dromaeo/cssquery-mootools.html) 11:30:30 INFO - PROCESS | 27846 | RSS: Main: 219078656 11:30:30 INFO - PROCESS | 27846 | 11:33:32 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:50921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50921/tests/dromaeo/cssquery-prototype.html) 11:33:33 INFO - PROCESS | 27846 | RSS: Main: 220659712 11:33:33 INFO - PROCESS | 27846 | 11:36:36 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:50921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50921/tests/dromaeo/cssquery-yui.html) 11:36:37 INFO - PROCESS | 27846 | RSS: Main: 219058176 11:36:37 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | Cycle 1(1): loaded http://localhost:50921/tests/dromaeo/cssquery-yui.html (next: http://localhost:50921/tests/dromaeo/cssquery-dojo.html) 11:39:40 INFO - PROCESS | 27846 | RSS: Main: 308858880 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | __start_tp_report 11:39:40 INFO - PROCESS | 27846 | _x_x_mozilla_page_load 11:39:40 INFO - PROCESS | 27846 | _x_x_mozilla_page_load_details 11:39:40 INFO - PROCESS | 27846 | |i|pagename|runs| 11:39:40 INFO - PROCESS | 27846 | |0;dojo.html;2570.3702592864747;2650.4699060187945;2688.7311268873113;2688.9327766805827;2696.4876673432045;4603.148417542749;4729.4797572267025;4750.4536978247515;4807.735574543399;4879.26810978353;4765.809367625291;4819.421669399677;4867.221244600864;4878.243872199815;4980.103581355354;4450.287953927373;4500.122476117151;4514.480834704018;4521.525239849801;4534.251848445019;4476.9776151119195;4506.346579745935;4507;4530.569595888385;4548.317752337143;4529.932051019237;4571.154336447751;4605.4933957264675;4606.585407313341;4630;4272.423222864904;4317.15815415994;4334.371516130143;4372.759498227596;4396.076823866992;4284.61438470536;4341.978290108561;4344.044310251739;4372.868813935587;4433.600975912151;4722.244440889475;4736.336912832172;4742.454617718972;4746.1931471649905;4799.424069111694;5065.924011139836;5085.949140508585;5093.057784309877;5094.7197904115255;5159.355080614923;5069.873253168664;5130.358705161855;5134.358205224347;5141.691498510101;5210.791568337262;4781.187198176319;4781.569658730697;4789.784459699322;4793.664443488992;4840.564349208588;5240.9475905241225;5241.633085683966;5241.633085684041;5242.711650859239;5249.317588713443;4939.876503087452;4995.350604421402;5059.974700126476;5104.285400043997;5113.718745469035;5177.404598471148;5199.844004679866;5203.635745497854;5218.608604354613;5271.42014378418;5061.342025536656;5087.643864929493;5095;5106.591472682177;5168.8966220675375;4787.3776409066595;4789.832355867528;4830.758462076882;4905.583025442806;5137.948620513822;4173.373993900878;4175.519815221289;4177.415161877339;4178.811953462102;4181.560936101666;3725.3294407006456;3773.6792372648633;3795.658390744846;3862.613738626171;3873.2640798248244;4431.224535706238;4433.1577000369825;4439.400680908101;4441.555844415532;4492.258777301774;5191.870203244949;5197.986392653396;5215;5215.634905556651;5282.815101471507;4343.695941284143;4345.521992580813;4365.476142862877;4375.737455752601;4394.033312671208;4582.152301824173;4616.561426664529;4626.028534007896;4668.15973124834;4681.578657920735;4865.805367785249;4865.95134048662;4868.659193856396;4878.268259760922;4935.6051515877925;5002.774875130555;5049.34358533403;5073.92389114171;5108.386993560796;5163.4578369272185;4809.78355973975;4816.060868130681;4819.807207711652;4861.756912154449;4874.976254986493;5008.774605142705;5014.147594908947;5019.799208031638;5020.121478741279;5063.1898896176435;5043.092243396224;5054.924176137288;5102.209157580581;5133;5180.844574662766;4997.450280469218;5025.3718285214345;5053.393592768891;5110.105731497048;5116.718580478109;5060.645754797129;5062.670926389773;5063.493650634907;5068.163752980717;5139.717315547681;4737.526247375235;4787.329773831597;4991.725455100004;4997.800087996439;5004.824831130893;4949.356583644103;5046;5103.87240318995;5124.666896651705;5192.506711862367;4955.876103097451;4974.676646017997;4985.775640096277;4988.600911926965;5049.192129259301 11:39:40 INFO - PROCESS | 27846 | |1;ext.html;558.6480517274117;568.3095039526974;569.9316082070152;575.8761866198766;578.9218455508507;27992.440151196963;28687.856560717195;31032;31328;31358.059258222234;30864;31646.68353316466;37804.24391512168;38920.41619375712;38954.220915581674;7697.653605587762;7827.921720782805;7833.804154896116;7834.05991281047;7837.490563113408;7670.654820533089;7763.611819409007;7766.495177813452;7770.145284018753;7771.805704857367;7360.66876990534;7489.475736698406;7792.610369481532;9843.950780246088;10060;9989.051040151175;10029.849552256723;10054.396736195778;10055;10061.3460125092;9818.45998470084;9892.060254275832;9909.554070066792;9916.553755081039;9924.851127233098;28514.429711405657;29106.27234319159;37103.031757459335;37849.81075094607;38473.42289865654;2762.875670594828;2870.368518925833;3145.1036454610326;3420.846061927219;3573.1960308930543;28837.56743648847;29207.853960730274;29343.413131737245;29453.705462945312;30099.699003009908;3258.1691668624585;3323.5845519310087;3366.8148251846137;3432.1419645088727;3461.7230621550216;259471;259738;259907;260023.69988150126;260206;54101.72949135229;54757.72621136869;54779;54805.69734480506;54817.72591137019;49082.75458622684;49785;54511.72744136254;54765.726171368886;57341;12514.936230420517;12566.371681415892;12574.748505029847;12580;12583.874161258453;9914.80170396588;9924.35491693052;9936.80126397468;9959.651412200537;9999.450030248261;17625.647487050188;17639;17684.46946591604;17690.91154544219;17729.37947171843;5456.563474921997;6492.993585994084;6675.666216689243;6923.965380173167;6969.372756451944;787.5786454247065;844.438448431786;898.2095755734912;937.0676177203726;971.2181693736469;26476.73523264743;28119.015834445698;28377.858110709316;28670.713292866803;28731.425371492453;933.5798890499302;964.344245912786;981.40134517944;994.6121012805012;998.226374559722;13983.30083495821;14802;14985.682945965094;15068.321925513379;15185.240737963057;393549;395535;398012;398086;398712;42759.35860962088;43344;47254.76372618115;48728.7563562187;49318.75340623274;1132.943352832355;1141.1840534018218;1166.2361153444508;1171.976560468803;1182.9763404731857;27972.72027279701;29134.56298155572;29160.125196244146;30005.399892002475;30026.69973300239;42129;42521.149577007665;42526.36210456784;42549;42551.574484256;335601;339260;356404;366996;367113;38040;38292.42561361526;38373.424398633484;38680.2263954725;39069;42322.36516452317;42586.1482770349;42674.35988460114;42830;43299;35605.64394356023;35859.462108068925;35931.82034089813;35950;36677.26645467129;35218.47172292469;35268.823655881555;35699;35837.82081089578;36230.637693622724;34738.305233895684;35211.82394088013;35964.28071438609;36070.8196459016;36500.087497811706;30357.84821075969;32281;32572.185695357806;32725;32808.83595582007;25039.499210016063;25669.871650641628;25688.100916467833;26024.219273421826;26056.73943260619 11:39:40 INFO - PROCESS | 27846 | |2;jquery.html;340.2786093481819;372.36511747470564;376.8567944181212;380.08210172433564;393.1449098211389;11931.403429828506;15574.844251557495;15704.371825126995;16572.917135414307;17497.037662928535;16698.248578813953;16894.74657880133;16996.4051258206;17094;17122.31510739569;4927.9014419711675;5054.797808087672;5136.101182293102;5284.313039304904;5319.148936170194;3446.8104254266004;3625.492431059654;5245.527902488775;5271.578273738091;5274.2879711238875;5602.943970560304;5877.471027607515;5904.55715821313;5975.760969561213;5989.700514974255;5697.259356283698;5762.366139724627;5800.970995144998;5956.166136740838;5969.373215812342;5139.486051394868;5139.897202055938;5145.228215767627;5145.871353216162;5147.691138531663;11681.299122052704;18542.35101771445;19524.219031238732;19593.31423400174;20450.897745511178;1641.286040572343;1919.5393105654682;2019.2831544801531;2089.6447603907372;2209.635410157322;8292.543910084943;8584.227419532272;9036.819263614756;9072.95463522678;9229.953850230773;1664.3841778541896;1728.3224607165528;1763.3475614022766;1765.4438851761654;1807.629435965624;68939.31060689429;71155;71525.6423717878;72358.63820680862;73055.63472182605;9368;9489.572969216402;9565.091316324939;9787;9963.950180249052;13354.597767234494;13362.33188340579;13369.598912032654;13377.130486518345;13386.799198012037;6899.965500172568;7073.469489788286;7106.964465177641;7301.37938275242;7319.670614822346;6924.58452492852;6987.782367935356;7042.61265630385;7132.821679458055;7221.133463984355;4093.1404405074672;4178.832846686159;4205;4304.139172165579;4398.406215160912;1768.2484943899049;1768.9656894571347;1772.9645407091787;1793.2916497983485;1847.2795609712223;819.7704642699935;847.7583888591845;882.2456799436518;903.2039868299352;928.6842473559022;16228.918855405647;16481.34074637001;16801.32794688199;16956.660866782597;17497.037662928662;788.8264581791997;803.1165717710471;814.2386868278179;838.3670328901762;854.6154230596256;8964.058773828785;9604.615815367308;9657.661981830603;9674.177694896012;9676.56455459506;262640;336266;338827.95236619085;338991;339293;61301.69349153315;63603;73057.6347118261;75446.62276688582;81450.59274703589;821.4947807098591;870.2646263906988;900.9189172974463;927.5918595817953;931.5109567477128;11650.592229271935;15022.549323520312;15526.61183470377;16310.347586096423;16619.50141495757;38374.42438363371;39563;39599;39805.80097099496;40770.38844417396;50052.74973625254;50334.49665503445;50497;51916;52745;4572.81708731647;4943.728094954812;5883.735231914488;6576.934230657824;6746.4265537429865;10866.239363244496;12080.75838483243;12128.757424851277;12150.027997760335;12325.630231092722;10305.330153539995;10308.278420510793;10409.42748148859;10532.578696852346;10935.83596246041;9715.07706767856;9911.702648920544;9942.15491683215;10253.794924101625;10343.793124137324;9696.418214907128;9808.558614862492;10335.379877207391;10411.479426028516;10800.729981750519;6650.800475985729;6826.624535650587;6847.589144651337;6884.519828236753;7052.858942821217;10122.746931326776;10296;10544.314619549705;10872.402017889091;11218.270812397168 11:39:40 INFO - PROCESS | 27846 | |3;mootools.html;1368.1038919507723;1400.2648609480023;1454.6290695872551;1680.5714542791586;1721.681488924549;7721.806954826132;8118.594070296484;8121.309688676455;8121.512709237442;8122.390820688457;7049.54177978431;7320.158181809094;7655.387568994481;7904.407169462299;7960.76117716468;2127.2235633993596;2142.2930432957087;2143.807057364837;2160.0711693971584;2160.9891950540227;2116.9259075932346;2131.232756207764;2196.0447205465593;2210.4694873230387;2214.0700905619597;2134.583756167548;2139.1443422630996;2148.3125399872047;2151.9139234430604;2181.4328274648547;2125.9468513287216;2128.701492089824;2129.212191489159;2130.4886827161527;2130.776268491817;2127.7872212778752;2166.5125346797004;2167.739871215464;2170.9891450542805;2174.510735084609;8111.4727542710125;8129.75610731679;8180.918190818075;8185;8255.834883302301;4668.5798278155125;4819.975900120512;4821.7589120543835;4830.637702172351;4833.9033219335415;2907.8836846526115;2995.0715278263806;3028.424599326121;3036.377542603761;3042.0569623416814;927.2720914082413;962.9711108666751;972.0619602083952;983.5918093990986;987.8468837330225;11217.887821121765;11261.099112071097;11275.43622818864;11301;11312.717182070432;4030.2141082488633;4167.270727622654;4298.720583162084;4319;4334.913301734011;9500.904990950141;9506.762330941781;9507.524623768784;9516.286278529;9516.38143520669;4813.95186048142;4862.319275301461;4868.172410690191;4868.756562171877;4870.683405578697;3884.6503814656817;4046.858359957387;4173.248815213291;4422.402975598317;4424.535423780521;3648.2521083177885;3722.3671975763646;3837.079101015792;3847.5960024197057;3851.807409629507;1206.7586482703318;1240.3054289597853;1246.7257203415234;1257.1577043380958;1261.1613277170761;732.9816754581071;740.2412527159704;749.5352881213682;761.7562380038445;765.7664412354173;4993.6005119590345;5006.69959802413;5030;5090.669106508065;5092.796288148506;399.1956208240398;408.55263486482255;412.1838759256689;415.34790379104516;417.7827529684547;3482.89551313461;3504.421770407905;3549.6095429502734;3565.5008298838184;3712.6101759315425;9797.363171393836;10061.245406594535;10166.847497287547;10182.338148020355;10199.235057370726;10162.898371016343;10163.593456261668;10163.745906352253;10165.847512287322;10178.898211017944;7404.814879628052;7581.431392645573;7650.885236721454;7654.885176722353;7662.96168519165;5057.266696328938;5070.391553013515;5195.844124676266;5220.843374698765;5316.840494785162;9006.279497640304;9158.908410916072;9193;9197.816043679222;9236.953815231149;9397.107274808883;9404.482753448627;9493.905060949579;9506.096920792514;9538.28462865274;6250.312465628868;6469.029645553204;6834.214065382345;6855.314468553105;6902.723891044302;7189.7483588074165;7494.775156745306;7497.475176737576;7653.19641437641;7666.501677390952;6918.584884906922;6923.099997000358;6951.30486951321;6953;7191.316824901626;6567.113439685581;6572.901406478811;6626.701798419179;6802.523823332319;6803.897941530782;5907.704614769158;5989.131575921379;5991.460768530679;5991.88016239664;5992.13114098462;4423.823047078081;4446.955530444654;4457.420535330386;4484.9103017940115;4543.38664280318;4396.912061758683;4421.668374871833;4550.772461376851;4552.180607490551;4662.813487460464 11:39:40 INFO - PROCESS | 27846 | |4;prototype.html;277.84857252797224;284.7992165523306;288.7473460721868;289.2335311424725;293.7737941784827;4888.217885138379;4889.511048895113;4900.509949005098;4906.632002599801;4933.7779799909;4832.492588278233;4861.927071093936;4878.829240976566;4882.7070375777475;4896.632752543555;3597.62224966378;3700.389435743099;3736.4955730976376;3785.205106927535;3805.3340665383585;3814.1608846053823;3817.9045523861846;3820.59883712209;3825.7704537727686;3844.519435070616;3778.489903862971;3780.395136778116;3786.3373909565853;3790.5830358660523;3798.335291324021;3612.1872578669722;3704.5369328833895;3722.7021838252876;3779.5653499847595;3799.4490798834154;3333.683300086488;3335.816530090844;3341.114604629751;3345;3353.9161520961925;4709.317149013408;4733.810647574093;4747.45404278509;4798.328234047236;4814.855554333376;4123.175364927027;4233.894152646178;4291.828326866922;4305.827766889321;4320.611144996966;5020.573251273646;5051.393832740058;5058.342415485963;5061.44324124346;5071.416787069497;3611.3138503684218;3616.8553257869653;3617.4573813928123;3618.2763447310645;3628.1473853644375;5090.949090509084;5304.681719096828;5325.813596524142;5345.946540534584;5360.731963401853;3644.5444319460066;3677.595464498903;3687.1150923778637;3694.6120657330594;3702.33357995558;3737.794421306854;3742.1580144467275;3743.240676881861;3755.7370984030854;3760.9435858462143;4318.093200427946;4318.978405107954;4332.696711230246;4337.9132417351475;4342.869713908588;4906.160189928777;5077.644564880423;5130.717810520383;5132.820351287762;5150.48495150482;1288.072587736828;1305.778017736987;1306.0987918336507;1316.5128902306208;1317.1306937421257;794.2454668065245;823.8475881961737;823.9670413183405;832.9333653307721;834.8937657603699;4311.698181127291;4343.761093139845;4453.888652783707;4505.189065968091;4512.638988880882;5275.208718692227;5277.994362142362;5282.81510147143;5286.577073834084;5291.243217315749;4474.485434175046;4486.573775491323;4489.528599497071;4497.918925536018;4513.9322910155715;2642.1148915113267;2771.182501162162;2790.3861150546845;2790.6511686039244;2795.259256297083;4958.404991401055;4959.132151873408;4964.230544265644;4973;4976.377952755905;5141.357330333708;5390.760125171154;5391.353037635509;5394.9460505394445;5410.675359478444;4930.926036109461;4937.8271760488215;4942.332785073969;4953.900921981613;5012.949870501321;5273.894522109613;5280.471952804843;5306.814261500829;5310.601704872072;5312.707801070978;5008.2738002988635;5124.899435841411;5163.380394352702;5188.974055129851;5207.3230480038865;4954.900901982012;4969.279454479008;4969.751512424436;4973.866464127576;4984.352034235526;3739.233457141334;3744.3415175225896;3746.3026620832957;3753.868614598476;3776.4146557283666;5025.3718285214345;5283.656562323436;5308.336457942757;5325.949509438817;5338.492843179892;5138.280640710378;5149.279100925948;5155.175171972466;5159.561437277874;5177.249298851721;5120.334356533627;5149.279100925948;5162.819301324435;5167.431582525995;5191.610629202901;4899.3385892904;5041.159976608585;5089.262057001788;5095.312132862016;5103.545489535464;4880.95119048805;5032.471590483093;5148.536631703165;5168.741562921764;5179.1454410021925;4849.539293767087;4916.188828843201;4916.434610019894;4916.7541622919425;4923.236898280772 11:39:40 INFO - PROCESS | 27846 | |5;yui.html;672.804886582891;681.4173881331459;718.2350796401835;721.1382398034348;757.734792822512;12473.812892806603;13863;13882.930585347072;13907;13921.164730116188;13507.527236546723;13513.797293040612;13517.053806233567;13526.120802147878;13571.389287482063;613.7330261336322;631.819931319574;744.9143348514909;767.0411985018727;771.240328276647;764.0182365660128;765.0819017179407;766.6933226709305;766.8312971146366;767.2365995834125;652.5008368598026;819.3936486999637;821.109096630154;821.7247222180577;821.9424640275183;665.6072916978982;780.3640033372783;798.9001374828147;806.1253539909205;809.4657526032848;593.2051051590889;593.970301484924;595.9702014899237;596.8179705189915;597.199752331873;12698.365081745877;12723.491060357575;12724.109312348139;12752.171108877894;12752.553660621927;12603.558875439316;12972;13271.071025028252;13273.402696878567;13534.729305413837;11987.88012119885;12154.453049612788;12206.816897746541;12238.388080595934;12327.137100402886;4203.936940945889;4213.831446742127;4236.936445953283;4272.829086836554;4291.3777502262;66102;67212.66393668049;67365;67879.32120678829;68636.6568167161;10271.845922311171;10280.383177009404;10451.68644940653;10544.472776361152;10865.402402867918;19480.902595487216;19550.511237219183;19599;19632.70550941737;19761.209551618063;6761.5604985676755;6775.796726098225;6857.131476483959;6904.654767261717;6985.057017302701;3584.121890136933;3673.9816300918324;3728.422094575345;3743.419769935664;3798.924021519554;2690.1794952539663;2764.3641962348775;2781.235160330885;2783.2346104821336;2784.763295119897;486.91478991176405;488.9291052797324;489.6572399320419;495.6679025053223;496.5580633236423;459.7011942237506;498.7855222254393;518.4556215973213;530.3927003580878;562.0557463461424;7026.578405295699;7281.381082607932;7602.46782725215;8003.5197888126895;8192.67229310821;571.9685417302005;577.7313549199642;582.3943099176809;591.7544219149005;609.2567068176817;3696.77819330841;3865.3235683755793;4171.770552619635;4176.394422808676;4344.3483477478;92866.53566732258;92981.53509232546;94323;94738;95288.52355738176;80648.59675701584;81187;81750;82086;84073.15926840776;66718.66640666862;70186;70194;71840.28159718441;71857.64071179506;7859.685612575433;7886.684532618631;8381.95809020951;8432.32541396699;8550.78623034429;39557.40663890102;40117.59882401139;40581;40602.39096413497;41716.791416042724;52005.21992170196;56538.434615653314;58062;58398.416015840994;58441.4155858453;9794.510274486389;10021.09810117093;10060.966483401327;10066.49667516636;10360.047386494813;10000.396290719009;11268.887311126784;11427.803708089741;11601.767964640829;11760.882391176321;10874.238803283693;11063.72340691489;11646.417679116179;11934.164608477324;12025.939870300592;11301.660950171508;11642.185047046625;11717.472713728073;12062.638120856389;12083.57707480234;12052.457639406073;12235.816462753244;12431.875681243071;12540.686482838002;12986.610401687965;8780.780480487783;9122.498262595622;9262.16640502331;9578.329516933747;9765.9023409765;9692.418454892448;9896.703098907044;10359.84460233082;10378.42918639482;10396.324238924446 11:39:40 INFO - PROCESS | 27846 | __end_tp_report 11:39:40 INFO - PROCESS | 27846 | __start_cc_report 11:39:40 INFO - PROCESS | 27846 | _x_x_mozilla_cycle_collect,895 11:39:40 INFO - PROCESS | 27846 | __end_cc_report 11:39:40 INFO - PROCESS | 27846 | __startTimestamp1474655980452__endTimestamp 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | ------- Summary: start ------- 11:39:40 INFO - PROCESS | 27846 | Number of tests: 6 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | [#0] dojo.html Cycles:165 Average:4743.93 Median:4867.22 stddev:503.90 (10.4%) stddev-sans-first:475.72 11:39:40 INFO - PROCESS | 27846 | Values: 2570.4 2650.5 2688.7 2688.9 2696.5 4603.1 4729.5 4750.5 4807.7 4879.3 4765.8 4819.4 4867.2 4878.2 4980.1 4450.3 4500.1 4514.5 4521.5 4534.3 4477.0 4506.3 4507.0 4530.6 4548.3 4529.9 4571.2 4605.5 4606.6 4630.0 4272.4 4317.2 4334.4 4372.8 4396.1 4284.6 4342.0 4344.0 4372.9 4433.6 4722.2 4736.3 4742.5 4746.2 4799.4 5065.9 5085.9 5093.1 5094.7 5159.4 5069.9 5130.4 5134.4 5141.7 5210.8 4781.2 4781.6 4789.8 4793.7 4840.6 5240.9 5241.6 5241.6 5242.7 5249.3 4939.9 4995.4 5060.0 5104.3 5113.7 5177.4 5199.8 5203.6 5218.6 5271.4 5061.3 5087.6 5095.0 5106.6 5168.9 4787.4 4789.8 4830.8 4905.6 5137.9 4173.4 4175.5 4177.4 4178.8 4181.6 3725.3 3773.7 3795.7 3862.6 3873.3 4431.2 4433.2 4439.4 4441.6 4492.3 5191.9 5198.0 5215.0 5215.6 5282.8 4343.7 4345.5 4365.5 4375.7 4394.0 4582.2 4616.6 4626.0 4668.2 4681.6 4865.8 4866.0 4868.7 4878.3 4935.6 5002.8 5049.3 5073.9 5108.4 5163.5 4809.8 4816.1 4819.8 4861.8 4875.0 5008.8 5014.1 5019.8 5020.1 5063.2 5043.1 5054.9 5102.2 5133.0 5180.8 4997.5 5025.4 5053.4 5110.1 5116.7 5060.6 5062.7 5063.5 5068.2 5139.7 4737.5 4787.3 4991.7 4997.8 5004.8 4949.4 5046.0 5103.9 5124.7 5192.5 4955.9 4974.7 4985.8 4988.6 5049.2 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | [#1] ext.html Cycles:180 Average:48747.02 Median:36588.68 stddev:90005.83 (246.0%) stddev-sans-first:90185.60 11:39:40 INFO - PROCESS | 27846 | Values: 558.6 568.3 569.9 575.9 578.9 27992.4 28687.9 31032.0 31328.0 31358.1 30864.0 31646.7 37804.2 38920.4 38954.2 7697.7 7827.9 7833.8 7834.1 7837.5 7670.7 7763.6 7766.5 7770.1 7771.8 7360.7 7489.5 7792.6 9844.0 10060.0 9989.1 10029.8 10054.4 10055.0 10061.3 9818.5 9892.1 9909.6 9916.6 9924.9 28514.4 29106.3 37103.0 37849.8 38473.4 2762.9 2870.4 3145.1 3420.8 3573.2 28837.6 29207.9 29343.4 29453.7 30099.7 3258.2 3323.6 3366.8 3432.1 3461.7 259471.0 259738.0 259907.0 260023.7 260206.0 54101.7 54757.7 54779.0 54805.7 54817.7 49082.8 49785.0 54511.7 54765.7 57341.0 12514.9 12566.4 12574.7 12580.0 12583.9 9914.8 9924.4 9936.8 9959.7 9999.5 17625.6 17639.0 17684.5 17690.9 17729.4 5456.6 6493.0 6675.7 6924.0 6969.4 787.6 844.4 898.2 937.1 971.2 26476.7 28119.0 28377.9 28670.7 28731.4 933.6 964.3 981.4 994.6 998.2 13983.3 14802.0 14985.7 15068.3 15185.2 393549.0 395535.0 398012.0 398086.0 398712.0 42759.4 43344.0 47254.8 48728.8 49318.8 1132.9 1141.2 1166.2 1172.0 1183.0 27972.7 29134.6 29160.1 30005.4 30026.7 42129.0 42521.1 42526.4 42549.0 42551.6 335601.0 339260.0 356404.0 366996.0 367113.0 38040.0 38292.4 38373.4 38680.2 39069.0 42322.4 42586.1 42674.4 42830.0 43299.0 35605.6 35859.5 35931.8 35950.0 36677.3 35218.5 35268.8 35699.0 35837.8 36230.6 34738.3 35211.8 35964.3 36070.8 36500.1 30357.8 32281.0 32572.2 32725.0 32808.8 25039.5 25669.9 25688.1 26024.2 26056.7 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | [#2] jquery.html Cycles:180 Average:22200.26 Median:50193.62 stddev:54093.41 (107.8%) stddev-sans-first:54220.26 11:39:40 INFO - PROCESS | 27846 | Values: 340.3 372.4 376.9 380.1 393.1 11931.4 15574.8 15704.4 16572.9 17497.0 16698.2 16894.7 16996.4 17094.0 17122.3 4927.9 5054.8 5136.1 5284.3 5319.1 3446.8 3625.5 5245.5 5271.6 5274.3 5602.9 5877.5 5904.6 5975.8 5989.7 5697.3 5762.4 5801.0 5956.2 5969.4 5139.5 5139.9 5145.2 5145.9 5147.7 11681.3 18542.4 19524.2 19593.3 20450.9 1641.3 1919.5 2019.3 2089.6 2209.6 8292.5 8584.2 9036.8 9073.0 9230.0 1664.4 1728.3 1763.3 1765.4 1807.6 68939.3 71155.0 71525.6 72358.6 73055.6 9368.0 9489.6 9565.1 9787.0 9964.0 13354.6 13362.3 13369.6 13377.1 13386.8 6900.0 7073.5 7107.0 7301.4 7319.7 6924.6 6987.8 7042.6 7132.8 7221.1 4093.1 4178.8 4205.0 4304.1 4398.4 1768.2 1769.0 1773.0 1793.3 1847.3 819.8 847.8 882.2 903.2 928.7 16228.9 16481.3 16801.3 16956.7 17497.0 788.8 803.1 814.2 838.4 854.6 8964.1 9604.6 9657.7 9674.2 9676.6 262640.0 336266.0 338828.0 338991.0 339293.0 61301.7 63603.0 73057.6 75446.6 81450.6 821.5 870.3 900.9 927.6 931.5 11650.6 15022.5 15526.6 16310.3 16619.5 38374.4 39563.0 39599.0 39805.8 40770.4 50052.7 50334.5 50497.0 51916.0 52745.0 4572.8 4943.7 5883.7 6576.9 6746.4 10866.2 12080.8 12128.8 12150.0 12325.6 10305.3 10308.3 10409.4 10532.6 10935.8 9715.1 9911.7 9942.2 10253.8 10343.8 9696.4 9808.6 10335.4 10411.5 10800.7 6650.8 6826.6 6847.6 6884.5 7052.9 10122.7 10296.0 10544.3 10872.4 11218.3 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | [#3] mootools.html Cycles:180 Average:5225.53 Median:4816.96 stddev:3031.47 (62.9%) stddev-sans-first:3026.12 11:39:40 INFO - PROCESS | 27846 | Values: 1368.1 1400.3 1454.6 1680.6 1721.7 7721.8 8118.6 8121.3 8121.5 8122.4 7049.5 7320.2 7655.4 7904.4 7960.8 2127.2 2142.3 2143.8 2160.1 2161.0 2116.9 2131.2 2196.0 2210.5 2214.1 2134.6 2139.1 2148.3 2151.9 2181.4 2125.9 2128.7 2129.2 2130.5 2130.8 2127.8 2166.5 2167.7 2171.0 2174.5 8111.5 8129.8 8180.9 8185.0 8255.8 4668.6 4820.0 4821.8 4830.6 4833.9 2907.9 2995.1 3028.4 3036.4 3042.1 927.3 963.0 972.1 983.6 987.8 11217.9 11261.1 11275.4 11301.0 11312.7 4030.2 4167.3 4298.7 4319.0 4334.9 9500.9 9506.8 9507.5 9516.3 9516.4 4814.0 4862.3 4868.2 4868.8 4870.7 3884.7 4046.9 4173.2 4422.4 4424.5 3648.3 3722.4 3837.1 3847.6 3851.8 1206.8 1240.3 1246.7 1257.2 1261.2 733.0 740.2 749.5 761.8 765.8 4993.6 5006.7 5030.0 5090.7 5092.8 399.2 408.6 412.2 415.3 417.8 3482.9 3504.4 3549.6 3565.5 3712.6 9797.4 10061.2 10166.8 10182.3 10199.2 10162.9 10163.6 10163.7 10165.8 10178.9 7404.8 7581.4 7650.9 7654.9 7663.0 5057.3 5070.4 5195.8 5220.8 5316.8 9006.3 9158.9 9193.0 9197.8 9237.0 9397.1 9404.5 9493.9 9506.1 9538.3 6250.3 6469.0 6834.2 6855.3 6902.7 7189.7 7494.8 7497.5 7653.2 7666.5 6918.6 6923.1 6951.3 6953.0 7191.3 6567.1 6572.9 6626.7 6802.5 6803.9 5907.7 5989.1 5991.5 5991.9 5992.1 4423.8 4447.0 4457.4 4484.9 4543.4 4396.9 4421.7 4550.8 4552.2 4662.8 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | [#4] prototype.html Cycles:180 Average:4233.06 Median:4885.46 stddev:1240.59 (25.4%) stddev-sans-first:1208.03 11:39:40 INFO - PROCESS | 27846 | Values: 277.8 284.8 288.7 289.2 293.8 4888.2 4889.5 4900.5 4906.6 4933.8 4832.5 4861.9 4878.8 4882.7 4896.6 3597.6 3700.4 3736.5 3785.2 3805.3 3814.2 3817.9 3820.6 3825.8 3844.5 3778.5 3780.4 3786.3 3790.6 3798.3 3612.2 3704.5 3722.7 3779.6 3799.4 3333.7 3335.8 3341.1 3345.0 3353.9 4709.3 4733.8 4747.5 4798.3 4814.9 4123.2 4233.9 4291.8 4305.8 4320.6 5020.6 5051.4 5058.3 5061.4 5071.4 3611.3 3616.9 3617.5 3618.3 3628.1 5090.9 5304.7 5325.8 5345.9 5360.7 3644.5 3677.6 3687.1 3694.6 3702.3 3737.8 3742.2 3743.2 3755.7 3760.9 4318.1 4319.0 4332.7 4337.9 4342.9 4906.2 5077.6 5130.7 5132.8 5150.5 1288.1 1305.8 1306.1 1316.5 1317.1 794.2 823.8 824.0 832.9 834.9 4311.7 4343.8 4453.9 4505.2 4512.6 5275.2 5278.0 5282.8 5286.6 5291.2 4474.5 4486.6 4489.5 4497.9 4513.9 2642.1 2771.2 2790.4 2790.7 2795.3 4958.4 4959.1 4964.2 4973.0 4976.4 5141.4 5390.8 5391.4 5394.9 5410.7 4930.9 4937.8 4942.3 4953.9 5012.9 5273.9 5280.5 5306.8 5310.6 5312.7 5008.3 5124.9 5163.4 5189.0 5207.3 4954.9 4969.3 4969.8 4973.9 4984.4 3739.2 3744.3 3746.3 3753.9 3776.4 5025.4 5283.7 5308.3 5325.9 5338.5 5138.3 5149.3 5155.2 5159.6 5177.2 5120.3 5149.3 5162.8 5167.4 5191.6 4899.3 5041.2 5089.3 5095.3 5103.5 4881.0 5032.5 5148.5 5168.7 5179.1 4849.5 4916.2 4916.4 4916.8 4923.2 11:39:40 INFO - PROCESS | 27846 | 11:39:40 INFO - PROCESS | 27846 | [#5] yui.html Cycles:180 Average:17385.81 Median:492.66 stddev:24470.82 (4967.1%) stddev-sans-first:24507.29 11:39:40 INFO - PROCESS | 27846 | Values: 672.8 681.4 718.2 721.1 757.7 12473.8 13863.0 13882.9 13907.0 13921.2 13507.5 13513.8 13517.1 13526.1 13571.4 613.7 631.8 744.9 767.0 771.2 764.0 765.1 766.7 766.8 767.2 652.5 819.4 821.1 821.7 821.9 665.6 780.4 798.9 806.1 809.5 593.2 594.0 596.0 596.8 597.2 12698.4 12723.5 12724.1 12752.2 12752.6 12603.6 12972.0 13271.1 13273.4 13534.7 11987.9 12154.5 12206.8 12238.4 12327.1 4203.9 4213.8 4236.9 4272.8 4291.4 66102.0 67212.7 67365.0 67879.3 68636.7 10271.8 10280.4 10451.7 10544.5 10865.4 19480.9 19550.5 19599.0 19632.7 19761.2 6761.6 6775.8 6857.1 6904.7 6985.1 3584.1 3674.0 3728.4 3743.4 3798.9 2690.2 2764.4 2781.2 2783.2 2784.8 486.9 488.9 489.7 495.7 496.6 459.7 498.8 518.5 530.4 562.1 7026.6 7281.4 7602.5 8003.5 8192.7 572.0 577.7 582.4 591.8 609.3 3696.8 3865.3 4171.8 4176.4 4344.3 92866.5 92981.5 94323.0 94738.0 95288.5 80648.6 81187.0 81750.0 82086.0 84073.2 66718.7 70186.0 70194.0 71840.3 71857.6 7859.7 7886.7 8382.0 8432.3 8550.8 39557.4 40117.6 40581.0 40602.4 41716.8 52005.2 56538.4 58062.0 58398.4 58441.4 9794.5 10021.1 10061.0 10066.5 10360.0 10000.4 11268.9 11427.8 11601.8 11760.9 10874.2 11063.7 11646.4 11934.2 12025.9 11301.7 11642.2 11717.5 12062.6 12083.6 12052.5 12235.8 12431.9 12540.7 12986.6 8780.8 9122.5 9262.2 9578.3 9765.9 9692.4 9896.7 10359.8 10378.4 10396.3 11:39:40 INFO - PROCESS | 27846 | -------- Summary: end -------- 11:39:40 INFO - PROCESS | 27846 | 11:39:41 INFO - TEST-INFO | 27846: exit 0 11:39:41 INFO - TEST-OK | dromaeo_css | took 1121056ms 11:39:41 INFO - TEST-START | kraken 11:39:41 INFO - operating with platform_type : linux_ 11:39:41 INFO - Initialising browser for kraken test... 11:39:41 INFO - TEST-INFO | started process 28147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUL_hL5/profile http://localhost:50921/getInfo.html) 11:39:46 INFO - PROCESS | 28147 | __metrics Screen width/height:1600/1200 11:39:46 INFO - PROCESS | 28147 | colorDepth:24 11:39:46 INFO - PROCESS | 28147 | Browser inner width/height: 1024/697 11:39:46 INFO - PROCESS | 28147 | __metrics 11:39:46 INFO - PROCESS | 28147 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:39:46 INFO - PROCESS | 28147 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:47 INFO - PROCESS | 28147 | console.error: PushService: 11:39:47 INFO - PROCESS | 28147 | stateChangeProcessEnqueue: Error transitioning state 11:39:47 INFO - PROCESS | 28147 | UnknownError 11:39:47 INFO - TEST-INFO | 28147: exit 0 11:39:47 INFO - Browser initialized. 11:39:47 INFO - Running cycle 1/1 for kraken test... 11:39:47 INFO - TEST-INFO | started process 28232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUL_hL5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:59 INFO - PROCESS | 28232 | RSS: Main: 175157248 11:39:59 INFO - PROCESS | 28232 | 11:40:02 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50921/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:03 INFO - PROCESS | 28232 | RSS: Main: 233545728 11:40:03 INFO - PROCESS | 28232 | 11:40:06 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50921/tests/kraken/driver.html?testName=audio-dft) 11:40:07 INFO - PROCESS | 28232 | RSS: Main: 218296320 11:40:07 INFO - PROCESS | 28232 | 11:40:10 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50921/tests/kraken/driver.html?testName=audio-fft) 11:40:10 INFO - PROCESS | 28232 | RSS: Main: 300081152 11:40:10 INFO - PROCESS | 28232 | 11:40:13 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50921/tests/kraken/driver.html?testName=audio-oscillator) 11:40:13 INFO - PROCESS | 28232 | RSS: Main: 210190336 11:40:13 INFO - PROCESS | 28232 | 11:40:15 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:16 INFO - PROCESS | 28232 | RSS: Main: 213884928 11:40:16 INFO - PROCESS | 28232 | 11:40:19 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50921/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:20 INFO - PROCESS | 28232 | RSS: Main: 250146816 11:40:20 INFO - PROCESS | 28232 | 11:40:23 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50921/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:24 INFO - PROCESS | 28232 | RSS: Main: 244486144 11:40:24 INFO - PROCESS | 28232 | 11:40:27 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50921/tests/kraken/driver.html?testName=json-parse-financial) 11:40:27 INFO - PROCESS | 28232 | RSS: Main: 247103488 11:40:27 INFO - PROCESS | 28232 | 11:40:29 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:30 INFO - PROCESS | 28232 | RSS: Main: 211165184 11:40:30 INFO - PROCESS | 28232 | 11:40:32 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:32 INFO - PROCESS | 28232 | RSS: Main: 218976256 11:40:32 INFO - PROCESS | 28232 | 11:40:34 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:35 INFO - PROCESS | 28232 | RSS: Main: 222752768 11:40:35 INFO - PROCESS | 28232 | 11:40:38 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:39 INFO - PROCESS | 28232 | RSS: Main: 224227328 11:40:39 INFO - PROCESS | 28232 | 11:40:42 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:42 INFO - PROCESS | 28232 | RSS: Main: 221265920 11:40:42 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | Cycle 1(1): loaded http://localhost:50921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50921/tests/kraken/driver.html?testName=ai-astar) 11:40:44 INFO - PROCESS | 28232 | RSS: Main: 272101376 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | __start_tp_report 11:40:44 INFO - PROCESS | 28232 | _x_x_mozilla_page_load 11:40:44 INFO - PROCESS | 28232 | _x_x_mozilla_page_load_details 11:40:44 INFO - PROCESS | 28232 | |i|pagename|runs| 11:40:44 INFO - PROCESS | 28232 | |0;ai-astar;113;114;115;114;114;116;113;115;113;118 11:40:44 INFO - PROCESS | 28232 | |1;audio-beat-detection;157;123;123;172;128;123;124;123;159;123 11:40:44 INFO - PROCESS | 28232 | |2;audio-dft;162;162;161;161;162;161;163;161;161;162 11:40:44 INFO - PROCESS | 28232 | |3;audio-fft;76;76;77;114;77;76;76;77;99;76 11:40:44 INFO - PROCESS | 28232 | |4;audio-oscillator;84;84;117;84;84;85;105;83;84;121 11:40:44 INFO - PROCESS | 28232 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;116;116 11:40:44 INFO - PROCESS | 28232 | |6;imaging-darkroom;147;148;147;147;147;148;147;147;147;147 11:40:44 INFO - PROCESS | 28232 | |7;imaging-desaturate;96;96;96;96;96;95;96;95;96;96 11:40:44 INFO - PROCESS | 28232 | |8;json-parse-financial;64;63;63;63;63;64;64;64;64;63 11:40:44 INFO - PROCESS | 28232 | |9;json-stringify-tinderbox;65;66;66;65;67;71;68;66;68;67 11:40:44 INFO - PROCESS | 28232 | |10;stanford-crypto-aes;85;89;82;87;83;82;82;85;82;88 11:40:44 INFO - PROCESS | 28232 | |11;stanford-crypto-ccm;137;135;135;134;140;153;152;135;167;141 11:40:44 INFO - PROCESS | 28232 | |12;stanford-crypto-pbkdf2;182;177;171;170;176;179;171;169;170;171 11:40:44 INFO - PROCESS | 28232 | |13;stanford-crypto-sha256-iterative;69;69;69;69;70;68;69;69;68;69 11:40:44 INFO - PROCESS | 28232 | __end_tp_report 11:40:44 INFO - PROCESS | 28232 | __start_cc_report 11:40:44 INFO - PROCESS | 28232 | _x_x_mozilla_cycle_collect,1955 11:40:44 INFO - PROCESS | 28232 | __end_cc_report 11:40:44 INFO - PROCESS | 28232 | __startTimestamp1474656044865__endTimestamp 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | ------- Summary: start ------- 11:40:44 INFO - PROCESS | 28232 | Number of tests: 14 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.50 stddev:1.58 (1.4%) stddev-sans-first:1.58 11:40:44 INFO - PROCESS | 28232 | Values: 113.0 114.0 115.0 114.0 114.0 116.0 113.0 115.0 113.0 118.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:126.00 stddev:19.20 (15.2%) stddev-sans-first:18.72 11:40:44 INFO - PROCESS | 28232 | Values: 157.0 123.0 123.0 172.0 128.0 123.0 124.0 123.0 159.0 123.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 11:40:44 INFO - PROCESS | 28232 | Values: 162.0 162.0 161.0 161.0 162.0 161.0 163.0 161.0 161.0 162.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:13.19 (17.2%) stddev-sans-first:13.79 11:40:44 INFO - PROCESS | 28232 | Values: 76.0 76.0 77.0 114.0 77.0 76.0 76.0 77.0 99.0 76.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:15.18 (18.1%) stddev-sans-first:15.74 11:40:44 INFO - PROCESS | 28232 | Values: 84.0 84.0 117.0 84.0 84.0 85.0 105.0 83.0 84.0 121.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:40:44 INFO - PROCESS | 28232 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:40:44 INFO - PROCESS | 28232 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:40:44 INFO - PROCESS | 28232 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 11:40:44 INFO - PROCESS | 28232 | Values: 64.0 63.0 63.0 63.0 63.0 64.0 64.0 64.0 64.0 63.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.76 11:40:44 INFO - PROCESS | 28232 | Values: 65.0 66.0 66.0 65.0 67.0 71.0 68.0 66.0 68.0 67.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:2.72 (3.2%) stddev-sans-first:2.88 11:40:44 INFO - PROCESS | 28232 | Values: 85.0 89.0 82.0 87.0 83.0 82.0 82.0 85.0 82.0 88.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.50 stddev:10.95 (7.8%) stddev-sans-first:11.40 11:40:44 INFO - PROCESS | 28232 | Values: 137.0 135.0 135.0 134.0 140.0 153.0 152.0 135.0 167.0 141.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.50 stddev:4.53 (2.6%) stddev-sans-first:3.64 11:40:44 INFO - PROCESS | 28232 | Values: 182.0 177.0 171.0 170.0 176.0 179.0 171.0 169.0 170.0 171.0 11:40:44 INFO - PROCESS | 28232 | 11:40:44 INFO - PROCESS | 28232 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 11:40:44 INFO - PROCESS | 28232 | Values: 69.0 69.0 69.0 69.0 70.0 68.0 69.0 69.0 68.0 69.0 11:40:44 INFO - PROCESS | 28232 | -------- Summary: end -------- 11:40:44 INFO - PROCESS | 28232 | 11:40:46 INFO - TEST-INFO | 28232: exit 0 11:40:46 INFO - TEST-OK | kraken | took 64907ms 11:40:46 INFO - SUITE-END | took 1185s 11:40:46 INFO - Completed test suite (00:19:46) 11:40:46 INFO - javascript benchmark 11:40:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.3702592864747, 2650.4699060187945, 2688.7311268873113, 2688.9327766805827, 2696.4876673432045, 4603.148417542749, 4729.4797572267025, 4750.4536978247515, 4807.735574543399, 4879.26810978353, 4765.809367625291, 4819.421669399677, 4867.221244600864, 4878.243872199815, 4980.103581355354, 4450.287953927373, 4500.122476117151, 4514.480834704018, 4521.525239849801, 4534.251848445019, 4476.9776151119195, 4506.346579745935, 4507.0, 4530.569595888385, 4548.317752337143, 4529.932051019237, 4571.154336447751, 4605.4933957264675, 4606.585407313341, 4630.0, 4272.423222864904, 4317.15815415994, 4334.371516130143, 4372.759498227596, 4396.076823866992, 4284.61438470536, 4341.978290108561, 4344.044310251739, 4372.868813935587, 4433.600975912151, 4722.244440889475, 4736.336912832172, 4742.454617718972, 4746.1931471649905, 4799.424069111694, 5065.924011139836, 5085.949140508585, 5093.057784309877, 5094.7197904115255, 5159.355080614923, 5069.873253168664, 5130.358705161855, 5134.358205224347, 5141.691498510101, 5210.791568337262, 4781.187198176319, 4781.569658730697, 4789.784459699322, 4793.664443488992, 4840.564349208588, 5240.9475905241225, 5241.633085683966, 5241.633085684041, 5242.711650859239, 5249.317588713443, 4939.876503087452, 4995.350604421402, 5059.974700126476, 5104.285400043997, 5113.718745469035, 5177.404598471148, 5199.844004679866, 5203.635745497854, 5218.608604354613, 5271.42014378418, 5061.342025536656, 5087.643864929493, 5095.0, 5106.591472682177, 5168.8966220675375, 4787.3776409066595, 4789.832355867528, 4830.758462076882, 4905.583025442806, 5137.948620513822, 4173.373993900878, 4175.519815221289, 4177.415161877339, 4178.811953462102, 4181.560936101666, 3725.3294407006456, 3773.6792372648633, 3795.658390744846, 3862.613738626171, 3873.2640798248244, 4431.224535706238, 4433.1577000369825, 4439.400680908101, 4441.555844415532, 4492.258777301774, 5191.870203244949, 5197.986392653396, 5215.0, 5215.634905556651, 5282.815101471507, 4343.695941284143, 4345.521992580813, 4365.476142862877, 4375.737455752601, 4394.033312671208, 4582.152301824173, 4616.561426664529, 4626.028534007896, 4668.15973124834, 4681.578657920735, 4865.805367785249, 4865.95134048662, 4868.659193856396, 4878.268259760922, 4935.6051515877925, 5002.774875130555, 5049.34358533403, 5073.92389114171, 5108.386993560796, 5163.4578369272185, 4809.78355973975, 4816.060868130681, 4819.807207711652, 4861.756912154449, 4874.976254986493, 5008.774605142705, 5014.147594908947, 5019.799208031638, 5020.121478741279, 5063.1898896176435, 5043.092243396224, 5054.924176137288, 5102.209157580581, 5133.0, 5180.844574662766, 4997.450280469218, 5025.3718285214345, 5053.393592768891, 5110.105731497048, 5116.718580478109, 5060.645754797129, 5062.670926389773, 5063.493650634907, 5068.163752980717, 5139.717315547681, 4737.526247375235, 4787.329773831597, 4991.725455100004, 4997.800087996439, 5004.824831130893, 4949.356583644103, 5046.0, 5103.87240318995, 5124.666896651705, 5192.506711862367, 4955.876103097451, 4974.676646017997, 4985.775640096277, 4988.600911926965, 5049.192129259301], "value": 4711.260926505689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6480517274117, 568.3095039526974, 569.9316082070152, 575.8761866198766, 578.9218455508507, 27992.440151196963, 28687.856560717195, 31032.0, 31328.0, 31358.059258222234, 30864.0, 31646.68353316466, 37804.24391512168, 38920.41619375712, 38954.220915581674, 7697.653605587762, 7827.921720782805, 7833.804154896116, 7834.05991281047, 7837.490563113408, 7670.654820533089, 7763.611819409007, 7766.495177813452, 7770.145284018753, 7771.805704857367, 7360.66876990534, 7489.475736698406, 7792.610369481532, 9843.950780246088, 10060.0, 9989.051040151175, 10029.849552256723, 10054.396736195778, 10055.0, 10061.3460125092, 9818.45998470084, 9892.060254275832, 9909.554070066792, 9916.553755081039, 9924.851127233098, 28514.429711405657, 29106.27234319159, 37103.031757459335, 37849.81075094607, 38473.42289865654, 2762.875670594828, 2870.368518925833, 3145.1036454610326, 3420.846061927219, 3573.1960308930543, 28837.56743648847, 29207.853960730274, 29343.413131737245, 29453.705462945312, 30099.699003009908, 3258.1691668624585, 3323.5845519310087, 3366.8148251846137, 3432.1419645088727, 3461.7230621550216, 259471.0, 259738.0, 259907.0, 260023.69988150126, 260206.0, 54101.72949135229, 54757.72621136869, 54779.0, 54805.69734480506, 54817.72591137019, 49082.75458622684, 49785.0, 54511.72744136254, 54765.726171368886, 57341.0, 12514.936230420517, 12566.371681415892, 12574.748505029847, 12580.0, 12583.874161258453, 9914.80170396588, 9924.35491693052, 9936.80126397468, 9959.651412200537, 9999.450030248261, 17625.647487050188, 17639.0, 17684.46946591604, 17690.91154544219, 17729.37947171843, 5456.563474921997, 6492.993585994084, 6675.666216689243, 6923.965380173167, 6969.372756451944, 787.5786454247065, 844.438448431786, 898.2095755734912, 937.0676177203726, 971.2181693736469, 26476.73523264743, 28119.015834445698, 28377.858110709316, 28670.713292866803, 28731.425371492453, 933.5798890499302, 964.344245912786, 981.40134517944, 994.6121012805012, 998.226374559722, 13983.30083495821, 14802.0, 14985.682945965094, 15068.321925513379, 15185.240737963057, 393549.0, 395535.0, 398012.0, 398086.0, 398712.0, 42759.35860962088, 43344.0, 47254.76372618115, 48728.7563562187, 49318.75340623274, 1132.943352832355, 1141.1840534018218, 1166.2361153444508, 1171.976560468803, 1182.9763404731857, 27972.72027279701, 29134.56298155572, 29160.125196244146, 30005.399892002475, 30026.69973300239, 42129.0, 42521.149577007665, 42526.36210456784, 42549.0, 42551.574484256, 335601.0, 339260.0, 356404.0, 366996.0, 367113.0, 38040.0, 38292.42561361526, 38373.424398633484, 38680.2263954725, 39069.0, 42322.36516452317, 42586.1482770349, 42674.35988460114, 42830.0, 43299.0, 35605.64394356023, 35859.462108068925, 35931.82034089813, 35950.0, 36677.26645467129, 35218.47172292469, 35268.823655881555, 35699.0, 35837.82081089578, 36230.637693622724, 34738.305233895684, 35211.82394088013, 35964.28071438609, 36070.8196459016, 36500.087497811706, 30357.84821075969, 32281.0, 32572.185695357806, 32725.0, 32808.83595582007, 25039.499210016063, 25669.871650641628, 25688.100916467833, 26024.219273421826, 26056.73943260619], "value": 17647.44653564494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.2786093481819, 372.36511747470564, 376.8567944181212, 380.08210172433564, 393.1449098211389, 11931.403429828506, 15574.844251557495, 15704.371825126995, 16572.917135414307, 17497.037662928535, 16698.248578813953, 16894.74657880133, 16996.4051258206, 17094.0, 17122.31510739569, 4927.9014419711675, 5054.797808087672, 5136.101182293102, 5284.313039304904, 5319.148936170194, 3446.8104254266004, 3625.492431059654, 5245.527902488775, 5271.578273738091, 5274.2879711238875, 5602.943970560304, 5877.471027607515, 5904.55715821313, 5975.760969561213, 5989.700514974255, 5697.259356283698, 5762.366139724627, 5800.970995144998, 5956.166136740838, 5969.373215812342, 5139.486051394868, 5139.897202055938, 5145.228215767627, 5145.871353216162, 5147.691138531663, 11681.299122052704, 18542.35101771445, 19524.219031238732, 19593.31423400174, 20450.897745511178, 1641.286040572343, 1919.5393105654682, 2019.2831544801531, 2089.6447603907372, 2209.635410157322, 8292.543910084943, 8584.227419532272, 9036.819263614756, 9072.95463522678, 9229.953850230773, 1664.3841778541896, 1728.3224607165528, 1763.3475614022766, 1765.4438851761654, 1807.629435965624, 68939.31060689429, 71155.0, 71525.6423717878, 72358.63820680862, 73055.63472182605, 9368.0, 9489.572969216402, 9565.091316324939, 9787.0, 9963.950180249052, 13354.597767234494, 13362.33188340579, 13369.598912032654, 13377.130486518345, 13386.799198012037, 6899.965500172568, 7073.469489788286, 7106.964465177641, 7301.37938275242, 7319.670614822346, 6924.58452492852, 6987.782367935356, 7042.61265630385, 7132.821679458055, 7221.133463984355, 4093.1404405074672, 4178.832846686159, 4205.0, 4304.139172165579, 4398.406215160912, 1768.2484943899049, 1768.9656894571347, 1772.9645407091787, 1793.2916497983485, 1847.2795609712223, 819.7704642699935, 847.7583888591845, 882.2456799436518, 903.2039868299352, 928.6842473559022, 16228.918855405647, 16481.34074637001, 16801.32794688199, 16956.660866782597, 17497.037662928662, 788.8264581791997, 803.1165717710471, 814.2386868278179, 838.3670328901762, 854.6154230596256, 8964.058773828785, 9604.615815367308, 9657.661981830603, 9674.177694896012, 9676.56455459506, 262640.0, 336266.0, 338827.95236619085, 338991.0, 339293.0, 61301.69349153315, 63603.0, 73057.6347118261, 75446.62276688582, 81450.59274703589, 821.4947807098591, 870.2646263906988, 900.9189172974463, 927.5918595817953, 931.5109567477128, 11650.592229271935, 15022.549323520312, 15526.61183470377, 16310.347586096423, 16619.50141495757, 38374.42438363371, 39563.0, 39599.0, 39805.80097099496, 40770.38844417396, 50052.74973625254, 50334.49665503445, 50497.0, 51916.0, 52745.0, 4572.81708731647, 4943.728094954812, 5883.735231914488, 6576.934230657824, 6746.4265537429865, 10866.239363244496, 12080.75838483243, 12128.757424851277, 12150.027997760335, 12325.630231092722, 10305.330153539995, 10308.278420510793, 10409.42748148859, 10532.578696852346, 10935.83596246041, 9715.07706767856, 9911.702648920544, 9942.15491683215, 10253.794924101625, 10343.793124137324, 9696.418214907128, 9808.558614862492, 10335.379877207391, 10411.479426028516, 10800.729981750519, 6650.800475985729, 6826.624535650587, 6847.589144651337, 6884.519828236753, 7052.858942821217, 10122.746931326776, 10296.0, 10544.314619549705, 10872.402017889091, 11218.270812397168], "value": 7982.344221741006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.1038919507723, 1400.2648609480023, 1454.6290695872551, 1680.5714542791586, 1721.681488924549, 7721.806954826132, 8118.594070296484, 8121.309688676455, 8121.512709237442, 8122.390820688457, 7049.54177978431, 7320.158181809094, 7655.387568994481, 7904.407169462299, 7960.76117716468, 2127.2235633993596, 2142.2930432957087, 2143.807057364837, 2160.0711693971584, 2160.9891950540227, 2116.9259075932346, 2131.232756207764, 2196.0447205465593, 2210.4694873230387, 2214.0700905619597, 2134.583756167548, 2139.1443422630996, 2148.3125399872047, 2151.9139234430604, 2181.4328274648547, 2125.9468513287216, 2128.701492089824, 2129.212191489159, 2130.4886827161527, 2130.776268491817, 2127.7872212778752, 2166.5125346797004, 2167.739871215464, 2170.9891450542805, 2174.510735084609, 8111.4727542710125, 8129.75610731679, 8180.918190818075, 8185.0, 8255.834883302301, 4668.5798278155125, 4819.975900120512, 4821.7589120543835, 4830.637702172351, 4833.9033219335415, 2907.8836846526115, 2995.0715278263806, 3028.424599326121, 3036.377542603761, 3042.0569623416814, 927.2720914082413, 962.9711108666751, 972.0619602083952, 983.5918093990986, 987.8468837330225, 11217.887821121765, 11261.099112071097, 11275.43622818864, 11301.0, 11312.717182070432, 4030.2141082488633, 4167.270727622654, 4298.720583162084, 4319.0, 4334.913301734011, 9500.904990950141, 9506.762330941781, 9507.524623768784, 9516.286278529, 9516.38143520669, 4813.95186048142, 4862.319275301461, 4868.172410690191, 4868.756562171877, 4870.683405578697, 3884.6503814656817, 4046.858359957387, 4173.248815213291, 4422.402975598317, 4424.535423780521, 3648.2521083177885, 3722.3671975763646, 3837.079101015792, 3847.5960024197057, 3851.807409629507, 1206.7586482703318, 1240.3054289597853, 1246.7257203415234, 1257.1577043380958, 1261.1613277170761, 732.9816754581071, 740.2412527159704, 749.5352881213682, 761.7562380038445, 765.7664412354173, 4993.6005119590345, 5006.69959802413, 5030.0, 5090.669106508065, 5092.796288148506, 399.1956208240398, 408.55263486482255, 412.1838759256689, 415.34790379104516, 417.7827529684547, 3482.89551313461, 3504.421770407905, 3549.6095429502734, 3565.5008298838184, 3712.6101759315425, 9797.363171393836, 10061.245406594535, 10166.847497287547, 10182.338148020355, 10199.235057370726, 10162.898371016343, 10163.593456261668, 10163.745906352253, 10165.847512287322, 10178.898211017944, 7404.814879628052, 7581.431392645573, 7650.885236721454, 7654.885176722353, 7662.96168519165, 5057.266696328938, 5070.391553013515, 5195.844124676266, 5220.843374698765, 5316.840494785162, 9006.279497640304, 9158.908410916072, 9193.0, 9197.816043679222, 9236.953815231149, 9397.107274808883, 9404.482753448627, 9493.905060949579, 9506.096920792514, 9538.28462865274, 6250.312465628868, 6469.029645553204, 6834.214065382345, 6855.314468553105, 6902.723891044302, 7189.7483588074165, 7494.775156745306, 7497.475176737576, 7653.19641437641, 7666.501677390952, 6918.584884906922, 6923.099997000358, 6951.30486951321, 6953.0, 7191.316824901626, 6567.113439685581, 6572.901406478811, 6626.701798419179, 6802.523823332319, 6803.897941530782, 5907.704614769158, 5989.131575921379, 5991.460768530679, 5991.88016239664, 5992.13114098462, 4423.823047078081, 4446.955530444654, 4457.420535330386, 4484.9103017940115, 4543.38664280318, 4396.912061758683, 4421.668374871833, 4550.772461376851, 4552.180607490551, 4662.813487460464], "value": 4100.568250961398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.84857252797224, 284.7992165523306, 288.7473460721868, 289.2335311424725, 293.7737941784827, 4888.217885138379, 4889.511048895113, 4900.509949005098, 4906.632002599801, 4933.7779799909, 4832.492588278233, 4861.927071093936, 4878.829240976566, 4882.7070375777475, 4896.632752543555, 3597.62224966378, 3700.389435743099, 3736.4955730976376, 3785.205106927535, 3805.3340665383585, 3814.1608846053823, 3817.9045523861846, 3820.59883712209, 3825.7704537727686, 3844.519435070616, 3778.489903862971, 3780.395136778116, 3786.3373909565853, 3790.5830358660523, 3798.335291324021, 3612.1872578669722, 3704.5369328833895, 3722.7021838252876, 3779.5653499847595, 3799.4490798834154, 3333.683300086488, 3335.816530090844, 3341.114604629751, 3345.0, 3353.9161520961925, 4709.317149013408, 4733.810647574093, 4747.45404278509, 4798.328234047236, 4814.855554333376, 4123.175364927027, 4233.894152646178, 4291.828326866922, 4305.827766889321, 4320.611144996966, 5020.573251273646, 5051.393832740058, 5058.342415485963, 5061.44324124346, 5071.416787069497, 3611.3138503684218, 3616.8553257869653, 3617.4573813928123, 3618.2763447310645, 3628.1473853644375, 5090.949090509084, 5304.681719096828, 5325.813596524142, 5345.946540534584, 5360.731963401853, 3644.5444319460066, 3677.595464498903, 3687.1150923778637, 3694.6120657330594, 3702.33357995558, 3737.794421306854, 3742.1580144467275, 3743.240676881861, 3755.7370984030854, 3760.9435858462143, 4318.093200427946, 4318.978405107954, 4332.696711230246, 4337.9132417351475, 4342.869713908588, 4906.160189928777, 5077.644564880423, 5130.717810520383, 5132.820351287762, 5150.48495150482, 1288.072587736828, 1305.778017736987, 1306.0987918336507, 1316.5128902306208, 1317.1306937421257, 794.2454668065245, 823.8475881961737, 823.9670413183405, 832.9333653307721, 834.8937657603699, 4311.698181127291, 4343.761093139845, 4453.888652783707, 4505.189065968091, 4512.638988880882, 5275.208718692227, 5277.994362142362, 5282.81510147143, 5286.577073834084, 5291.243217315749, 4474.485434175046, 4486.573775491323, 4489.528599497071, 4497.918925536018, 4513.9322910155715, 2642.1148915113267, 2771.182501162162, 2790.3861150546845, 2790.6511686039244, 2795.259256297083, 4958.404991401055, 4959.132151873408, 4964.230544265644, 4973.0, 4976.377952755905, 5141.357330333708, 5390.760125171154, 5391.353037635509, 5394.9460505394445, 5410.675359478444, 4930.926036109461, 4937.8271760488215, 4942.332785073969, 4953.900921981613, 5012.949870501321, 5273.894522109613, 5280.471952804843, 5306.814261500829, 5310.601704872072, 5312.707801070978, 5008.2738002988635, 5124.899435841411, 5163.380394352702, 5188.974055129851, 5207.3230480038865, 4954.900901982012, 4969.279454479008, 4969.751512424436, 4973.866464127576, 4984.352034235526, 3739.233457141334, 3744.3415175225896, 3746.3026620832957, 3753.868614598476, 3776.4146557283666, 5025.3718285214345, 5283.656562323436, 5308.336457942757, 5325.949509438817, 5338.492843179892, 5138.280640710378, 5149.279100925948, 5155.175171972466, 5159.561437277874, 5177.249298851721, 5120.334356533627, 5149.279100925948, 5162.819301324435, 5167.431582525995, 5191.610629202901, 4899.3385892904, 5041.159976608585, 5089.262057001788, 5095.312132862016, 5103.545489535464, 4880.95119048805, 5032.471590483093, 5148.536631703165, 5168.741562921764, 5179.1454410021925, 4849.539293767087, 4916.188828843201, 4916.434610019894, 4916.7541622919425, 4923.236898280772], "value": 3831.370733886206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.804886582891, 681.4173881331459, 718.2350796401835, 721.1382398034348, 757.734792822512, 12473.812892806603, 13863.0, 13882.930585347072, 13907.0, 13921.164730116188, 13507.527236546723, 13513.797293040612, 13517.053806233567, 13526.120802147878, 13571.389287482063, 613.7330261336322, 631.819931319574, 744.9143348514909, 767.0411985018727, 771.240328276647, 764.0182365660128, 765.0819017179407, 766.6933226709305, 766.8312971146366, 767.2365995834125, 652.5008368598026, 819.3936486999637, 821.109096630154, 821.7247222180577, 821.9424640275183, 665.6072916978982, 780.3640033372783, 798.9001374828147, 806.1253539909205, 809.4657526032848, 593.2051051590889, 593.970301484924, 595.9702014899237, 596.8179705189915, 597.199752331873, 12698.365081745877, 12723.491060357575, 12724.109312348139, 12752.171108877894, 12752.553660621927, 12603.558875439316, 12972.0, 13271.071025028252, 13273.402696878567, 13534.729305413837, 11987.88012119885, 12154.453049612788, 12206.816897746541, 12238.388080595934, 12327.137100402886, 4203.936940945889, 4213.831446742127, 4236.936445953283, 4272.829086836554, 4291.3777502262, 66102.0, 67212.66393668049, 67365.0, 67879.32120678829, 68636.6568167161, 10271.845922311171, 10280.383177009404, 10451.68644940653, 10544.472776361152, 10865.402402867918, 19480.902595487216, 19550.511237219183, 19599.0, 19632.70550941737, 19761.209551618063, 6761.5604985676755, 6775.796726098225, 6857.131476483959, 6904.654767261717, 6985.057017302701, 3584.121890136933, 3673.9816300918324, 3728.422094575345, 3743.419769935664, 3798.924021519554, 2690.1794952539663, 2764.3641962348775, 2781.235160330885, 2783.2346104821336, 2784.763295119897, 486.91478991176405, 488.9291052797324, 489.6572399320419, 495.6679025053223, 496.5580633236423, 459.7011942237506, 498.7855222254393, 518.4556215973213, 530.3927003580878, 562.0557463461424, 7026.578405295699, 7281.381082607932, 7602.46782725215, 8003.5197888126895, 8192.67229310821, 571.9685417302005, 577.7313549199642, 582.3943099176809, 591.7544219149005, 609.2567068176817, 3696.77819330841, 3865.3235683755793, 4171.770552619635, 4176.394422808676, 4344.3483477478, 92866.53566732258, 92981.53509232546, 94323.0, 94738.0, 95288.52355738176, 80648.59675701584, 81187.0, 81750.0, 82086.0, 84073.15926840776, 66718.66640666862, 70186.0, 70194.0, 71840.28159718441, 71857.64071179506, 7859.685612575433, 7886.684532618631, 8381.95809020951, 8432.32541396699, 8550.78623034429, 39557.40663890102, 40117.59882401139, 40581.0, 40602.39096413497, 41716.791416042724, 52005.21992170196, 56538.434615653314, 58062.0, 58398.416015840994, 58441.4155858453, 9794.510274486389, 10021.09810117093, 10060.966483401327, 10066.49667516636, 10360.047386494813, 10000.396290719009, 11268.887311126784, 11427.803708089741, 11601.767964640829, 11760.882391176321, 10874.238803283693, 11063.72340691489, 11646.417679116179, 11934.164608477324, 12025.939870300592, 11301.660950171508, 11642.185047046625, 11717.472713728073, 12062.638120856389, 12083.57707480234, 12052.457639406073, 12235.816462753244, 12431.875681243071, 12540.686482838002, 12986.610401687965, 8780.780480487783, 9122.498262595622, 9262.16640502331, 9578.329516933747, 9765.9023409765, 9692.418454892448, 9896.703098907044, 10359.84460233082, 10378.42918639482, 10396.324238924446], "value": 6498.179588722558, "unit": "score"}], "name": "dromaeo_css", "value": 6385.0568063387445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 114.0, 116.0, 113.0, 115.0, 113.0, 118.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 123.0, 172.0, 128.0, 123.0, 124.0, 123.0, 159.0, 123.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 114.0, 77.0, 76.0, 76.0, 77.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 84.0, 85.0, 105.0, 83.0, 84.0, 121.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 67.0, 71.0, 68.0, 66.0, 68.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 82.0, 87.0, 83.0, 82.0, 82.0, 85.0, 82.0, 88.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 135.0, 134.0, 140.0, 153.0, 152.0, 135.0, 167.0, 141.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 171.0, 170.0, 176.0, 179.0, 171.0, 169.0, 170.0, 171.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 69.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1547.1000000000001, "alertThreshold": 2.0}]} 11:40:46 INFO - Return code: 0 11:40:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:46 INFO - # TBPL SUCCESS # 11:40:46 INFO - Running post-action listener: _resource_record_post_action 11:40:46 INFO - [mozharness: 2016-09-23 18:40:46.650351Z] Finished run-tests step (success) 11:40:46 INFO - Running post-run listener: _resource_record_post_run 11:40:46 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392368128; Read time: 12; Write time: 232188 11:40:46 INFO - TinderboxPrint: CPU usage
13.0% 11:40:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:40:46 INFO - TinderboxPrint: I/O write bytes / time
392,368,128 / 232,188 11:40:46 INFO - TinderboxPrint: CPU idle
8,341.1 (87.0%) 11:40:46 INFO - TinderboxPrint: CPU user
1,201.3 (12.5%) 11:40:46 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99860480; Read time: 0; Write time: 86800 11:40:46 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292507648; Read time: 0; Write time: 145388 11:40:47 INFO - Running post-run listener: _upload_blobber_files 11:40:47 INFO - Blob upload gear active. 11:40:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:40:47 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:40:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:52 INFO - (blobuploader) - INFO - Done attempting. 11:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:53 INFO - (blobuploader) - INFO - Done attempting. 11:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:54 INFO - (blobuploader) - INFO - Done attempting. 11:40:54 INFO - (blobuploader) - INFO - Iteration through files over. 11:40:54 INFO - Return code: 0 11:40:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:40:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:40:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2d65428c0f809e96b9ec6edd2baba8ec8d0d23b98b35a867f88f2742eef5cf27e671d49cc15fb44ff3d3ba8518756fe4aca1ab45a9e0ea0225614c8ff542654", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b79a96e520579e1969bbf5d2e1bfa57f9da990aff0774ff2eae68a5f5603f5c7f40ea37bdbb6558c007873a99d6d9d9671fcf92567c555348da1cd5afab89dc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f974fbc93e259dd8b9842eb53b4b58301d4f3595b0daee0b6fcf1a3b4b431e7afe0d6235458dbcd0289c8ef04be142cd1c9cd5828681340200d4b22fc209b860"} 11:40:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:40:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:40:54 INFO - Contents: 11:40:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2d65428c0f809e96b9ec6edd2baba8ec8d0d23b98b35a867f88f2742eef5cf27e671d49cc15fb44ff3d3ba8518756fe4aca1ab45a9e0ea0225614c8ff542654", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b79a96e520579e1969bbf5d2e1bfa57f9da990aff0774ff2eae68a5f5603f5c7f40ea37bdbb6558c007873a99d6d9d9671fcf92567c555348da1cd5afab89dc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f974fbc93e259dd8b9842eb53b4b58301d4f3595b0daee0b6fcf1a3b4b431e7afe0d6235458dbcd0289c8ef04be142cd1c9cd5828681340200d4b22fc209b860"} 11:40:54 INFO - Running post-run listener: copy_logs_to_upload_dir 11:40:54 INFO - Copying logs to upload dir... 11:40:54 INFO - mkdir: /builds/slave/test/build/upload/logs 11:40:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.080715 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-23 11:40:53.918223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 11:40:53.921562) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604 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/b2d65428c0f809e96b9ec6edd2baba8ec8d0d23b98b35a867f88f2742eef5cf27e671d49cc15fb44ff3d3ba8518756fe4aca1ab45a9e0ea0225614c8ff542654", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b79a96e520579e1969bbf5d2e1bfa57f9da990aff0774ff2eae68a5f5603f5c7f40ea37bdbb6558c007873a99d6d9d9671fcf92567c555348da1cd5afab89dc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f974fbc93e259dd8b9842eb53b4b58301d4f3595b0daee0b6fcf1a3b4b431e7afe0d6235458dbcd0289c8ef04be142cd1c9cd5828681340200d4b22fc209b860"} build_url:https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/ZvZ16b05Rr2bdfiYMKh94g/artifacts/public/build/firefox-52.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/b2d65428c0f809e96b9ec6edd2baba8ec8d0d23b98b35a867f88f2742eef5cf27e671d49cc15fb44ff3d3ba8518756fe4aca1ab45a9e0ea0225614c8ff542654", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b79a96e520579e1969bbf5d2e1bfa57f9da990aff0774ff2eae68a5f5603f5c7f40ea37bdbb6558c007873a99d6d9d9671fcf92567c555348da1cd5afab89dc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f974fbc93e259dd8b9842eb53b4b58301d4f3595b0daee0b6fcf1a3b4b431e7afe0d6235458dbcd0289c8ef04be142cd1c9cd5828681340200d4b22fc209b860"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 11:40:53.947121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:40:53.947522) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474654804.395529-1893125604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:40:54.033456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 11:40:54.033811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 11:40:54.034129) ========= ========= Total master_lag: 0.17 =========