builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1473779649.21 results: success (0) buildid: 20160913065007 builduid: 29091d27e931439397e6896f92167f0c revision: b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.213307) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.213761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.214076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.242427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.242743) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-13 08:14:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.3M=0s 2016-09-13 08:14:09 (37.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.379174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.379495) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.429346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:09.429711) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd --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 b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd --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=97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-13 08:14:09,813 truncating revision to first 12 chars 2016-09-13 08:14:09,813 Setting DEBUG logging. 2016-09-13 08:14:09,813 attempt 1/10 2016-09-13 08:14:09,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b2166c12cbbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 08:14:10,110 unpacking tar archive at: autoland-b2166c12cbbe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636210 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:10.079536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:10.079858) ========= script_repo_revision: b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:10.080262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:10.080565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 08:14:10.090074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-13 08:14:10.090391) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:10 INFO - MultiFileLogger online at 20160913 08:14:10 in /builds/slave/test 08:14:10 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 08:14:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:10 INFO - {'append_to_log': False, 08:14:10 INFO - 'base_work_dir': '/builds/slave/test', 08:14:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:14:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:10 INFO - 'branch': 'Autoland-Non-PGO', 08:14:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:10 INFO - 'config_files': ('talos/linux_config.py',), 08:14:10 INFO - 'default_actions': ('clobber', 08:14:10 INFO - 'read-buildbot-config', 08:14:10 INFO - 'download-and-extract', 08:14:10 INFO - 'populate-webroot', 08:14:10 INFO - 'create-virtualenv', 08:14:10 INFO - 'install', 08:14:10 INFO - 'run-tests'), 08:14:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:10 INFO - 'download_minidump_stackwalk': True, 08:14:10 INFO - 'download_symbols': 'ondemand', 08:14:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:10 INFO - 'installer_path': 'installer.exe', 08:14:10 INFO - 'log_level': 'info', 08:14:10 INFO - 'log_name': 'talos', 08:14:10 INFO - 'log_to_console': True, 08:14:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:10 INFO - 'opt_config_files': (), 08:14:10 INFO - 'pip_index': False, 08:14:10 INFO - 'sps_profile': False, 08:14:10 INFO - 'sps_profile_interval': 0, 08:14:10 INFO - 'suite': 'dromaeojs', 08:14:10 INFO - 'system_bits': '32', 08:14:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:10 INFO - 'title': 'talos-linux64-ix-068', 08:14:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:10 INFO - 'use_talos_json': True, 08:14:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:10 INFO - 'work_dir': 'build'} 08:14:10 INFO - [mozharness: 2016-09-13 15:14:10.570422Z] Running clobber step. 08:14:10 INFO - Running pre-action listener: _resource_record_pre_action 08:14:10 INFO - Running main action method: clobber 08:14:10 INFO - rmtree: /builds/slave/test/build 08:14:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:11 INFO - Running post-action listener: _resource_record_post_action 08:14:11 INFO - [mozharness: 2016-09-13 15:14:11.027265Z] Finished clobber step (success) 08:14:11 INFO - [mozharness: 2016-09-13 15:14:11.027397Z] Running read-buildbot-config step. 08:14:11 INFO - Running pre-action listener: _resource_record_pre_action 08:14:11 INFO - Running main action method: read_buildbot_config 08:14:11 INFO - Using buildbot properties: 08:14:11 INFO - { 08:14:11 INFO - "project": "", 08:14:11 INFO - "product": "firefox", 08:14:11 INFO - "script_repo_revision": "production", 08:14:11 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:14:11 INFO - "repository": "", 08:14:11 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:14:11 INFO - "buildid": "20160913065007", 08:14:11 INFO - "pgo_build": "False", 08:14:11 INFO - "basedir": "/builds/slave/test", 08:14:11 INFO - "buildnumber": 530, 08:14:11 INFO - "slavename": "talos-linux64-ix-068", 08:14:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:14:11 INFO - "platform": "ubuntu64_hw", 08:14:11 INFO - "scheduler": "tests-autoland-linux64-talos", 08:14:11 INFO - "branch": "autoland", 08:14:11 INFO - "repo_path": "integration/autoland", 08:14:11 INFO - "revision": "b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd", 08:14:11 INFO - "stage_platform": "linux64", 08:14:11 INFO - "builduid": "29091d27e931439397e6896f92167f0c", 08:14:11 INFO - "slavebuilddir": "test" 08:14:11 INFO - } 08:14:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:14:11 INFO - Running post-action listener: _resource_record_post_action 08:14:11 INFO - [mozharness: 2016-09-13 15:14:11.030162Z] Finished read-buildbot-config step (success) 08:14:11 INFO - [mozharness: 2016-09-13 15:14:11.030252Z] Running download-and-extract step. 08:14:11 INFO - Running pre-action listener: _resource_record_pre_action 08:14:11 INFO - Running main action method: download_and_extract 08:14:11 INFO - mkdir: /builds/slave/test/build/tests 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:11 INFO - trying https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:14:11 INFO - Downloading https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:14:11 INFO - Downloaded 1361 bytes. 08:14:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:14:11 INFO - Using the following test package requirements: 08:14:11 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:14:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'jsshell-linux-x86_64.zip'], 08:14:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:14:11 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:14:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:14:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:11 INFO - Fetch https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:14:12 INFO - Expected file size: 20362044 08:14:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:14:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:17 INFO - Fetch https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:14:17 INFO - Expected file size: 20362044 08:14:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:22 INFO - Fetch https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:14:23 INFO - Expected file size: 14414048 08:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:24 INFO - trying https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:14:24 INFO - Downloading https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:26 INFO - Downloaded 55612324 bytes. 08:14:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:14:26 INFO - mkdir: /builds/slave/test/properties 08:14:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:26 INFO - Contents: 08:14:26 INFO - build_url:https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:14:26 INFO - Running post-action listener: _resource_record_post_action 08:14:26 INFO - Running post-action listener: set_extra_try_arguments 08:14:26 INFO - [mozharness: 2016-09-13 15:14:26.997827Z] Finished download-and-extract step (success) 08:14:26 INFO - [mozharness: 2016-09-13 15:14:26.998055Z] Running populate-webroot step. 08:14:26 INFO - Running pre-action listener: _resource_record_pre_action 08:14:26 INFO - Running main action method: populate_webroot 08:14:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:27 INFO - '--tppagecycles', 08:14:27 INFO - '7'], 08:14:27 INFO - 'tests': ['tsvgm']}}, 08:14:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['damp', 'tps']}, 08:14:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'tests': ['damp', 'tps']}, 08:14:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['dromaeo_dom']}, 08:14:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['basic_compositor_video']}, 08:14:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['a11yr', 08:14:27 INFO - 'ts_paint', 08:14:27 INFO - 'tpaint', 08:14:27 INFO - 'sessionrestore', 08:14:27 INFO - 'sessionrestore_no_auto_restore', 08:14:27 INFO - 'tabpaint']}, 08:14:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tsvgx', 08:14:27 INFO - 'tsvgr_opacity', 08:14:27 INFO - 'tart', 08:14:27 INFO - 'tscrollx', 08:14:27 INFO - 'cart']}, 08:14:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:27 INFO - 'tsvgr_opacity', 08:14:27 INFO - 'tart', 08:14:27 INFO - 'tscrollx', 08:14:27 INFO - 'cart']}, 08:14:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s'], 08:14:27 INFO - 'tests': ['tp5o']}, 08:14:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'tests': ['tp5o']}, 08:14:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--disable-e10s', 08:14:27 INFO - '--xperf_path', 08:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:27 INFO - 'tests': ['tp5n']}, 08:14:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:27 INFO - 'talos_options': ['--xperf_path', 08:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:27 INFO - 'tests': ['tp5n']}}, 08:14:27 INFO - 'talos.zip': {'path': '', 08:14:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:27 INFO - Running post-action listener: _resource_record_post_action 08:14:27 INFO - [mozharness: 2016-09-13 15:14:27.017398Z] Finished populate-webroot step (success) 08:14:27 INFO - [mozharness: 2016-09-13 15:14:27.017487Z] Running create-virtualenv step. 08:14:27 INFO - Running pre-action listener: _resource_record_pre_action 08:14:27 INFO - Running main action method: create_virtualenv 08:14:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:27 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 08:14:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:27 INFO - Using real prefix '/usr' 08:14:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:29 INFO - Installing pip.................done. 08:14:29 INFO - Return code: 0 08:14:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14: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', 'pip>=1.5'] in /builds/slave/test/build 08:14: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 pip>=1.5 08:14:29 INFO - Using env: {'DISPLAY': ':0', 08:14:29 INFO - 'HOME': '/home/cltbld', 08:14:29 INFO - 'LANG': 'en_US.UTF-8', 08:14:29 INFO - 'LANGUAGE': 'en_US:en', 08:14:29 INFO - 'LOGNAME': 'cltbld', 08:14:29 INFO - 'MAIL': '/var/mail/cltbld', 08:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:29 INFO - 'MOZ_NO_REMOTE': '1', 08:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:29 INFO - 'NO_EM_RESTART': '1', 08:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:29 INFO - 'PWD': '/builds/slave/test', 08:14:29 INFO - 'SHELL': '/bin/bash', 08:14:29 INFO - 'SHLVL': '1', 08:14:29 INFO - 'TERM': 'linux', 08:14:29 INFO - 'TMOUT': '86400', 08:14:29 INFO - 'USER': 'cltbld', 08:14:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:29 INFO - '_': '/tools/buildbot/bin/python'} 08:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:29 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 08:14:29 INFO - Cleaning up... 08:14:29 INFO - Return code: 0 08:14:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', '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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:14: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 psutil>=3.1.1 08:14:29 INFO - Using env: {'DISPLAY': ':0', 08:14:29 INFO - 'HOME': '/home/cltbld', 08:14:29 INFO - 'LANG': 'en_US.UTF-8', 08:14:29 INFO - 'LANGUAGE': 'en_US:en', 08:14:29 INFO - 'LOGNAME': 'cltbld', 08:14:29 INFO - 'MAIL': '/var/mail/cltbld', 08:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:29 INFO - 'MOZ_NO_REMOTE': '1', 08:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:29 INFO - 'NO_EM_RESTART': '1', 08:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:29 INFO - 'PWD': '/builds/slave/test', 08:14:29 INFO - 'SHELL': '/bin/bash', 08:14:29 INFO - 'SHLVL': '1', 08:14:29 INFO - 'TERM': 'linux', 08:14:29 INFO - 'TMOUT': '86400', 08:14:29 INFO - 'USER': 'cltbld', 08:14:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:29 INFO - '_': '/tools/buildbot/bin/python'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Downloading/unpacking psutil>=3.1.1 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:32 INFO - Installing collected packages: psutil 08:14:32 INFO - Running setup.py install for psutil 08:14:32 INFO - building 'psutil._psutil_linux' extension 08:14:32 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 08:14:32 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 08:14:32 INFO - building 'psutil._psutil_posix' extension 08:14:32 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 08:14:32 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 08:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:32 INFO - Successfully installed psutil 08:14:32 INFO - Cleaning up... 08:14:32 INFO - Return code: 0 08:14:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:14: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 mozsystemmonitor==0.3 08:14:32 INFO - Using env: {'DISPLAY': ':0', 08:14:32 INFO - 'HOME': '/home/cltbld', 08:14:32 INFO - 'LANG': 'en_US.UTF-8', 08:14:32 INFO - 'LANGUAGE': 'en_US:en', 08:14:32 INFO - 'LOGNAME': 'cltbld', 08:14:32 INFO - 'MAIL': '/var/mail/cltbld', 08:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:32 INFO - 'MOZ_NO_REMOTE': '1', 08:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:32 INFO - 'NO_EM_RESTART': '1', 08:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:32 INFO - 'PWD': '/builds/slave/test', 08:14:32 INFO - 'SHELL': '/bin/bash', 08:14:32 INFO - 'SHLVL': '1', 08:14:32 INFO - 'TERM': 'linux', 08:14:32 INFO - 'TMOUT': '86400', 08:14:32 INFO - 'USER': 'cltbld', 08:14:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:32 INFO - '_': '/tools/buildbot/bin/python'} 08:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:34 INFO - Installing collected packages: mozsystemmonitor 08:14:34 INFO - Running setup.py install for mozsystemmonitor 08:14:34 INFO - Successfully installed mozsystemmonitor 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:34 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 08:14:34 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 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:37 INFO - warning: no files found matching '*.txt' 08:14:37 INFO - no previously-included directories found matching 'build' 08:14:37 INFO - no previously-included directories found matching 'dist' 08:14:37 INFO - no previously-included directories found matching '.git*' 08:14:37 INFO - Installing collected packages: jsonschema, functools32 08:14:37 INFO - Running setup.py install for functools32 08:14:37 INFO - warning: no files found matching '*.txt' 08:14:37 INFO - no previously-included directories found matching 'build' 08:14:37 INFO - no previously-included directories found matching 'dist' 08:14:37 INFO - no previously-included directories found matching '.git*' 08:14:37 INFO - Successfully installed jsonschema functools32 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:37 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 08:14:37 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 08:14:37 INFO - Using env: {'DISPLAY': ':0', 08:14:37 INFO - 'HOME': '/home/cltbld', 08:14:37 INFO - 'LANG': 'en_US.UTF-8', 08:14:37 INFO - 'LANGUAGE': 'en_US:en', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MAIL': '/var/mail/cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SHLVL': '1', 08:14:37 INFO - 'TERM': 'linux', 08:14:37 INFO - 'TMOUT': '86400', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - '_': '/tools/buildbot/bin/python'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:37 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 08:14:37 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 08:14:37 INFO - Using env: {'DISPLAY': ':0', 08:14:37 INFO - 'HOME': '/home/cltbld', 08:14:37 INFO - 'LANG': 'en_US.UTF-8', 08:14:37 INFO - 'LANGUAGE': 'en_US:en', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MAIL': '/var/mail/cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SHLVL': '1', 08:14:37 INFO - 'TERM': 'linux', 08:14:37 INFO - 'TMOUT': '86400', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - '_': '/tools/buildbot/bin/python'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:40 INFO - Downloading docopt-0.6.1.tar.gz 08:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:40 INFO - Running setup.py install for blobuploader 08:14:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:40 INFO - Running setup.py install for requests 08:14:41 INFO - Running setup.py install for docopt 08:14:41 INFO - Successfully installed blobuploader requests docopt 08:14:41 INFO - Cleaning up... 08:14:41 INFO - Return code: 0 08:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:41 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')]} 08:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 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')]} 08:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:41 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 08:14:41 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 08:14:41 INFO - Using env: {'DISPLAY': ':0', 08:14:41 INFO - 'HOME': '/home/cltbld', 08:14:41 INFO - 'LANG': 'en_US.UTF-8', 08:14:41 INFO - 'LANGUAGE': 'en_US:en', 08:14:41 INFO - 'LOGNAME': 'cltbld', 08:14:41 INFO - 'MAIL': '/var/mail/cltbld', 08:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:41 INFO - 'MOZ_NO_REMOTE': '1', 08:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:41 INFO - 'NO_EM_RESTART': '1', 08:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:41 INFO - 'PWD': '/builds/slave/test', 08:14:41 INFO - 'SHELL': '/bin/bash', 08:14:41 INFO - 'SHLVL': '1', 08:14:41 INFO - 'TERM': 'linux', 08:14:41 INFO - 'TMOUT': '86400', 08:14:41 INFO - 'USER': 'cltbld', 08:14:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:41 INFO - '_': '/tools/buildbot/bin/python'} 08:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:41 INFO - Running setup.py (path:/tmp/pip-a88qav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:41 INFO - Running setup.py (path:/tmp/pip-zxZAG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:41 INFO - Running setup.py (path:/tmp/pip-YLjnTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:41 INFO - Running setup.py (path:/tmp/pip-NOqL9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:41 INFO - Running setup.py (path:/tmp/pip-9T4JRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:41 INFO - Running setup.py (path:/tmp/pip-GXSKhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:42 INFO - Running setup.py (path:/tmp/pip-KMQ8RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:42 INFO - Running setup.py (path:/tmp/pip-zfeaqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:42 INFO - Running setup.py (path:/tmp/pip-VIw6ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:42 INFO - Running setup.py (path:/tmp/pip-z2qCMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:42 INFO - Running setup.py (path:/tmp/pip-Luyl3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:42 INFO - Running setup.py (path:/tmp/pip-VdmoFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:42 INFO - Running setup.py (path:/tmp/pip-zrdchP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:42 INFO - Running setup.py (path:/tmp/pip-WLEXUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:42 INFO - Running setup.py (path:/tmp/pip-IJA68_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:42 INFO - Running setup.py (path:/tmp/pip-GRch4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:42 INFO - Running setup.py (path:/tmp/pip-qoARAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:42 INFO - Running setup.py install for manifestparser 08:14:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:42 INFO - Running setup.py install for mozcrash 08:14:43 INFO - Running setup.py install for mozdebug 08:14:43 INFO - Running setup.py install for mozdevice 08:14:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Running setup.py install for mozfile 08:14:43 INFO - Running setup.py install for mozhttpd 08:14:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Running setup.py install for mozinfo 08:14:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Running setup.py install for mozInstall 08:14:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Running setup.py install for mozleak 08:14:43 INFO - Running setup.py install for mozlog 08:14:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Running setup.py install for moznetwork 08:14:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Running setup.py install for mozprocess 08:14:44 INFO - Running setup.py install for mozprofile 08:14:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:44 INFO - Running setup.py install for mozrunner 08:14:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:44 INFO - Running setup.py install for mozscreenshot 08:14:44 INFO - Running setup.py install for moztest 08:14:44 INFO - Running setup.py install for mozversion 08:14:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:44 INFO - Cleaning up... 08:14:44 INFO - Return code: 0 08:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:44 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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:44 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 08:14:44 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 08:14:44 INFO - Using env: {'DISPLAY': ':0', 08:14:44 INFO - 'HOME': '/home/cltbld', 08:14:44 INFO - 'LANG': 'en_US.UTF-8', 08:14:44 INFO - 'LANGUAGE': 'en_US:en', 08:14:44 INFO - 'LOGNAME': 'cltbld', 08:14:44 INFO - 'MAIL': '/var/mail/cltbld', 08:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:44 INFO - 'MOZ_NO_REMOTE': '1', 08:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:44 INFO - 'NO_EM_RESTART': '1', 08:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:44 INFO - 'PWD': '/builds/slave/test', 08:14:44 INFO - 'SHELL': '/bin/bash', 08:14:44 INFO - 'SHLVL': '1', 08:14:44 INFO - 'TERM': 'linux', 08:14:44 INFO - 'TMOUT': '86400', 08:14:44 INFO - 'USER': 'cltbld', 08:14:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:44 INFO - '_': '/tools/buildbot/bin/python'} 08:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:44 INFO - Running setup.py (path:/tmp/pip-_CpboB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:44 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)) 08:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:44 INFO - Running setup.py (path:/tmp/pip-undbea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:44 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)) 08:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:44 INFO - Running setup.py (path:/tmp/pip-jKfZJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:45 INFO - Running setup.py (path:/tmp/pip-nyvFr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:45 INFO - Running setup.py (path:/tmp/pip-y8nJLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:45 INFO - Running setup.py (path:/tmp/pip-8eYOzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:45 INFO - Running setup.py (path:/tmp/pip-9zzaBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:45 INFO - Running setup.py (path:/tmp/pip-34175J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:45 INFO - Running setup.py (path:/tmp/pip-JvnYmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:45 INFO - Running setup.py (path:/tmp/pip-OcDGDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:45 INFO - Running setup.py (path:/tmp/pip-2cnZ6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:45 INFO - Running setup.py (path:/tmp/pip-GIT56M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:45 INFO - Running setup.py (path:/tmp/pip-25Pxex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:45 INFO - Running setup.py (path:/tmp/pip-0g1u35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:45 INFO - Running setup.py (path:/tmp/pip-tEjDKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:45 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)) 08:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:45 INFO - Running setup.py (path:/tmp/pip-GI5xuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:46 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)) 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:46 INFO - Running setup.py (path:/tmp/pip-plbOJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:46 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)) 08:14:46 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)) 08:14:46 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)) 08:14:46 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)) 08:14:46 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)) 08:14:46 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)) 08:14:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:47 INFO - Downloading blessings-1.6.tar.gz 08:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:48 INFO - Installing collected packages: blessings 08:14:48 INFO - Running setup.py install for blessings 08:14:48 INFO - Successfully installed blessings 08:14:48 INFO - Cleaning up... 08:14:48 INFO - Return code: 0 08:14:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:48 INFO - Reading from file tmpfile_stdout 08:14:48 INFO - Current package versions: 08:14:48 INFO - argparse == 1.2.1 08:14:48 INFO - blessings == 1.6 08:14:48 INFO - blobuploader == 1.2.4 08:14:48 INFO - docopt == 0.6.1 08:14:48 INFO - functools32 == 3.2.3-2 08:14:48 INFO - jsonschema == 2.5.1 08:14:48 INFO - manifestparser == 1.1 08:14:48 INFO - mozInstall == 1.12 08:14:48 INFO - mozcrash == 0.17 08:14:48 INFO - mozdebug == 0.1 08:14:48 INFO - mozdevice == 0.48 08:14:48 INFO - mozfile == 1.2 08:14:48 INFO - mozhttpd == 0.7 08:14:48 INFO - mozinfo == 0.9 08:14:48 INFO - mozleak == 0.1 08:14:48 INFO - mozlog == 3.3 08:14:48 INFO - moznetwork == 0.27 08:14:48 INFO - mozprocess == 0.23 08:14:48 INFO - mozprofile == 0.28 08:14:48 INFO - mozrunner == 6.12 08:14:48 INFO - mozscreenshot == 0.1 08:14:48 INFO - mozsystemmonitor == 0.3 08:14:48 INFO - moztest == 0.7 08:14:48 INFO - mozversion == 1.4 08:14:48 INFO - psutil == 3.1.1 08:14:48 INFO - requests == 1.2.3 08:14:48 INFO - wsgiref == 0.1.2 08:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 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 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:48 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 08:14:48 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 08:14:48 INFO - Using env: {'DISPLAY': ':0', 08:14:48 INFO - 'HOME': '/home/cltbld', 08:14:48 INFO - 'LANG': 'en_US.UTF-8', 08:14:48 INFO - 'LANGUAGE': 'en_US:en', 08:14:48 INFO - 'LOGNAME': 'cltbld', 08:14:48 INFO - 'MAIL': '/var/mail/cltbld', 08:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:48 INFO - 'MOZ_NO_REMOTE': '1', 08:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:48 INFO - 'NO_EM_RESTART': '1', 08:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:48 INFO - 'PWD': '/builds/slave/test', 08:14:48 INFO - 'SHELL': '/bin/bash', 08:14:48 INFO - 'SHLVL': '1', 08:14:48 INFO - 'TERM': 'linux', 08:14:48 INFO - 'TMOUT': '86400', 08:14:48 INFO - 'USER': 'cltbld', 08:14:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:48 INFO - '_': '/tools/buildbot/bin/python'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 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)) 08:14:48 INFO - Cleaning up... 08:14:48 INFO - Return code: 0 08:14:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee8f940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', '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 08:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:48 INFO - Using env: {'DISPLAY': ':0', 08:14:48 INFO - 'HOME': '/home/cltbld', 08:14:48 INFO - 'LANG': 'en_US.UTF-8', 08:14:48 INFO - 'LANGUAGE': 'en_US:en', 08:14:48 INFO - 'LOGNAME': 'cltbld', 08:14:48 INFO - 'MAIL': '/var/mail/cltbld', 08:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:48 INFO - 'MOZ_NO_REMOTE': '1', 08:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:48 INFO - 'NO_EM_RESTART': '1', 08:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:48 INFO - 'PWD': '/builds/slave/test', 08:14:48 INFO - 'SHELL': '/bin/bash', 08:14:48 INFO - 'SHLVL': '1', 08:14:48 INFO - 'TERM': 'linux', 08:14:48 INFO - 'TMOUT': '86400', 08:14:48 INFO - 'USER': 'cltbld', 08:14:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:48 INFO - '_': '/tools/buildbot/bin/python'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:48 INFO - Cleaning up... 08:14:48 INFO - Return code: 0 08:14:48 INFO - Running post-action listener: _resource_record_post_action 08:14:48 INFO - Running post-action listener: _start_resource_monitoring 08:14:48 INFO - Starting resource monitoring. 08:14:48 INFO - [mozharness: 2016-09-13 15:14:48.903704Z] Finished create-virtualenv step (success) 08:14:48 INFO - [mozharness: 2016-09-13 15:14:48.904161Z] Running install step. 08:14:48 INFO - Running pre-action listener: _resource_record_pre_action 08:14:48 INFO - Running main action method: install 08:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:49 INFO - Reading from file tmpfile_stdout 08:14:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:49 INFO - Reading from file tmpfile_stdout 08:14:49 INFO - Output received: 08:14:49 INFO - Usage: mozinstall [options] installer 08:14:49 INFO - Options: 08:14:49 INFO - -h, --help show this help message and exit 08:14:49 INFO - -d DEST, --destination=DEST 08:14:49 INFO - Directory to install application into. [default: 08:14:49 INFO - "/builds/slave/test"] 08:14:49 INFO - --app=APP Application being installed. [default: firefox] 08:14:49 INFO - mkdir: /builds/slave/test/build/application 08:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:15:05 INFO - Reading from file tmpfile_stdout 08:15:05 INFO - Output received: 08:15:05 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:05 INFO - Running post-action listener: _resource_record_post_action 08:15:05 INFO - [mozharness: 2016-09-13 15:15:05.451140Z] Finished install step (success) 08:15:05 INFO - [mozharness: 2016-09-13 15:15:05.451420Z] Running run-tests step. 08:15:05 INFO - Running pre-action listener: _resource_record_pre_action 08:15:05 INFO - Running main action method: run_tests 08:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:05 INFO - Python 2.7.3 08:15:05 INFO - Return code: 0 08:15:05 INFO - grabbing minidump binary from tooltool 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:05 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 0x1183f60>, '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 0x1184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11851d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:05 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 08:15:05 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 08:15:05 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 08:15:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:05 INFO - Return code: 0 08:15:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:05 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/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:15:05 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/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 08:15:05 INFO - Using env: {'DISPLAY': ':0', 08:15:05 INFO - 'HOME': '/home/cltbld', 08:15:05 INFO - 'LANG': 'en_US.UTF-8', 08:15:05 INFO - 'LANGUAGE': 'en_US:en', 08:15:05 INFO - 'LOGNAME': 'cltbld', 08:15:05 INFO - 'MAIL': '/var/mail/cltbld', 08:15:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:05 INFO - 'MOZ_NO_REMOTE': '1', 08:15:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:05 INFO - 'NO_EM_RESTART': '1', 08:15:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:05 INFO - 'PWD': '/builds/slave/test', 08:15:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:05 INFO - 'SHELL': '/bin/bash', 08:15:05 INFO - 'SHLVL': '1', 08:15:05 INFO - 'TERM': 'linux', 08:15:05 INFO - 'TMOUT': '86400', 08:15:05 INFO - 'USER': 'cltbld', 08:15:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897', 08:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:05 INFO - '_': '/tools/buildbot/bin/python'} 08:15:05 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/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:15:05 INFO - mozversion application_buildid: 20160913065007 08:15:05 INFO - mozversion application_changeset: b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd 08:15:05 INFO - mozversion application_display_name: Nightly 08:15:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:05 INFO - mozversion application_name: Firefox 08:15:05 INFO - mozversion application_remotingname: firefox 08:15:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:15:05 INFO - mozversion application_vendor: Mozilla 08:15:05 INFO - mozversion application_version: 51.0a1 08:15:05 INFO - mozversion platform_buildid: 20160913065007 08:15:05 INFO - mozversion platform_changeset: b2166c12cbbe850f8f903e40ffa1f85efc5d8bdd 08:15:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:15:05 INFO - mozversion platform_version: 51.0a1 08:15:05 INFO - using testdate: 1473779705 08:15:05 INFO - actual date: 1473779705 08:15:05 INFO - starting webserver on 'localhost:49062' 08:15:05 INFO - SUITE-START | Running 2 tests 08:15:05 INFO - TEST-START | dromaeo_css 08:15:05 INFO - operating with platform_type : linux_ 08:15:05 INFO - Initialising browser for dromaeo_css test... 08:15:05 INFO - TEST-INFO | started process 15355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvMLNUW/profile http://localhost:49062/getInfo.html) 08:15:10 INFO - PROCESS | 15355 | __metrics Screen width/height:1600/1200 08:15:10 INFO - PROCESS | 15355 | colorDepth:24 08:15:10 INFO - PROCESS | 15355 | Browser inner width/height: 1024/697 08:15:10 INFO - PROCESS | 15355 | __metrics 08:15:11 INFO - PROCESS | 15355 | 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" 08:15:11 INFO - PROCESS | 15355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:11 INFO - PROCESS | 15355 | console.error: PushService: 08:15:11 INFO - PROCESS | 15355 | stateChangeProcessEnqueue: Error transitioning state 08:15:11 INFO - PROCESS | 15355 | UnknownError 08:15:12 INFO - TEST-INFO | 15355: exit 0 08:15:12 INFO - Browser initialized. 08:15:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:12 INFO - TEST-INFO | started process 15438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvMLNUW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:24 INFO - PROCESS | 15438 | RSS: Main: 180039680 08:15:24 INFO - PROCESS | 15438 | 08:16:15 INFO - PROCESS | 15438 | 1473779775448 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] 08:18:28 INFO - PROCESS | 15438 | Cycle 1(1): loaded http://localhost:49062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49062/tests/dromaeo/cssquery-ext.html) 08:18:30 INFO - PROCESS | 15438 | RSS: Main: 351592448 08:18:30 INFO - PROCESS | 15438 | 08:21:33 INFO - PROCESS | 15438 | Cycle 1(1): loaded http://localhost:49062/tests/dromaeo/cssquery-ext.html (next: http://localhost:49062/tests/dromaeo/cssquery-jquery.html) 08:21:34 INFO - PROCESS | 15438 | RSS: Main: 277143552 08:21:34 INFO - PROCESS | 15438 | 08:24:36 INFO - PROCESS | 15438 | Cycle 1(1): loaded http://localhost:49062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49062/tests/dromaeo/cssquery-mootools.html) 08:24:36 INFO - PROCESS | 15438 | RSS: Main: 240668672 08:24:36 INFO - PROCESS | 15438 | 08:27:39 INFO - PROCESS | 15438 | Cycle 1(1): loaded http://localhost:49062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49062/tests/dromaeo/cssquery-prototype.html) 08:27:39 INFO - PROCESS | 15438 | RSS: Main: 219918336 08:27:39 INFO - PROCESS | 15438 | 08:30:42 INFO - PROCESS | 15438 | Cycle 1(1): loaded http://localhost:49062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49062/tests/dromaeo/cssquery-yui.html) 08:30:43 INFO - PROCESS | 15438 | RSS: Main: 218583040 08:30:43 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | Cycle 1(1): loaded http://localhost:49062/tests/dromaeo/cssquery-yui.html (next: http://localhost:49062/tests/dromaeo/cssquery-dojo.html) 08:33:46 INFO - PROCESS | 15438 | RSS: Main: 305946624 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | __start_tp_report 08:33:46 INFO - PROCESS | 15438 | _x_x_mozilla_page_load 08:33:46 INFO - PROCESS | 15438 | _x_x_mozilla_page_load_details 08:33:46 INFO - PROCESS | 15438 | |i|pagename|runs| 08:33:46 INFO - PROCESS | 15438 | |0;dojo.html;2532.9361668099396;2580.832245904017;2581.1095172165597;2597.79217662587;2623.3835048763535;4487.237169681154;4546.408966834315;4566.497685254623;4600.76762106892;4695.953040469599;4569.657275704319;4572.519885412034;4587.81648734051;4631.953680463194;4709.670323077386;4242.745435273878;4260.147970405916;4310;4311.461067366579;4360.520342762294;4296.076343586128;4324.027093903862;4365.49796773372;4378.5183629800695;4388.934165987513;4327.06968001878;4351.630111440531;4366.6506679465565;4381.5618438155925;4402;4163.75017498951;4196.328587425997;4202.516710578261;4220.050488640031;4228.9788551057045;4161.479815023122;4174.3321068628875;4179.519355274152;4256.2338779019765;4275.551067137937;4544.318352247189;4554.2485489894125;4573.131105090022;4591.035882464653;4633.212353899811;4765.309030190638;4812.975935120302;4847.466778654345;4885.218365061609;4907.9263811042865;4902.4852390498845;4945.357103576548;4945.876353091166;4945.876353091166;4994.82518111868;4600.539946005372;4606.470255920545;4622.656105729191;4630;4667.906641867144;4948.925766113512;4997.625178111656;5010.849674509771;5067.087924173684;5112.590992720573;4836.830710925101;4863.659543831898;4867.975660121677;4905.23968784839;4922.827701030446;4932.876678083005;4944.035912996931;4944.936838579651;4946.115251016879;5003.949960500421;4759.524047595212;4795.856124316276;4881.585065269421;4890.315355850184;4951.628627852853;4818.518148185153;4830.033993201374;4836.927446088312;4866.562009419169;4867.9269810952155;4070.3612259670417;4073.674106071507;4100.200460910094;4112.588741125924;4120.91758164841;3625.093726568358;3640.0353906214873;3644.1436262478296;3679.025058359537;3694;4189.036521599988;4235.8729238122905;4265.87202383929;4318.848840290575;4323.978380108079;4927.556519913153;4932.4081110267;4945.480724523945;4988.176950803077;5004.574611158092;4266.552012038691;4297.205017071789;4305.913881722348;4356.869293921188;4362.563743625612;4303.311470164758;4338.501072376654;4360.607545320936;4408.404865343202;4410.889727756768;4676.555727205842;4708.6468514860835;4722.905541889212;4726.172919738963;4764.213904705824;4975.527324904128;4977.328060711758;4985.651004429655;4988.376452943382;5047.444781074152;4583.2437647789075;4707.8587642370785;4722.338872557913;4725.8582242532775;4786.688865223749;4778.211595086772;4821.63837712166;4842.17682993899;4853.102176097434;4854.077725232195;4905.8037678492465;4912.336834527436;4917.483664215349;4920.138975679313;4952.678075925053;4763.73799441034;4799.040191961692;4807.18277892766;4809.3026511154985;4867.026594681007;4695.882602934817;4726.1020406122725;4778.593819525379;4778.713277203379;4792.904141917212;4743.1225223333795;4747.477777444409;4749.9287510688055;4751.691140075884;4800.975995120002;4715.905681886412;4770.427548694179;4811.08589368019;4844.660873738804;4864.683795553277;4696.342512048248;4727.976360118315;4738.644601654821;4741.170295198395;4741.431028276629 08:33:46 INFO - PROCESS | 15438 | |1;ext.html;567.6707509644407;567.8722287485316;569.8262030080825;573.8393249890032;584.5761822678556;27581.862090689545;38126.428103578466;39313.60686393135;39355.212895742065;42884;40606.59393406072;40983.38524922128;41018.58981410185;41021.99999999993;41053.17893642125;7652.808679783022;7809.140994490602;7811.4922530035365;7817.921820781805;7818.061832580099;7272.2364151764095;7447.4786764926475;9712.125908668218;9981.850272245885;9982.750431239241;9979.251556133318;10058.396496210251;10064.849027264598;10080.34477758947;10082.798344033115;9949.651762188325;9996.350237234556;10004.399736015863;10004.449755263422;10009.849852252222;9554.04459554046;9558.426494410358;9603.711888643353;9622.75943101421;9625.759356016086;37195;37316.813415933015;37491.4376284356;37508.24983500342;37515;2654.296611397981;2814.366767477322;2930.633670791151;3122.4847900096456;3148.134263077649;28284.85857570699;28523.286917827012;28660.570091448644;29037.709622903712;29710.40579188404;3091.2580980564726;3228.386606544749;3288.342331533679;3289;3341.398548261312;245787;245997;246258;246466;246915;30873.69126308753;31228.531572026437;31569.526457103162;52016.47983520192;52244.47755522396;32683.509747353808;33016.50475242873;33044;33060.834695826365;33062.3387532248;13669.794953075712;13759.587212383645;13813.447462101403;13818.654533636538;13819;9878;9954.104130628279;11432.828507572392;11521.539138434537;11549.307041577533;7596.734114306083;7740.109887362913;7756.828088135331;7821.5698136601895;7856.84286314282;2998.4902566563737;3005.2637103909246;3076.077176846937;3083.5837161982845;3086.5987421635045;814.951102933814;865.523961820996;869.5956380283072;870.656090844113;923.3813345058827;26260;27299.727002730117;27464.313392164957;27726.722732772414;28181.43637127246;860.2558786649503;888.9911100889037;935.0088905759781;977.3695966101825;1009.5204777730519;14082.577522674335;14303.356348964322;14494.782578261334;14897;14997.2501374933;356025;358073;358296;359503;360001;47483;47865.282020769715;47931.760341198766;47943;47946;1019.1031891935049;1067.813132701774;1102.3220719257438;1150.6260465348628;1165.9825102623297;25413.110541130973;28492.857535712188;28571.996284319594;28814.711852881203;28892.27769305784;40650.79674601608;41108.76673699794;41140.382894256014;41189;41418;281185;282289;282466;283966;284021;24050.51898962046;24390;24655.137070202458;24799.876000619883;25749.3562660935;40364.19271614493;40448;40788;40856.79571602123;41506.79246603748;34778;34778.82610586931;34925.47611785876;34957.65042349646;35137;34804.303913922085;35249.82375088108;35278.47082293716;35400.29199415946;35579.822100890364;34663.48004779981;34722.131946701535;35351.469727954616;35861.1034724134;35864.46203307005;30748.231294217825;32307;32694.67305326916;32726.83636581897;32989.34021319608;23804.642930355712;24035.27894163178;24679.669632781115;24684;25188.11841585536 08:33:46 INFO - PROCESS | 15438 | |2;jquery.html;340.3550272234118;342.8440059772805;345.8772135891758;349.25434197987295;373.48832100022975;12113.939430302848;15531.223438828056;15680.137592432426;15953.920230398831;17159.571010724707;15727.84272157281;16189.109598972082;16762;16837.494875153734;16978.660426791455;4886.291487734276;4939.950600493994;5049.283243697142;5092.185250359943;5183.092958732225;3698.611645777195;3853.421986701989;4983.352164218646;5062.341895553592;5067.442581316071;3915.158240978189;3926.27363937671;3926.293267211901;5588.273524441817;5904;4805.75971201442;5071.619628527838;5967.433093856077;6003.489703375219;6003.789867354665;5013.623978201649;5020.322256495363;5023.799048038074;5024.874378140539;5026.773795179226;11583.18917675763;11713.648590542298;11732.472038758277;11779.764404711943;11849.17055806094;1725.5772335777815;1771.477414162825;1892.9053547322717;2018.9394318170332;2422.140140250221;9314.487703176323;9589.712308630682;9886.752831179207;10164.745881353025;13329.933350333284;1677.9161041947975;1688.1981058997;1718.3727939302064;1726.6719323328653;1733.1161107834969;64022.67988660074;68450;69153.65423172903;69743.65128174378;70700;8945.686900958566;8961.910380896108;9035.457872527539;9188.770280743034;9608.375455595364;12555.435005424777;12563.874361256454;12579.496820127093;12593.37033148339;12600.558980435824;6865.759698410531;6989.545679530815;7007.334303241184;7207.351338379466;7223.638818059076;6823.420009299265;6831.658417079127;7040.401565866856;7068;7077.964610176916;3733.794641294755;3839.117003089305;3842.0779013037227;3950.585188555218;3963.6432721055244;1600.2958698172768;1607.710612089835;1613.8708903287709;1790.4897104325205;1823.5441139715072;770.4260326057012;822.9053658829191;862.2239984014437;890.9910900890908;904.7873749668822;16046.839531604768;16514.83485165157;16954.830451695572;17350.826491735173;17409.82590174082;780.1330111838969;787.9842403151905;818.7993941484256;830.3606223208096;912.543728135932;9008.819823603622;9177.541122943827;9579.233661307078;9595.808083838423;9619.56711947964;354966;359745;361428;364199;366311;73194.26805731982;74266.25733742594;74920;75965.6201718999;76220.61889690626;787.4763282417243;832.7751507093051;833.1751565949667;833.7957200485798;840.8234270803077;15103.4713785017;15274.465393711167;15401.691966160839;15467.613309667347;16048.839511604734;36100.27799444049;37172.62827371692;37579.624203757616;37995;38251;51420.74289628528;53612;54091.72954135204;54309;54913;6799.864002720017;6808.183018037867;6931.965340173267;6966.721331146698;7293.452991025588;9129.908700912905;9902.653407130716;10259.179265658879;10413.42726150069;10599.48043706736;8101.797455063671;8338.958305208434;8710.47737135774;8729.301655867388;8749.343799214957;9626.66306679291;9693.612255509983;9771.169450596779;9793.314467987173;9940.850887236553;9188.540572971191;9326.440413575207;9495.14543691071;9562.808743825224;10038.1467575254;6365.140706004815;6452.548321617442;6869.519133660596;6911.965440172767;6915.135608048994;7139.82150446243;7863.174366691415;7868.291853733192;8137.226963438464;8175.754727358189 08:33:46 INFO - PROCESS | 15438 | |3;mootools.html;1183.2368122560943;1314.5661931562581;1346.07793661342;1380.2201756007855;1625.6342322977325;6661.4670826333895;7230.963845180773;7579;7605.04936882889;7610.581418022007;7415.814604634887;7573.431992600549;7574.280443357872;7726.652300646484;7728.381729461629;2080.8231300339453;2119.8092171704543;2124.925627603034;2125.2561603438826;2126.9893650531726;2103.085157956294;2139.465133716571;2188.5075857931997;2195.835312351572;2196.286206982729;2141.0579345088113;2144.4317255927112;2156.9352919412445;2158.902849371782;2195.6157672407344;2131.2540610786255;2131.435169680036;2133.477298061969;2134.7758485359045;2143.8177754890776;2044.2436298569476;2114.904829282686;2115.6297647911556;2117.502386939068;2123.288698286076;7665.8850117248285;7715.382769378492;7746.30283274508;7767.805804854867;7774.65014074368;4406.515283318832;4418.668599854992;4552.021315417202;4554.43069616298;4559.475660299075;2839.7018313077037;2917.081119447367;2926.2976885547528;2936.309967157716;2943.249471384783;863.6459051788736;879.6525372477836;881.7266647339345;886.7517095213351;888.1739981816908;10510.737231569196;10654.733631659194;10729.9463502682;10739.785204295871;10779.6766097018;3982.6216509431556;4026.5570787213383;4169.187008533307;4193.098483825992;4252.681048921343;9188.310876684141;9195.310351723647;9197.310201734897;9204.309676774268;9208.723738287863;4689.20283551797;4690.273007683814;4692.671512994058;4694.718316900997;4700.647451441156;3689.3912504437003;3818.503594532693;4075.409065685459;4256.191323648559;4276.935845962313;3572.4284114541547;3596.956882504097;3733.533308336458;3744.3634582121103;3754.3617585010616;1175.8295047218105;1225.8651548329676;1234.950601975911;1237.9814302785464;1238.2694210415718;733.3216774483582;733.3326672727899;750.8498300339954;754.7094368668103;758.1243663568587;4592;4604.378408914754;4698.859034228979;4735.2186889163595;4741.857744267678;373.0691923650509;385.4276399546671;395.0459639969442;399.0263756434291;401.2676864721836;3034.302110514594;3096.90709278722;3146.276356438032;3170.77804553679;3318.445423708603;9115.589798459085;9537.141657250742;9539.856902146474;9542.3320367575;9543.9045609543;9490.952545237229;9503.477308747946;9514.38156519824;9516.524173791422;9521.52416375463;7007.404370628554;7136.678849451787;7205.351518363268;7262.491625586264;7270.600116993511;4632.235681112578;4634.9304760429295;4681.180793361216;4681.602063824613;4818.7831547581145;8495.447795893248;8587.82824343522;8722.781930451789;8789.208971192624;8832.072632373509;8807.119288071142;8835.425697329652;8923.687670931486;8937.553122343726;8982.056884027344;5998.610090344114;6071.635701857903;6571.704273307808;6635.734570617121;6641.369069938348;7355.7057717690695;7466.36535894455;7535.585542795199;7543.207963163789;7548.924045887425;6618.801435956929;6619;6720.6975686093265;6759.425448836904;6944.201416837129;6625.4037136657935;6636.838553253065;6756.121704178426;6759.2564817869015;6805.081314022742;5878.823635290948;5977.850553736192;5980.474978880357;5983.192269043798;5988.4909782668965;4040.5041708589897;4090.1410703752545;4125;4128.628423441784;4326.1563995021925;4248.192843359751;4271.444712187395;4318.265894797954;4355.651547876099;4512.029913568598 08:33:46 INFO - PROCESS | 15438 | |4;prototype.html;287.4595759971254;291.0613272197164;291.4011705944286;292.8286952133002;293.528886137749;4628.67599268051;4637.327587499811;4648.976755116224;4659.790309436075;4686.6953648012895;4544.159330523856;4581.244094724367;4598.333241679954;4601.930971035429;4633.142868569309;3505.7020153287003;3580.946285805715;3610.620884807097;3688.926221475569;3694.408894576868;3638.781673099609;3664.175560498893;3671.8347674354586;3682.1899182179877;3685.7419980601367;3652.1600031992657;3654.963450365502;3670.834812433447;3675.8529658813613;3676.448532720087;3500.299940012008;3533.5406397168463;3600.4959305697225;3622.655847694478;3664.5968943416337;3201.471757160066;3203.759718021158;3216.694414030663;3229.5963004624423;3231.7396215475983;4539.341795439643;4540.048968170716;4541.45502539694;4542.092321225094;4548.863534093983;4027.6979226557833;4125.360569111793;4134.152498737782;4139.668826493873;4148.854790082332;4783.425988881322;4813.4356334191525;4815.253635686474;4816.8795780105775;4817.470078291421;3408.3353746019534;3411.3347897160065;3413.5050417689545;3413.6586341365914;3426.417509023472;5047.2429135629945;5052.69683818972;5056.494350564951;5077.974610126926;5092.974535127338;3420;3496.265784185299;3527.506149139071;3528.1532432216595;3536.1159710072484;3568.518250036264;3571.3035957988463;3576.302620988882;3580.5524309461316;3586.6951309139017;4085.1216988347646;4087.9182416351505;4103.322951712994;4103.440692536877;4126.587341265909;4727.172744769651;4804.975975120102;4811.477211421253;4827.25177597473;4843.564079232886;1261.713052686255;1269.7016201192712;1281.3401098434315;1282.5190553542423;1285.2930888011556;770.8535378278109;831.4304701279643;833.2750507058777;836.5858899844616;842.1410161635221;3883.7863917484246;3902.921941561153;4122.113745544662;4244.681648876347;4289.356596510486;5010.323606313174;5020.171671674206;5023.14606516893;5030.119729047402;5033.748312584356;4390.517043125254;4399.14216727735;4400.361947517656;4403.229434848889;4405.669574781904;2562.2313306008123;2625.9868700656375;2644.9603255951174;2656.654634897451;2662.281184080326;4749.667523273338;4761.285807128889;4765.571098601143;4786.779371260306;4790.449098353734;5113;5128.358955130609;5136.1525348317855;5137.2037334213255;5144.61415393847;4499.820007199741;4747.145513807479;4780.378550788375;4781.330613714083;4800.3759511263315;5048.990201959697;5074.086664400444;5074.416442109057;5075.137226671549;5081.568066714371;4954.603631709382;4967.751612419437;4973.651844370859;4979.278004689228;4980.676256043345;4669.60308373792;4774.164521208844;4815.879603009953;4820.566149046603;4825.469198388104;3529.541159649229;3538.734594905341;3540.4689296605716;3545.4327307630656;3555.3422616815974;5040.747962601782;5051.625735904119;5075.213341932006;5076.543111120017;5076.6446348755235;4747.596454301423;4932.8766780830765;4945.431275403231;4956.058348913695;4963.70217786934;4887.853364399074;4891.608671306216;4899.314096026488;4901.5588597026435;4923.8276660316715;4850.393700787402;4857.514248575114;4861.854144375674;4866.367372241586;4866.367372241586;4728.574428301332;4731.668783185144;4920.5571498565305;4931.235658472942;4953.702777833341;4642.93035604473;4760.88097797544;4808.783604737865;4815.686980346266;4832.20268655682 08:33:46 INFO - PROCESS | 15438 | |5;yui.html;535.2159086937638;560.271646859083;567.9687617181054;582.6009183709158;615.3139249736544;12563.623091307263;13236;13279.53521626742;13792.724145517084;13817;12572.559960401388;13320.333983300821;13482.12366196199;13498.932505337483;13554.322283885791;721.9566825990431;743.4572761883828;746.261201410605;748.4910261022502;748.5134662469384;590.9763609455616;606.378462076373;728.3262981741894;746.8842329438919;750.8535835512077;790.2137373313561;790.3913986230627;790.7667238164755;792.2631952284373;792.5759718550548;784.701813310941;784.9411294152961;785.0304873481247;785.0540099180474;785.2461636828651;457.9175748365293;466.3540995720917;560.6888177061729;572.421853927532;575.4274496875594;13136.34318284082;13172.802407963889;13178.209307441488;13194.142380745221;13201.86798132016;11144.888551114465;11291.548338066468;12256.81614775779;13113.606591802261;13324.067315287934;11796.954919701704;11806.881931180664;11844.644660660195;11946.044316454663;11982.400879955967;3997.2605068062503;4027.5117361572907;4107.609777071173;4149.232392007458;4183.958160418418;70944.29055709428;71670;71765.64117179433;71788.28211717868;71911.92132118075;9476.620935162655;9551;9793.363431376938;10100;10230.23273254509;18183.363582274556;18256.087195640164;18482.966873643887;18508.537286567942;18554.350597729015;6321.841953951188;6376.202974628171;6443.6455994920725;6446.097546343516;6833.3166683332265;3541;3565.4295312749837;3584.605693373727;3585.3904836177912;3585.4980302757635;2855.0150198181595;2969.213158512996;2969.346743716379;2972.435237304905;2975.330550626135;480.8653576998376;483.1568912248079;487.14992338369063;499.08168969097034;505.2043032224262;413.6194700875202;422.58164417226726;428.7620370694295;459.21474278982646;469.88957594965154;6033.185519954838;6386.36136386367;6444.613323200623;6588.604683718992;6980.197277313174;380.7296819258302;401.98593049243135;401.9939700904489;405.3757213890634;407.5130219387803;3096.752259819209;3103.7051480109353;3152.653208147102;3272.8363581820813;3356.110630682871;80472.59763701144;80871.19128808637;82781.58609206915;83602.58198708968;102739;69299;82659.17340826515;83209.3358132834;85983;89340;48305.51694483081;65285;78561.60719196367;79207;79454.60272698599;7121.465890058163;7371.115466144097;7432.368248698921;7499.587522686086;7537.510061845963;42410.57589424066;46745;46791.29813052875;46852;48893.755531222116;41378.79310603548;57280;58383;65387.019194713066;69473;10740;10826.188035897181;10934.179936504635;11180.385078820744;11360.318380897173;11323;11425.164575829089;11811.527538898348;12061.162201321473;12089.637310880336;9180.403273787182;9393.107654772786;9512.33413661037;9809.215262779104;9836.3606365586;10049.89950100519;10219.284650074424;10399.376037437778;10549.736256593647;10717.464126793786;9353.532323383668;9389.38968967015;9393.624255029723;9626.085521875411;9772.706818795448;9262.44425334482;9538.284628653018;9709.22326213887;9847.409155450696;9921.25590580695;8292.460990035628;8314.293285070837;8942.597583108645;8987.236084932854;9171.451764717727 08:33:46 INFO - PROCESS | 15438 | __end_tp_report 08:33:46 INFO - PROCESS | 15438 | __start_cc_report 08:33:46 INFO - PROCESS | 15438 | _x_x_mozilla_cycle_collect,1802 08:33:46 INFO - PROCESS | 15438 | __end_cc_report 08:33:46 INFO - PROCESS | 15438 | __startTimestamp1473780826815__endTimestamp 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | ------- Summary: start ------- 08:33:46 INFO - PROCESS | 15438 | Number of tests: 6 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | [#0] dojo.html Cycles:165 Average:4558.88 Median:4722.34 stddev:471.19 (10.0%) stddev-sans-first:445.03 08:33:46 INFO - PROCESS | 15438 | Values: 2532.9 2580.8 2581.1 2597.8 2623.4 4487.2 4546.4 4566.5 4600.8 4696.0 4569.7 4572.5 4587.8 4632.0 4709.7 4242.7 4260.1 4310.0 4311.5 4360.5 4296.1 4324.0 4365.5 4378.5 4388.9 4327.1 4351.6 4366.7 4381.6 4402.0 4163.8 4196.3 4202.5 4220.1 4229.0 4161.5 4174.3 4179.5 4256.2 4275.6 4544.3 4554.2 4573.1 4591.0 4633.2 4765.3 4813.0 4847.5 4885.2 4907.9 4902.5 4945.4 4945.9 4945.9 4994.8 4600.5 4606.5 4622.7 4630.0 4667.9 4948.9 4997.6 5010.8 5067.1 5112.6 4836.8 4863.7 4868.0 4905.2 4922.8 4932.9 4944.0 4944.9 4946.1 5003.9 4759.5 4795.9 4881.6 4890.3 4951.6 4818.5 4830.0 4836.9 4866.6 4867.9 4070.4 4073.7 4100.2 4112.6 4120.9 3625.1 3640.0 3644.1 3679.0 3694.0 4189.0 4235.9 4265.9 4318.8 4324.0 4927.6 4932.4 4945.5 4988.2 5004.6 4266.6 4297.2 4305.9 4356.9 4362.6 4303.3 4338.5 4360.6 4408.4 4410.9 4676.6 4708.6 4722.9 4726.2 4764.2 4975.5 4977.3 4985.7 4988.4 5047.4 4583.2 4707.9 4722.3 4725.9 4786.7 4778.2 4821.6 4842.2 4853.1 4854.1 4905.8 4912.3 4917.5 4920.1 4952.7 4763.7 4799.0 4807.2 4809.3 4867.0 4695.9 4726.1 4778.6 4778.7 4792.9 4743.1 4747.5 4749.9 4751.7 4801.0 4715.9 4770.4 4811.1 4844.7 4864.7 4696.3 4728.0 4738.6 4741.2 4741.4 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | [#1] ext.html Cycles:180 Average:43964.75 Median:34692.81 stddev:78705.29 (226.9%) stddev-sans-first:78858.63 08:33:46 INFO - PROCESS | 15438 | Values: 567.7 567.9 569.8 573.8 584.6 27581.9 38126.4 39313.6 39355.2 42884.0 40606.6 40983.4 41018.6 41022.0 41053.2 7652.8 7809.1 7811.5 7817.9 7818.1 7272.2 7447.5 9712.1 9981.9 9982.8 9979.3 10058.4 10064.8 10080.3 10082.8 9949.7 9996.4 10004.4 10004.4 10009.8 9554.0 9558.4 9603.7 9622.8 9625.8 37195.0 37316.8 37491.4 37508.2 37515.0 2654.3 2814.4 2930.6 3122.5 3148.1 28284.9 28523.3 28660.6 29037.7 29710.4 3091.3 3228.4 3288.3 3289.0 3341.4 245787.0 245997.0 246258.0 246466.0 246915.0 30873.7 31228.5 31569.5 52016.5 52244.5 32683.5 33016.5 33044.0 33060.8 33062.3 13669.8 13759.6 13813.4 13818.7 13819.0 9878.0 9954.1 11432.8 11521.5 11549.3 7596.7 7740.1 7756.8 7821.6 7856.8 2998.5 3005.3 3076.1 3083.6 3086.6 815.0 865.5 869.6 870.7 923.4 26260.0 27299.7 27464.3 27726.7 28181.4 860.3 889.0 935.0 977.4 1009.5 14082.6 14303.4 14494.8 14897.0 14997.3 356025.0 358073.0 358296.0 359503.0 360001.0 47483.0 47865.3 47931.8 47943.0 47946.0 1019.1 1067.8 1102.3 1150.6 1166.0 25413.1 28492.9 28572.0 28814.7 28892.3 40650.8 41108.8 41140.4 41189.0 41418.0 281185.0 282289.0 282466.0 283966.0 284021.0 24050.5 24390.0 24655.1 24799.9 25749.4 40364.2 40448.0 40788.0 40856.8 41506.8 34778.0 34778.8 34925.5 34957.7 35137.0 34804.3 35249.8 35278.5 35400.3 35579.8 34663.5 34722.1 35351.5 35861.1 35864.5 30748.2 32307.0 32694.7 32726.8 32989.3 23804.6 24035.3 24679.7 24684.0 25188.1 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | [#2] jquery.html Cycles:180 Average:22873.55 Median:28301.92 stddev:59957.81 (211.9%) stddev-sans-first:60102.13 08:33:46 INFO - PROCESS | 15438 | Values: 340.4 342.8 345.9 349.3 373.5 12113.9 15531.2 15680.1 15953.9 17159.6 15727.8 16189.1 16762.0 16837.5 16978.7 4886.3 4940.0 5049.3 5092.2 5183.1 3698.6 3853.4 4983.4 5062.3 5067.4 3915.2 3926.3 3926.3 5588.3 5904.0 4805.8 5071.6 5967.4 6003.5 6003.8 5013.6 5020.3 5023.8 5024.9 5026.8 11583.2 11713.6 11732.5 11779.8 11849.2 1725.6 1771.5 1892.9 2018.9 2422.1 9314.5 9589.7 9886.8 10164.7 13329.9 1677.9 1688.2 1718.4 1726.7 1733.1 64022.7 68450.0 69153.7 69743.7 70700.0 8945.7 8961.9 9035.5 9188.8 9608.4 12555.4 12563.9 12579.5 12593.4 12600.6 6865.8 6989.5 7007.3 7207.4 7223.6 6823.4 6831.7 7040.4 7068.0 7078.0 3733.8 3839.1 3842.1 3950.6 3963.6 1600.3 1607.7 1613.9 1790.5 1823.5 770.4 822.9 862.2 891.0 904.8 16046.8 16514.8 16954.8 17350.8 17409.8 780.1 788.0 818.8 830.4 912.5 9008.8 9177.5 9579.2 9595.8 9619.6 354966.0 359745.0 361428.0 364199.0 366311.0 73194.3 74266.3 74920.0 75965.6 76220.6 787.5 832.8 833.2 833.8 840.8 15103.5 15274.5 15401.7 15467.6 16048.8 36100.3 37172.6 37579.6 37995.0 38251.0 51420.7 53612.0 54091.7 54309.0 54913.0 6799.9 6808.2 6932.0 6966.7 7293.5 9129.9 9902.7 10259.2 10413.4 10599.5 8101.8 8339.0 8710.5 8729.3 8749.3 9626.7 9693.6 9771.2 9793.3 9940.9 9188.5 9326.4 9495.1 9562.8 10038.1 6365.1 6452.5 6869.5 6912.0 6915.1 7139.8 7863.2 7868.3 8137.2 8175.8 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | [#3] mootools.html Cycles:180 Average:4994.06 Median:4685.40 stddev:2878.01 (61.4%) stddev-sans-first:2871.83 08:33:46 INFO - PROCESS | 15438 | Values: 1183.2 1314.6 1346.1 1380.2 1625.6 6661.5 7231.0 7579.0 7605.0 7610.6 7415.8 7573.4 7574.3 7726.7 7728.4 2080.8 2119.8 2124.9 2125.3 2127.0 2103.1 2139.5 2188.5 2195.8 2196.3 2141.1 2144.4 2156.9 2158.9 2195.6 2131.3 2131.4 2133.5 2134.8 2143.8 2044.2 2114.9 2115.6 2117.5 2123.3 7665.9 7715.4 7746.3 7767.8 7774.7 4406.5 4418.7 4552.0 4554.4 4559.5 2839.7 2917.1 2926.3 2936.3 2943.2 863.6 879.7 881.7 886.8 888.2 10510.7 10654.7 10729.9 10739.8 10779.7 3982.6 4026.6 4169.2 4193.1 4252.7 9188.3 9195.3 9197.3 9204.3 9208.7 4689.2 4690.3 4692.7 4694.7 4700.6 3689.4 3818.5 4075.4 4256.2 4276.9 3572.4 3597.0 3733.5 3744.4 3754.4 1175.8 1225.9 1235.0 1238.0 1238.3 733.3 733.3 750.8 754.7 758.1 4592.0 4604.4 4698.9 4735.2 4741.9 373.1 385.4 395.0 399.0 401.3 3034.3 3096.9 3146.3 3170.8 3318.4 9115.6 9537.1 9539.9 9542.3 9543.9 9491.0 9503.5 9514.4 9516.5 9521.5 7007.4 7136.7 7205.4 7262.5 7270.6 4632.2 4634.9 4681.2 4681.6 4818.8 8495.4 8587.8 8722.8 8789.2 8832.1 8807.1 8835.4 8923.7 8937.6 8982.1 5998.6 6071.6 6571.7 6635.7 6641.4 7355.7 7466.4 7535.6 7543.2 7548.9 6618.8 6619.0 6720.7 6759.4 6944.2 6625.4 6636.8 6756.1 6759.3 6805.1 5878.8 5977.9 5980.5 5983.2 5988.5 4040.5 4090.1 4125.0 4128.6 4326.2 4248.2 4271.4 4318.3 4355.7 4512.0 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | [#4] prototype.html Cycles:180 Average:4050.19 Median:4630.91 stddev:1181.20 (25.5%) stddev-sans-first:1150.25 08:33:46 INFO - PROCESS | 15438 | Values: 287.5 291.1 291.4 292.8 293.5 4628.7 4637.3 4649.0 4659.8 4686.7 4544.2 4581.2 4598.3 4601.9 4633.1 3505.7 3580.9 3610.6 3688.9 3694.4 3638.8 3664.2 3671.8 3682.2 3685.7 3652.2 3655.0 3670.8 3675.9 3676.4 3500.3 3533.5 3600.5 3622.7 3664.6 3201.5 3203.8 3216.7 3229.6 3231.7 4539.3 4540.0 4541.5 4542.1 4548.9 4027.7 4125.4 4134.2 4139.7 4148.9 4783.4 4813.4 4815.3 4816.9 4817.5 3408.3 3411.3 3413.5 3413.7 3426.4 5047.2 5052.7 5056.5 5078.0 5093.0 3420.0 3496.3 3527.5 3528.2 3536.1 3568.5 3571.3 3576.3 3580.6 3586.7 4085.1 4087.9 4103.3 4103.4 4126.6 4727.2 4805.0 4811.5 4827.3 4843.6 1261.7 1269.7 1281.3 1282.5 1285.3 770.9 831.4 833.3 836.6 842.1 3883.8 3902.9 4122.1 4244.7 4289.4 5010.3 5020.2 5023.1 5030.1 5033.7 4390.5 4399.1 4400.4 4403.2 4405.7 2562.2 2626.0 2645.0 2656.7 2662.3 4749.7 4761.3 4765.6 4786.8 4790.4 5113.0 5128.4 5136.2 5137.2 5144.6 4499.8 4747.1 4780.4 4781.3 4800.4 5049.0 5074.1 5074.4 5075.1 5081.6 4954.6 4967.8 4973.7 4979.3 4980.7 4669.6 4774.2 4815.9 4820.6 4825.5 3529.5 3538.7 3540.5 3545.4 3555.3 5040.7 5051.6 5075.2 5076.5 5076.6 4747.6 4932.9 4945.4 4956.1 4963.7 4887.9 4891.6 4899.3 4901.6 4923.8 4850.4 4857.5 4861.9 4866.4 4866.4 4728.6 4731.7 4920.6 4931.2 4953.7 4642.9 4760.9 4808.8 4815.7 4832.2 08:33:46 INFO - PROCESS | 15438 | 08:33:46 INFO - PROCESS | 15438 | [#5] yui.html Cycles:180 Average:17139.18 Median:502.14 stddev:24626.25 (4904.2%) stddev-sans-first:24663.77 08:33:46 INFO - PROCESS | 15438 | Values: 535.2 560.3 568.0 582.6 615.3 12563.6 13236.0 13279.5 13792.7 13817.0 12572.6 13320.3 13482.1 13498.9 13554.3 722.0 743.5 746.3 748.5 748.5 591.0 606.4 728.3 746.9 750.9 790.2 790.4 790.8 792.3 792.6 784.7 784.9 785.0 785.1 785.2 457.9 466.4 560.7 572.4 575.4 13136.3 13172.8 13178.2 13194.1 13201.9 11144.9 11291.5 12256.8 13113.6 13324.1 11797.0 11806.9 11844.6 11946.0 11982.4 3997.3 4027.5 4107.6 4149.2 4184.0 70944.3 71670.0 71765.6 71788.3 71911.9 9476.6 9551.0 9793.4 10100.0 10230.2 18183.4 18256.1 18483.0 18508.5 18554.4 6321.8 6376.2 6443.6 6446.1 6833.3 3541.0 3565.4 3584.6 3585.4 3585.5 2855.0 2969.2 2969.3 2972.4 2975.3 480.9 483.2 487.1 499.1 505.2 413.6 422.6 428.8 459.2 469.9 6033.2 6386.4 6444.6 6588.6 6980.2 380.7 402.0 402.0 405.4 407.5 3096.8 3103.7 3152.7 3272.8 3356.1 80472.6 80871.2 82781.6 83602.6 102739.0 69299.0 82659.2 83209.3 85983.0 89340.0 48305.5 65285.0 78561.6 79207.0 79454.6 7121.5 7371.1 7432.4 7499.6 7537.5 42410.6 46745.0 46791.3 46852.0 48893.8 41378.8 57280.0 58383.0 65387.0 69473.0 10740.0 10826.2 10934.2 11180.4 11360.3 11323.0 11425.2 11811.5 12061.2 12089.6 9180.4 9393.1 9512.3 9809.2 9836.4 10049.9 10219.3 10399.4 10549.7 10717.5 9353.5 9389.4 9393.6 9626.1 9772.7 9262.4 9538.3 9709.2 9847.4 9921.3 8292.5 8314.3 8942.6 8987.2 9171.5 08:33:46 INFO - PROCESS | 15438 | -------- Summary: end -------- 08:33:46 INFO - PROCESS | 15438 | 08:33:47 INFO - TEST-INFO | 15438: exit 0 08:33:47 INFO - TEST-OK | dromaeo_css | took 1122149ms 08:33:47 INFO - TEST-START | kraken 08:33:47 INFO - operating with platform_type : linux_ 08:33:47 INFO - Initialising browser for kraken test... 08:33:47 INFO - TEST-INFO | started process 15745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYK_LnN/profile http://localhost:49062/getInfo.html) 08:33:52 INFO - PROCESS | 15745 | __metrics Screen width/height:1600/1200 08:33:52 INFO - PROCESS | 15745 | colorDepth:24 08:33:52 INFO - PROCESS | 15745 | Browser inner width/height: 1024/697 08:33:52 INFO - PROCESS | 15745 | __metrics 08:33:53 INFO - PROCESS | 15745 | 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" 08:33:53 INFO - PROCESS | 15745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:53 INFO - PROCESS | 15745 | console.error: PushService: 08:33:53 INFO - PROCESS | 15745 | stateChangeProcessEnqueue: Error transitioning state 08:33:53 INFO - PROCESS | 15745 | UnknownError 08:33:54 INFO - TEST-INFO | 15745: exit 0 08:33:54 INFO - Browser initialized. 08:33:54 INFO - Running cycle 1/1 for kraken test... 08:33:54 INFO - TEST-INFO | started process 15826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYK_LnN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:06 INFO - PROCESS | 15826 | RSS: Main: 175988736 08:34:06 INFO - PROCESS | 15826 | 08:34:09 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49062/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:10 INFO - PROCESS | 15826 | RSS: Main: 237953024 08:34:10 INFO - PROCESS | 15826 | 08:34:13 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49062/tests/kraken/driver.html?testName=audio-dft) 08:34:13 INFO - PROCESS | 15826 | RSS: Main: 218566656 08:34:13 INFO - PROCESS | 15826 | 08:34:17 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49062/tests/kraken/driver.html?testName=audio-fft) 08:34:17 INFO - PROCESS | 15826 | RSS: Main: 300257280 08:34:17 INFO - PROCESS | 15826 | 08:34:20 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49062/tests/kraken/driver.html?testName=audio-oscillator) 08:34:20 INFO - PROCESS | 15826 | RSS: Main: 209711104 08:34:20 INFO - PROCESS | 15826 | 08:34:22 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:23 INFO - PROCESS | 15826 | RSS: Main: 213966848 08:34:23 INFO - PROCESS | 15826 | 08:34:26 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49062/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:27 INFO - PROCESS | 15826 | RSS: Main: 250142720 08:34:27 INFO - PROCESS | 15826 | 08:34:30 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49062/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:31 INFO - PROCESS | 15826 | RSS: Main: 243740672 08:34:31 INFO - PROCESS | 15826 | 08:34:34 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49062/tests/kraken/driver.html?testName=json-parse-financial) 08:34:34 INFO - PROCESS | 15826 | RSS: Main: 247480320 08:34:34 INFO - PROCESS | 15826 | 08:34:36 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:37 INFO - PROCESS | 15826 | RSS: Main: 210522112 08:34:37 INFO - PROCESS | 15826 | 08:34:39 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:39 INFO - PROCESS | 15826 | RSS: Main: 218820608 08:34:39 INFO - PROCESS | 15826 | 08:34:41 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:42 INFO - PROCESS | 15826 | RSS: Main: 223002624 08:34:42 INFO - PROCESS | 15826 | 08:34:45 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:46 INFO - PROCESS | 15826 | RSS: Main: 224051200 08:34:46 INFO - PROCESS | 15826 | 08:34:49 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:49 INFO - PROCESS | 15826 | RSS: Main: 221790208 08:34:49 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | Cycle 1(1): loaded http://localhost:49062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49062/tests/kraken/driver.html?testName=ai-astar) 08:34:51 INFO - PROCESS | 15826 | RSS: Main: 272334848 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | __start_tp_report 08:34:51 INFO - PROCESS | 15826 | _x_x_mozilla_page_load 08:34:51 INFO - PROCESS | 15826 | _x_x_mozilla_page_load_details 08:34:51 INFO - PROCESS | 15826 | |i|pagename|runs| 08:34:51 INFO - PROCESS | 15826 | |0;ai-astar;114;117;116;116;114;117;116;114;113;114 08:34:51 INFO - PROCESS | 15826 | |1;audio-beat-detection;150;128;127;164;137;125;125;122;155;129 08:34:51 INFO - PROCESS | 15826 | |2;audio-dft;161;160;162;162;164;163;164;163;164;162 08:34:51 INFO - PROCESS | 15826 | |3;audio-fft;77;77;76;109;76;77;77;78;100;77 08:34:51 INFO - PROCESS | 15826 | |4;audio-oscillator;85;84;123;84;83;84;122;84;85;119 08:34:51 INFO - PROCESS | 15826 | |5;imaging-gaussian-blur;117;118;117;116;117;116;117;117;117;117 08:34:51 INFO - PROCESS | 15826 | |6;imaging-darkroom;146;146;147;146;146;146;148;146;146;146 08:34:51 INFO - PROCESS | 15826 | |7;imaging-desaturate;95;95;97;94;95;96;95;95;95;96 08:34:51 INFO - PROCESS | 15826 | |8;json-parse-financial;65;64;64;65;64;64;64;66;66;65 08:34:51 INFO - PROCESS | 15826 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;65;65;65 08:34:51 INFO - PROCESS | 15826 | |10;stanford-crypto-aes;84;83;88;84;87;82;82;83;89;82 08:34:51 INFO - PROCESS | 15826 | |11;stanford-crypto-ccm;145;147;150;131;134;134;139;131;177;132 08:34:51 INFO - PROCESS | 15826 | |12;stanford-crypto-pbkdf2;178;174;177;178;177;174;179;179;183;184 08:34:51 INFO - PROCESS | 15826 | |13;stanford-crypto-sha256-iterative;70;70;74;69;69;76;70;69;73;68 08:34:51 INFO - PROCESS | 15826 | __end_tp_report 08:34:51 INFO - PROCESS | 15826 | __start_cc_report 08:34:51 INFO - PROCESS | 15826 | _x_x_mozilla_cycle_collect,1929 08:34:51 INFO - PROCESS | 15826 | __end_cc_report 08:34:51 INFO - PROCESS | 15826 | __startTimestamp1473780891873__endTimestamp 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | ------- Summary: start ------- 08:34:51 INFO - PROCESS | 15826 | Number of tests: 14 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:1.45 (1.2%) stddev-sans-first:1.48 08:34:51 INFO - PROCESS | 15826 | Values: 114.0 117.0 116.0 116.0 114.0 117.0 116.0 114.0 113.0 114.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:133.00 stddev:14.81 (11.1%) stddev-sans-first:14.84 08:34:51 INFO - PROCESS | 15826 | Values: 150.0 128.0 127.0 164.0 137.0 125.0 125.0 122.0 155.0 129.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.32 08:34:51 INFO - PROCESS | 15826 | Values: 161.0 160.0 162.0 162.0 164.0 163.0 164.0 163.0 164.0 162.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:11.85 (15.4%) stddev-sans-first:12.41 08:34:51 INFO - PROCESS | 15826 | Values: 77.0 77.0 76.0 109.0 76.0 77.0 77.0 78.0 100.0 77.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:18.00 (21.4%) stddev-sans-first:18.70 08:34:51 INFO - PROCESS | 15826 | Values: 85.0 84.0 123.0 84.0 83.0 84.0 122.0 84.0 85.0 119.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:34:51 INFO - PROCESS | 15826 | Values: 117.0 118.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:34:51 INFO - PROCESS | 15826 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 08:34:51 INFO - PROCESS | 15826 | Values: 95.0 95.0 97.0 94.0 95.0 96.0 95.0 95.0 95.0 96.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:34:51 INFO - PROCESS | 15826 | Values: 65.0 64.0 64.0 65.0 64.0 64.0 64.0 66.0 66.0 65.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 08:34:51 INFO - PROCESS | 15826 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.63 (3.1%) stddev-sans-first:2.79 08:34:51 INFO - PROCESS | 15826 | Values: 84.0 83.0 88.0 84.0 87.0 82.0 82.0 83.0 89.0 82.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:142.00 stddev:14.15 (10.0%) stddev-sans-first:14.97 08:34:51 INFO - PROCESS | 15826 | Values: 145.0 147.0 150.0 131.0 134.0 134.0 139.0 131.0 177.0 132.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:178.50 stddev:3.27 (1.8%) stddev-sans-first:3.46 08:34:51 INFO - PROCESS | 15826 | Values: 178.0 174.0 177.0 178.0 177.0 174.0 179.0 179.0 183.0 184.0 08:34:51 INFO - PROCESS | 15826 | 08:34:51 INFO - PROCESS | 15826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:70.00 stddev:2.62 (3.7%) stddev-sans-first:2.76 08:34:51 INFO - PROCESS | 15826 | Values: 70.0 70.0 74.0 69.0 69.0 76.0 70.0 69.0 73.0 68.0 08:34:51 INFO - PROCESS | 15826 | -------- Summary: end -------- 08:34:51 INFO - PROCESS | 15826 | 08:34:53 INFO - TEST-INFO | 15826: exit 0 08:34:53 INFO - TEST-OK | kraken | took 65241ms 08:34:53 INFO - SUITE-END | took 1187s 08:34:53 INFO - Completed test suite (00:19:47) 08:34:53 INFO - javascript benchmark 08:34:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2532.9361668099396, 2580.832245904017, 2581.1095172165597, 2597.79217662587, 2623.3835048763535, 4487.237169681154, 4546.408966834315, 4566.497685254623, 4600.76762106892, 4695.953040469599, 4569.657275704319, 4572.519885412034, 4587.81648734051, 4631.953680463194, 4709.670323077386, 4242.745435273878, 4260.147970405916, 4310.0, 4311.461067366579, 4360.520342762294, 4296.076343586128, 4324.027093903862, 4365.49796773372, 4378.5183629800695, 4388.934165987513, 4327.06968001878, 4351.630111440531, 4366.6506679465565, 4381.5618438155925, 4402.0, 4163.75017498951, 4196.328587425997, 4202.516710578261, 4220.050488640031, 4228.9788551057045, 4161.479815023122, 4174.3321068628875, 4179.519355274152, 4256.2338779019765, 4275.551067137937, 4544.318352247189, 4554.2485489894125, 4573.131105090022, 4591.035882464653, 4633.212353899811, 4765.309030190638, 4812.975935120302, 4847.466778654345, 4885.218365061609, 4907.9263811042865, 4902.4852390498845, 4945.357103576548, 4945.876353091166, 4945.876353091166, 4994.82518111868, 4600.539946005372, 4606.470255920545, 4622.656105729191, 4630.0, 4667.906641867144, 4948.925766113512, 4997.625178111656, 5010.849674509771, 5067.087924173684, 5112.590992720573, 4836.830710925101, 4863.659543831898, 4867.975660121677, 4905.23968784839, 4922.827701030446, 4932.876678083005, 4944.035912996931, 4944.936838579651, 4946.115251016879, 5003.949960500421, 4759.524047595212, 4795.856124316276, 4881.585065269421, 4890.315355850184, 4951.628627852853, 4818.518148185153, 4830.033993201374, 4836.927446088312, 4866.562009419169, 4867.9269810952155, 4070.3612259670417, 4073.674106071507, 4100.200460910094, 4112.588741125924, 4120.91758164841, 3625.093726568358, 3640.0353906214873, 3644.1436262478296, 3679.025058359537, 3694.0, 4189.036521599988, 4235.8729238122905, 4265.87202383929, 4318.848840290575, 4323.978380108079, 4927.556519913153, 4932.4081110267, 4945.480724523945, 4988.176950803077, 5004.574611158092, 4266.552012038691, 4297.205017071789, 4305.913881722348, 4356.869293921188, 4362.563743625612, 4303.311470164758, 4338.501072376654, 4360.607545320936, 4408.404865343202, 4410.889727756768, 4676.555727205842, 4708.6468514860835, 4722.905541889212, 4726.172919738963, 4764.213904705824, 4975.527324904128, 4977.328060711758, 4985.651004429655, 4988.376452943382, 5047.444781074152, 4583.2437647789075, 4707.8587642370785, 4722.338872557913, 4725.8582242532775, 4786.688865223749, 4778.211595086772, 4821.63837712166, 4842.17682993899, 4853.102176097434, 4854.077725232195, 4905.8037678492465, 4912.336834527436, 4917.483664215349, 4920.138975679313, 4952.678075925053, 4763.73799441034, 4799.040191961692, 4807.18277892766, 4809.3026511154985, 4867.026594681007, 4695.882602934817, 4726.1020406122725, 4778.593819525379, 4778.713277203379, 4792.904141917212, 4743.1225223333795, 4747.477777444409, 4749.9287510688055, 4751.691140075884, 4800.975995120002, 4715.905681886412, 4770.427548694179, 4811.08589368019, 4844.660873738804, 4864.683795553277, 4696.342512048248, 4727.976360118315, 4738.644601654821, 4741.170295198395, 4741.431028276629], "value": 4529.031141157361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6707509644407, 567.8722287485316, 569.8262030080825, 573.8393249890032, 584.5761822678556, 27581.862090689545, 38126.428103578466, 39313.60686393135, 39355.212895742065, 42884.0, 40606.59393406072, 40983.38524922128, 41018.58981410185, 41021.99999999993, 41053.17893642125, 7652.808679783022, 7809.140994490602, 7811.4922530035365, 7817.921820781805, 7818.061832580099, 7272.2364151764095, 7447.4786764926475, 9712.125908668218, 9981.850272245885, 9982.750431239241, 9979.251556133318, 10058.396496210251, 10064.849027264598, 10080.34477758947, 10082.798344033115, 9949.651762188325, 9996.350237234556, 10004.399736015863, 10004.449755263422, 10009.849852252222, 9554.04459554046, 9558.426494410358, 9603.711888643353, 9622.75943101421, 9625.759356016086, 37195.0, 37316.813415933015, 37491.4376284356, 37508.24983500342, 37515.0, 2654.296611397981, 2814.366767477322, 2930.633670791151, 3122.4847900096456, 3148.134263077649, 28284.85857570699, 28523.286917827012, 28660.570091448644, 29037.709622903712, 29710.40579188404, 3091.2580980564726, 3228.386606544749, 3288.342331533679, 3289.0, 3341.398548261312, 245787.0, 245997.0, 246258.0, 246466.0, 246915.0, 30873.69126308753, 31228.531572026437, 31569.526457103162, 52016.47983520192, 52244.47755522396, 32683.509747353808, 33016.50475242873, 33044.0, 33060.834695826365, 33062.3387532248, 13669.794953075712, 13759.587212383645, 13813.447462101403, 13818.654533636538, 13819.0, 9878.0, 9954.104130628279, 11432.828507572392, 11521.539138434537, 11549.307041577533, 7596.734114306083, 7740.109887362913, 7756.828088135331, 7821.5698136601895, 7856.84286314282, 2998.4902566563737, 3005.2637103909246, 3076.077176846937, 3083.5837161982845, 3086.5987421635045, 814.951102933814, 865.523961820996, 869.5956380283072, 870.656090844113, 923.3813345058827, 26260.0, 27299.727002730117, 27464.313392164957, 27726.722732772414, 28181.43637127246, 860.2558786649503, 888.9911100889037, 935.0088905759781, 977.3695966101825, 1009.5204777730519, 14082.577522674335, 14303.356348964322, 14494.782578261334, 14897.0, 14997.2501374933, 356025.0, 358073.0, 358296.0, 359503.0, 360001.0, 47483.0, 47865.282020769715, 47931.760341198766, 47943.0, 47946.0, 1019.1031891935049, 1067.813132701774, 1102.3220719257438, 1150.6260465348628, 1165.9825102623297, 25413.110541130973, 28492.857535712188, 28571.996284319594, 28814.711852881203, 28892.27769305784, 40650.79674601608, 41108.76673699794, 41140.382894256014, 41189.0, 41418.0, 281185.0, 282289.0, 282466.0, 283966.0, 284021.0, 24050.51898962046, 24390.0, 24655.137070202458, 24799.876000619883, 25749.3562660935, 40364.19271614493, 40448.0, 40788.0, 40856.79571602123, 41506.79246603748, 34778.0, 34778.82610586931, 34925.47611785876, 34957.65042349646, 35137.0, 34804.303913922085, 35249.82375088108, 35278.47082293716, 35400.29199415946, 35579.822100890364, 34663.48004779981, 34722.131946701535, 35351.469727954616, 35861.1034724134, 35864.46203307005, 30748.231294217825, 32307.0, 32694.67305326916, 32726.83636581897, 32989.34021319608, 23804.642930355712, 24035.27894163178, 24679.669632781115, 24684.0, 25188.11841585536], "value": 16338.906401268552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.3550272234118, 342.8440059772805, 345.8772135891758, 349.25434197987295, 373.48832100022975, 12113.939430302848, 15531.223438828056, 15680.137592432426, 15953.920230398831, 17159.571010724707, 15727.84272157281, 16189.109598972082, 16762.0, 16837.494875153734, 16978.660426791455, 4886.291487734276, 4939.950600493994, 5049.283243697142, 5092.185250359943, 5183.092958732225, 3698.611645777195, 3853.421986701989, 4983.352164218646, 5062.341895553592, 5067.442581316071, 3915.158240978189, 3926.27363937671, 3926.293267211901, 5588.273524441817, 5904.0, 4805.75971201442, 5071.619628527838, 5967.433093856077, 6003.489703375219, 6003.789867354665, 5013.623978201649, 5020.322256495363, 5023.799048038074, 5024.874378140539, 5026.773795179226, 11583.18917675763, 11713.648590542298, 11732.472038758277, 11779.764404711943, 11849.17055806094, 1725.5772335777815, 1771.477414162825, 1892.9053547322717, 2018.9394318170332, 2422.140140250221, 9314.487703176323, 9589.712308630682, 9886.752831179207, 10164.745881353025, 13329.933350333284, 1677.9161041947975, 1688.1981058997, 1718.3727939302064, 1726.6719323328653, 1733.1161107834969, 64022.67988660074, 68450.0, 69153.65423172903, 69743.65128174378, 70700.0, 8945.686900958566, 8961.910380896108, 9035.457872527539, 9188.770280743034, 9608.375455595364, 12555.435005424777, 12563.874361256454, 12579.496820127093, 12593.37033148339, 12600.558980435824, 6865.759698410531, 6989.545679530815, 7007.334303241184, 7207.351338379466, 7223.638818059076, 6823.420009299265, 6831.658417079127, 7040.401565866856, 7068.0, 7077.964610176916, 3733.794641294755, 3839.117003089305, 3842.0779013037227, 3950.585188555218, 3963.6432721055244, 1600.2958698172768, 1607.710612089835, 1613.8708903287709, 1790.4897104325205, 1823.5441139715072, 770.4260326057012, 822.9053658829191, 862.2239984014437, 890.9910900890908, 904.7873749668822, 16046.839531604768, 16514.83485165157, 16954.830451695572, 17350.826491735173, 17409.82590174082, 780.1330111838969, 787.9842403151905, 818.7993941484256, 830.3606223208096, 912.543728135932, 9008.819823603622, 9177.541122943827, 9579.233661307078, 9595.808083838423, 9619.56711947964, 354966.0, 359745.0, 361428.0, 364199.0, 366311.0, 73194.26805731982, 74266.25733742594, 74920.0, 75965.6201718999, 76220.61889690626, 787.4763282417243, 832.7751507093051, 833.1751565949667, 833.7957200485798, 840.8234270803077, 15103.4713785017, 15274.465393711167, 15401.691966160839, 15467.613309667347, 16048.839511604734, 36100.27799444049, 37172.62827371692, 37579.624203757616, 37995.0, 38251.0, 51420.74289628528, 53612.0, 54091.72954135204, 54309.0, 54913.0, 6799.864002720017, 6808.183018037867, 6931.965340173267, 6966.721331146698, 7293.452991025588, 9129.908700912905, 9902.653407130716, 10259.179265658879, 10413.42726150069, 10599.48043706736, 8101.797455063671, 8338.958305208434, 8710.47737135774, 8729.301655867388, 8749.343799214957, 9626.66306679291, 9693.612255509983, 9771.169450596779, 9793.314467987173, 9940.850887236553, 9188.540572971191, 9326.440413575207, 9495.14543691071, 9562.808743825224, 10038.1467575254, 6365.140706004815, 6452.548321617442, 6869.519133660596, 6911.965440172767, 6915.135608048994, 7139.82150446243, 7863.174366691415, 7868.291853733192, 8137.226963438464, 8175.754727358189], "value": 7639.971097695011, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.2368122560943, 1314.5661931562581, 1346.07793661342, 1380.2201756007855, 1625.6342322977325, 6661.4670826333895, 7230.963845180773, 7579.0, 7605.04936882889, 7610.581418022007, 7415.814604634887, 7573.431992600549, 7574.280443357872, 7726.652300646484, 7728.381729461629, 2080.8231300339453, 2119.8092171704543, 2124.925627603034, 2125.2561603438826, 2126.9893650531726, 2103.085157956294, 2139.465133716571, 2188.5075857931997, 2195.835312351572, 2196.286206982729, 2141.0579345088113, 2144.4317255927112, 2156.9352919412445, 2158.902849371782, 2195.6157672407344, 2131.2540610786255, 2131.435169680036, 2133.477298061969, 2134.7758485359045, 2143.8177754890776, 2044.2436298569476, 2114.904829282686, 2115.6297647911556, 2117.502386939068, 2123.288698286076, 7665.8850117248285, 7715.382769378492, 7746.30283274508, 7767.805804854867, 7774.65014074368, 4406.515283318832, 4418.668599854992, 4552.021315417202, 4554.43069616298, 4559.475660299075, 2839.7018313077037, 2917.081119447367, 2926.2976885547528, 2936.309967157716, 2943.249471384783, 863.6459051788736, 879.6525372477836, 881.7266647339345, 886.7517095213351, 888.1739981816908, 10510.737231569196, 10654.733631659194, 10729.9463502682, 10739.785204295871, 10779.6766097018, 3982.6216509431556, 4026.5570787213383, 4169.187008533307, 4193.098483825992, 4252.681048921343, 9188.310876684141, 9195.310351723647, 9197.310201734897, 9204.309676774268, 9208.723738287863, 4689.20283551797, 4690.273007683814, 4692.671512994058, 4694.718316900997, 4700.647451441156, 3689.3912504437003, 3818.503594532693, 4075.409065685459, 4256.191323648559, 4276.935845962313, 3572.4284114541547, 3596.956882504097, 3733.533308336458, 3744.3634582121103, 3754.3617585010616, 1175.8295047218105, 1225.8651548329676, 1234.950601975911, 1237.9814302785464, 1238.2694210415718, 733.3216774483582, 733.3326672727899, 750.8498300339954, 754.7094368668103, 758.1243663568587, 4592.0, 4604.378408914754, 4698.859034228979, 4735.2186889163595, 4741.857744267678, 373.0691923650509, 385.4276399546671, 395.0459639969442, 399.0263756434291, 401.2676864721836, 3034.302110514594, 3096.90709278722, 3146.276356438032, 3170.77804553679, 3318.445423708603, 9115.589798459085, 9537.141657250742, 9539.856902146474, 9542.3320367575, 9543.9045609543, 9490.952545237229, 9503.477308747946, 9514.38156519824, 9516.524173791422, 9521.52416375463, 7007.404370628554, 7136.678849451787, 7205.351518363268, 7262.491625586264, 7270.600116993511, 4632.235681112578, 4634.9304760429295, 4681.180793361216, 4681.602063824613, 4818.7831547581145, 8495.447795893248, 8587.82824343522, 8722.781930451789, 8789.208971192624, 8832.072632373509, 8807.119288071142, 8835.425697329652, 8923.687670931486, 8937.553122343726, 8982.056884027344, 5998.610090344114, 6071.635701857903, 6571.704273307808, 6635.734570617121, 6641.369069938348, 7355.7057717690695, 7466.36535894455, 7535.585542795199, 7543.207963163789, 7548.924045887425, 6618.801435956929, 6619.0, 6720.6975686093265, 6759.425448836904, 6944.201416837129, 6625.4037136657935, 6636.838553253065, 6756.121704178426, 6759.2564817869015, 6805.081314022742, 5878.823635290948, 5977.850553736192, 5980.474978880357, 5983.192269043798, 5988.4909782668965, 4040.5041708589897, 4090.1410703752545, 4125.0, 4128.628423441784, 4326.1563995021925, 4248.192843359751, 4271.444712187395, 4318.265894797954, 4355.651547876099, 4512.029913568598], "value": 3927.2242849493773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.4595759971254, 291.0613272197164, 291.4011705944286, 292.8286952133002, 293.528886137749, 4628.67599268051, 4637.327587499811, 4648.976755116224, 4659.790309436075, 4686.6953648012895, 4544.159330523856, 4581.244094724367, 4598.333241679954, 4601.930971035429, 4633.142868569309, 3505.7020153287003, 3580.946285805715, 3610.620884807097, 3688.926221475569, 3694.408894576868, 3638.781673099609, 3664.175560498893, 3671.8347674354586, 3682.1899182179877, 3685.7419980601367, 3652.1600031992657, 3654.963450365502, 3670.834812433447, 3675.8529658813613, 3676.448532720087, 3500.299940012008, 3533.5406397168463, 3600.4959305697225, 3622.655847694478, 3664.5968943416337, 3201.471757160066, 3203.759718021158, 3216.694414030663, 3229.5963004624423, 3231.7396215475983, 4539.341795439643, 4540.048968170716, 4541.45502539694, 4542.092321225094, 4548.863534093983, 4027.6979226557833, 4125.360569111793, 4134.152498737782, 4139.668826493873, 4148.854790082332, 4783.425988881322, 4813.4356334191525, 4815.253635686474, 4816.8795780105775, 4817.470078291421, 3408.3353746019534, 3411.3347897160065, 3413.5050417689545, 3413.6586341365914, 3426.417509023472, 5047.2429135629945, 5052.69683818972, 5056.494350564951, 5077.974610126926, 5092.974535127338, 3420.0, 3496.265784185299, 3527.506149139071, 3528.1532432216595, 3536.1159710072484, 3568.518250036264, 3571.3035957988463, 3576.302620988882, 3580.5524309461316, 3586.6951309139017, 4085.1216988347646, 4087.9182416351505, 4103.322951712994, 4103.440692536877, 4126.587341265909, 4727.172744769651, 4804.975975120102, 4811.477211421253, 4827.25177597473, 4843.564079232886, 1261.713052686255, 1269.7016201192712, 1281.3401098434315, 1282.5190553542423, 1285.2930888011556, 770.8535378278109, 831.4304701279643, 833.2750507058777, 836.5858899844616, 842.1410161635221, 3883.7863917484246, 3902.921941561153, 4122.113745544662, 4244.681648876347, 4289.356596510486, 5010.323606313174, 5020.171671674206, 5023.14606516893, 5030.119729047402, 5033.748312584356, 4390.517043125254, 4399.14216727735, 4400.361947517656, 4403.229434848889, 4405.669574781904, 2562.2313306008123, 2625.9868700656375, 2644.9603255951174, 2656.654634897451, 2662.281184080326, 4749.667523273338, 4761.285807128889, 4765.571098601143, 4786.779371260306, 4790.449098353734, 5113.0, 5128.358955130609, 5136.1525348317855, 5137.2037334213255, 5144.61415393847, 4499.820007199741, 4747.145513807479, 4780.378550788375, 4781.330613714083, 4800.3759511263315, 5048.990201959697, 5074.086664400444, 5074.416442109057, 5075.137226671549, 5081.568066714371, 4954.603631709382, 4967.751612419437, 4973.651844370859, 4979.278004689228, 4980.676256043345, 4669.60308373792, 4774.164521208844, 4815.879603009953, 4820.566149046603, 4825.469198388104, 3529.541159649229, 3538.734594905341, 3540.4689296605716, 3545.4327307630656, 3555.3422616815974, 5040.747962601782, 5051.625735904119, 5075.213341932006, 5076.543111120017, 5076.6446348755235, 4747.596454301423, 4932.8766780830765, 4945.431275403231, 4956.058348913695, 4963.70217786934, 4887.853364399074, 4891.608671306216, 4899.314096026488, 4901.5588597026435, 4923.8276660316715, 4850.393700787402, 4857.514248575114, 4861.854144375674, 4866.367372241586, 4866.367372241586, 4728.574428301332, 4731.668783185144, 4920.5571498565305, 4931.235658472942, 4953.702777833341, 4642.93035604473, 4760.88097797544, 4808.783604737865, 4815.686980346266, 4832.20268655682], "value": 3676.5290430279915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.2159086937638, 560.271646859083, 567.9687617181054, 582.6009183709158, 615.3139249736544, 12563.623091307263, 13236.0, 13279.53521626742, 13792.724145517084, 13817.0, 12572.559960401388, 13320.333983300821, 13482.12366196199, 13498.932505337483, 13554.322283885791, 721.9566825990431, 743.4572761883828, 746.261201410605, 748.4910261022502, 748.5134662469384, 590.9763609455616, 606.378462076373, 728.3262981741894, 746.8842329438919, 750.8535835512077, 790.2137373313561, 790.3913986230627, 790.7667238164755, 792.2631952284373, 792.5759718550548, 784.701813310941, 784.9411294152961, 785.0304873481247, 785.0540099180474, 785.2461636828651, 457.9175748365293, 466.3540995720917, 560.6888177061729, 572.421853927532, 575.4274496875594, 13136.34318284082, 13172.802407963889, 13178.209307441488, 13194.142380745221, 13201.86798132016, 11144.888551114465, 11291.548338066468, 12256.81614775779, 13113.606591802261, 13324.067315287934, 11796.954919701704, 11806.881931180664, 11844.644660660195, 11946.044316454663, 11982.400879955967, 3997.2605068062503, 4027.5117361572907, 4107.609777071173, 4149.232392007458, 4183.958160418418, 70944.29055709428, 71670.0, 71765.64117179433, 71788.28211717868, 71911.92132118075, 9476.620935162655, 9551.0, 9793.363431376938, 10100.0, 10230.23273254509, 18183.363582274556, 18256.087195640164, 18482.966873643887, 18508.537286567942, 18554.350597729015, 6321.841953951188, 6376.202974628171, 6443.6455994920725, 6446.097546343516, 6833.3166683332265, 3541.0, 3565.4295312749837, 3584.605693373727, 3585.3904836177912, 3585.4980302757635, 2855.0150198181595, 2969.213158512996, 2969.346743716379, 2972.435237304905, 2975.330550626135, 480.8653576998376, 483.1568912248079, 487.14992338369063, 499.08168969097034, 505.2043032224262, 413.6194700875202, 422.58164417226726, 428.7620370694295, 459.21474278982646, 469.88957594965154, 6033.185519954838, 6386.36136386367, 6444.613323200623, 6588.604683718992, 6980.197277313174, 380.7296819258302, 401.98593049243135, 401.9939700904489, 405.3757213890634, 407.5130219387803, 3096.752259819209, 3103.7051480109353, 3152.653208147102, 3272.8363581820813, 3356.110630682871, 80472.59763701144, 80871.19128808637, 82781.58609206915, 83602.58198708968, 102739.0, 69299.0, 82659.17340826515, 83209.3358132834, 85983.0, 89340.0, 48305.51694483081, 65285.0, 78561.60719196367, 79207.0, 79454.60272698599, 7121.465890058163, 7371.115466144097, 7432.368248698921, 7499.587522686086, 7537.510061845963, 42410.57589424066, 46745.0, 46791.29813052875, 46852.0, 48893.755531222116, 41378.79310603548, 57280.0, 58383.0, 65387.019194713066, 69473.0, 10740.0, 10826.188035897181, 10934.179936504635, 11180.385078820744, 11360.318380897173, 11323.0, 11425.164575829089, 11811.527538898348, 12061.162201321473, 12089.637310880336, 9180.403273787182, 9393.107654772786, 9512.33413661037, 9809.215262779104, 9836.3606365586, 10049.89950100519, 10219.284650074424, 10399.376037437778, 10549.736256593647, 10717.464126793786, 9353.532323383668, 9389.38968967015, 9393.624255029723, 9626.085521875411, 9772.706818795448, 9262.44425334482, 9538.284628653018, 9709.22326213887, 9847.409155450696, 9921.25590580695, 8292.460990035628, 8314.293285070837, 8942.597583108645, 8987.236084932854, 9171.451764717727], "value": 6123.822342782856, "unit": "score"}], "name": "dromaeo_css", "value": 6069.496299851601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 116.0, 116.0, 114.0, 117.0, 116.0, 114.0, 113.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 127.0, 164.0, 137.0, 125.0, 125.0, 122.0, 155.0, 129.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 164.0, 163.0, 164.0, 163.0, 164.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 109.0, 76.0, 77.0, 77.0, 78.0, 100.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 123.0, 84.0, 83.0, 84.0, 122.0, 84.0, 85.0, 119.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 66.0, 66.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 88.0, 84.0, 87.0, 82.0, 82.0, 83.0, 89.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 150.0, 131.0, 134.0, 134.0, 139.0, 131.0, 177.0, 132.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 174.0, 177.0, 178.0, 177.0, 174.0, 179.0, 179.0, 183.0, 184.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 74.0, 69.0, 69.0, 76.0, 70.0, 69.0, 73.0, 68.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1555.3999999999999, "alertThreshold": 2.0}]} 08:34:53 INFO - Return code: 0 08:34:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:53 INFO - # TBPL SUCCESS # 08:34:53 INFO - Running post-action listener: _resource_record_post_action 08:34:53 INFO - [mozharness: 2016-09-13 15:34:53.663222Z] Finished run-tests step (success) 08:34:53 INFO - Running post-run listener: _resource_record_post_run 08:34:53 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400322560; Read time: 24; Write time: 373952 08:34:53 INFO - TinderboxPrint: CPU usage
13.0% 08:34:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 08:34:53 INFO - TinderboxPrint: I/O write bytes / time
400,322,560 / 373,952 08:34:53 INFO - TinderboxPrint: CPU idle
8,354.5 (87.0%) 08:34:53 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 08:34:53 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99233792; Read time: 0; Write time: 67792 08:34:53 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289042432; Read time: 0; Write time: 302776 08:34:54 INFO - Running post-run listener: _upload_blobber_files 08:34:54 INFO - Blob upload gear active. 08:34:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:54 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 08:34:54 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'] 08:34:54 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 08:34:54 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:58 INFO - (blobuploader) - INFO - Done attempting. 08:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:59 INFO - (blobuploader) - INFO - Done attempting. 08:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:00 INFO - (blobuploader) - INFO - Done attempting. 08:35:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:00 INFO - Return code: 0 08:35:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/565addf60aa37907bf79b56d3fe42ba0c301b4422dd6a14c68d9da47df3807f45881d6481f7122cb2880509e67001d4c5eed832c92745a6a91aaef7ea3746ef6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53a0e8cac649da96d4dc287a83c03fd079fdbd86cfb21ca95dc8b984e46af1708db2a280c3b2caf68989ff5431fbe3980b08cdff72618c406f9c172356b45d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/57b3d77ffeaf9cef97a4d6c11bf8912acc8d341452f5cfb1da9e426a68b3c5a386cfaf19bd118986bd8fd2a7e0936ad5721e8518f304fb2650541434c3f07989"} 08:35:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:00 INFO - Contents: 08:35:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/565addf60aa37907bf79b56d3fe42ba0c301b4422dd6a14c68d9da47df3807f45881d6481f7122cb2880509e67001d4c5eed832c92745a6a91aaef7ea3746ef6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53a0e8cac649da96d4dc287a83c03fd079fdbd86cfb21ca95dc8b984e46af1708db2a280c3b2caf68989ff5431fbe3980b08cdff72618c406f9c172356b45d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/57b3d77ffeaf9cef97a4d6c11bf8912acc8d341452f5cfb1da9e426a68b3c5a386cfaf19bd118986bd8fd2a7e0936ad5721e8518f304fb2650541434c3f07989"} 08:35:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:00 INFO - Copying logs to upload dir... 08:35:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.862321 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-13 08:34:59.951023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 08:34:59.954060) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897 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/565addf60aa37907bf79b56d3fe42ba0c301b4422dd6a14c68d9da47df3807f45881d6481f7122cb2880509e67001d4c5eed832c92745a6a91aaef7ea3746ef6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53a0e8cac649da96d4dc287a83c03fd079fdbd86cfb21ca95dc8b984e46af1708db2a280c3b2caf68989ff5431fbe3980b08cdff72618c406f9c172356b45d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/57b3d77ffeaf9cef97a4d6c11bf8912acc8d341452f5cfb1da9e426a68b3c5a386cfaf19bd118986bd8fd2a7e0936ad5721e8518f304fb2650541434c3f07989"} build_url:https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/CWDxKfr3T5CuLAth6nz6fA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/565addf60aa37907bf79b56d3fe42ba0c301b4422dd6a14c68d9da47df3807f45881d6481f7122cb2880509e67001d4c5eed832c92745a6a91aaef7ea3746ef6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53a0e8cac649da96d4dc287a83c03fd079fdbd86cfb21ca95dc8b984e46af1708db2a280c3b2caf68989ff5431fbe3980b08cdff72618c406f9c172356b45d1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/57b3d77ffeaf9cef97a4d6c11bf8912acc8d341452f5cfb1da9e426a68b3c5a386cfaf19bd118986bd8fd2a7e0936ad5721e8518f304fb2650541434c3f07989"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 08:34:59.980444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:34:59.980798) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1473778845.52068-469980897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:35:00.066263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 08:35:00.066623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 08:35:00.067057) ========= ========= Total master_lag: 0.16 =========