builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1481692793.29 results: success (0) buildid: 20161213193155 builduid: 5f5a208d3d8943c68f64113c7a0ac072 revision: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.287407) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.287925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.288207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.304828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.305262) ========= 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=8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-13 21:19:53-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-12-13 21:19:53 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.418697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.419019) ========= 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=8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.468718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:53.469084) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e --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=8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-13 21:19:53,710 truncating revision to first 12 chars 2016-12-13 21:19:53,710 Setting DEBUG logging. 2016-12-13 21:19:53,710 attempt 1/10 2016-12-13 21:19:53,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ea0c60db5d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 21:19:54,285 unpacking tar archive at: mozilla-central-1ea0c60db5d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:54.384884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:54.385207) ========= script_repo_revision: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:54.385638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:54.385915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 21:19:54.448878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-12-13 21:19:54.449290) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:19:54 INFO - MultiFileLogger online at 20161213 21:19:54 in /builds/slave/test 21:19:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:19:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:19:54 INFO - {'append_to_log': False, 21:19:54 INFO - 'base_work_dir': '/builds/slave/test', 21:19:54 INFO - 'blob_upload_branch': 'Firefox', 21:19:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:19:54 INFO - 'branch': 'Firefox', 21:19:54 INFO - 'buildbot_json_path': 'buildprops.json', 21:19:54 INFO - 'config_files': ('talos/linux_config.py',), 21:19:54 INFO - 'default_actions': ('clobber', 21:19:54 INFO - 'read-buildbot-config', 21:19:54 INFO - 'download-and-extract', 21:19:54 INFO - 'populate-webroot', 21:19:54 INFO - 'create-virtualenv', 21:19:54 INFO - 'install', 21:19:54 INFO - 'run-tests'), 21:19:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:19:54 INFO - 'download_minidump_stackwalk': True, 21:19:54 INFO - 'download_symbols': 'ondemand', 21:19:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:19:54 INFO - 'tooltool.py': '/tools/tooltool.py', 21:19:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:19:54 INFO - '/tools/misc-python/virtualenv.py')}, 21:19:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:19:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:19:54 INFO - 'installer_path': 'installer.exe', 21:19:54 INFO - 'log_level': 'info', 21:19:54 INFO - 'log_name': 'talos', 21:19:54 INFO - 'log_to_console': True, 21:19:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:19:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:19:54 INFO - 'opt_config_files': (), 21:19:54 INFO - 'pip_index': False, 21:19:54 INFO - 'sps_profile': False, 21:19:54 INFO - 'sps_profile_interval': 0, 21:19:54 INFO - 'suite': 'dromaeojs', 21:19:54 INFO - 'system_bits': '32', 21:19:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:19:54 INFO - 'title': 'talos-linux64-ix-038', 21:19:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:19:54 INFO - 'use_talos_json': True, 21:19:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:19:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:19:54 INFO - 'work_dir': 'build'} 21:19:54 INFO - [mozharness: 2016-12-14 05:19:54.793012Z] Running clobber step. 21:19:54 INFO - Running pre-action listener: _resource_record_pre_action 21:19:54 INFO - Running main action method: clobber 21:19:54 INFO - rmtree: /builds/slave/test/build 21:19:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:19:55 INFO - Running post-action listener: _resource_record_post_action 21:19:55 INFO - [mozharness: 2016-12-14 05:19:55.275490Z] Finished clobber step (success) 21:19:55 INFO - [mozharness: 2016-12-14 05:19:55.275590Z] Running read-buildbot-config step. 21:19:55 INFO - Running pre-action listener: _resource_record_pre_action 21:19:55 INFO - Running main action method: read_buildbot_config 21:19:55 INFO - Using buildbot properties: 21:19:55 INFO - { 21:19:55 INFO - "project": "", 21:19:55 INFO - "product": "firefox", 21:19:55 INFO - "script_repo_revision": "production", 21:19:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:19:55 INFO - "repository": "", 21:19:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:19:55 INFO - "buildid": "20161213193155", 21:19:55 INFO - "pgo_build": "True", 21:19:55 INFO - "basedir": "/builds/slave/test", 21:19:55 INFO - "buildnumber": 109, 21:19:55 INFO - "slavename": "talos-linux64-ix-038", 21:19:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:19:55 INFO - "platform": "ubuntu64_hw", 21:19:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:19:55 INFO - "branch": "mozilla-central", 21:19:55 INFO - "repo_path": "mozilla-central", 21:19:55 INFO - "revision": "1ea0c60db5d25a7d522e2f252c1978ff4fc7538e", 21:19:55 INFO - "stage_platform": "linux64-pgo", 21:19:55 INFO - "builduid": "5f5a208d3d8943c68f64113c7a0ac072", 21:19:55 INFO - "slavebuilddir": "test" 21:19:55 INFO - } 21:19:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:19:55 INFO - Running post-action listener: _resource_record_post_action 21:19:55 INFO - [mozharness: 2016-12-14 05:19:55.278024Z] Finished read-buildbot-config step (success) 21:19:55 INFO - [mozharness: 2016-12-14 05:19:55.278112Z] Running download-and-extract step. 21:19:55 INFO - Running pre-action listener: _resource_record_pre_action 21:19:55 INFO - Running main action method: download_and_extract 21:19:55 INFO - mkdir: /builds/slave/test/build/tests 21:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:55 INFO - trying https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:19:55 INFO - Downloading https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:19:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:19:55 INFO - Downloaded 1361 bytes. 21:19:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:19:55 INFO - Using the following test package requirements: 21:19:55 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:19:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:19:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'jsshell-linux-x86_64.zip'], 21:19:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:19:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:19:55 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:19:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:19:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:19:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:19:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:19:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:19:55 INFO - Fetch https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:19:56 INFO - Expected file size: 21775519 21:19:56 INFO - Obtained file size: 21775519 21:20:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:20:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:20:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:20:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:20:07 INFO - Expected file size: 21775519 21:20:07 INFO - Obtained file size: 21775519 21:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:20:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:20:12 INFO - Fetch https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:20:29 INFO - Expected file size: 14409734 21:20:29 INFO - Obtained file size: 14409734 21:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:30 INFO - trying https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:20:30 INFO - Downloading https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:20:31 INFO - Downloaded 59893626 bytes. 21:20:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:20:31 INFO - mkdir: /builds/slave/test/properties 21:20:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:20:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:20:31 INFO - Contents: 21:20:31 INFO - build_url:https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:20:32 INFO - Running post-action listener: _resource_record_post_action 21:20:32 INFO - Running post-action listener: set_extra_try_arguments 21:20:32 INFO - [mozharness: 2016-12-14 05:20:32.519493Z] Finished download-and-extract step (success) 21:20:32 INFO - [mozharness: 2016-12-14 05:20:32.519723Z] Running populate-webroot step. 21:20:32 INFO - Running pre-action listener: _resource_record_pre_action 21:20:32 INFO - Running main action method: populate_webroot 21:20:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:20:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:20:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:20:32 INFO - '--tppagecycles', 21:20:32 INFO - '7'], 21:20:32 INFO - 'tests': ['tsvgm']}}, 21:20:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:20:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:20:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:20:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:20:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:20:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:20:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['damp', 'tps']}, 21:20:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'tests': ['damp', 'tps']}, 21:20:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['dromaeo_dom']}, 21:20:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:20:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['basic_compositor_video']}, 21:20:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:20:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['a11yr', 21:20:32 INFO - 'ts_paint', 21:20:32 INFO - 'tpaint', 21:20:32 INFO - 'sessionrestore', 21:20:32 INFO - 'sessionrestore_no_auto_restore', 21:20:32 INFO - 'tabpaint']}, 21:20:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:20:32 INFO - 'ts_paint', 21:20:32 INFO - 'tpaint', 21:20:32 INFO - 'sessionrestore', 21:20:32 INFO - 'sessionrestore_no_auto_restore', 21:20:32 INFO - 'tabpaint']}, 21:20:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:20:32 INFO - 'ts_paint', 21:20:32 INFO - 'tpaint', 21:20:32 INFO - 'sessionrestore', 21:20:32 INFO - 'sessionrestore_no_auto_restore', 21:20:32 INFO - 'tabpaint']}, 21:20:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:20:32 INFO - 'ts_paint', 21:20:32 INFO - 'tpaint', 21:20:32 INFO - 'sessionrestore', 21:20:32 INFO - 'sessionrestore_no_auto_restore', 21:20:32 INFO - 'tabpaint']}, 21:20:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['a11yr', 21:20:32 INFO - 'ts_paint', 21:20:32 INFO - 'tpaint', 21:20:32 INFO - 'sessionrestore', 21:20:32 INFO - 'sessionrestore_no_auto_restore', 21:20:32 INFO - 'tabpaint']}, 21:20:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['a11yr', 21:20:32 INFO - 'ts_paint', 21:20:32 INFO - 'tpaint', 21:20:32 INFO - 'sessionrestore', 21:20:32 INFO - 'sessionrestore_no_auto_restore', 21:20:32 INFO - 'tabpaint']}, 21:20:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['tsvgx', 21:20:32 INFO - 'tsvgr_opacity', 21:20:32 INFO - 'tart', 21:20:32 INFO - 'tscrollx', 21:20:32 INFO - 'cart', 21:20:32 INFO - 'tsvg_static']}, 21:20:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:20:32 INFO - 'tsvgr_opacity', 21:20:32 INFO - 'tart', 21:20:32 INFO - 'tscrollx', 21:20:32 INFO - 'cart', 21:20:32 INFO - 'tsvg_static']}, 21:20:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'talos_options': ['--disable-e10s'], 21:20:32 INFO - 'tests': ['tp5o']}, 21:20:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:20:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'talos_options': ['--disable-e10s', 21:20:32 INFO - '--xperf_path', 21:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:20:32 INFO - 'tests': ['tp5n']}, 21:20:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:20:32 INFO - 'talos_options': ['--xperf_path', 21:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:20:32 INFO - 'tests': ['tp5n']}}, 21:20:32 INFO - 'talos.zip': {'path': '', 21:20:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:20:32 INFO - Running post-action listener: _resource_record_post_action 21:20:32 INFO - [mozharness: 2016-12-14 05:20:32.538745Z] Finished populate-webroot step (success) 21:20:32 INFO - [mozharness: 2016-12-14 05:20:32.538833Z] Running create-virtualenv step. 21:20:32 INFO - Running pre-action listener: _resource_record_pre_action 21:20:32 INFO - Running main action method: create_virtualenv 21:20:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:20:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:20:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:20:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:20:32 INFO - Using real prefix '/usr' 21:20:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:20:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:20:35 INFO - Installing pip.................done. 21:20:35 INFO - Return code: 0 21:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:20:35 INFO - Reading from file tmpfile_stdout 21:20:35 INFO - Output received: 21:20:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:20:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:20:36 INFO - Using env: {'DISPLAY': ':0', 21:20:36 INFO - 'HOME': '/home/cltbld', 21:20:36 INFO - 'LANG': 'en_US.UTF-8', 21:20:36 INFO - 'LANGUAGE': 'en_US:en', 21:20:36 INFO - 'LOGNAME': 'cltbld', 21:20:36 INFO - 'MAIL': '/var/mail/cltbld', 21:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:36 INFO - 'MOZ_NO_REMOTE': '1', 21:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:36 INFO - 'NO_EM_RESTART': '1', 21:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:36 INFO - 'PWD': '/builds/slave/test', 21:20:36 INFO - 'SHELL': '/bin/bash', 21:20:36 INFO - 'SHLVL': '1', 21:20:36 INFO - 'TERM': 'linux', 21:20:36 INFO - 'TMOUT': '86400', 21:20:36 INFO - 'USER': 'cltbld', 21:20:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:36 INFO - '_': '/tools/buildbot/bin/python'} 21:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:20:36 INFO - Cleaning up... 21:20:36 INFO - Return code: 0 21:20:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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', '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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:20: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 psutil>=3.1.1 21:20:37 INFO - Using env: {'DISPLAY': ':0', 21:20:37 INFO - 'HOME': '/home/cltbld', 21:20:37 INFO - 'LANG': 'en_US.UTF-8', 21:20:37 INFO - 'LANGUAGE': 'en_US:en', 21:20:37 INFO - 'LOGNAME': 'cltbld', 21:20:37 INFO - 'MAIL': '/var/mail/cltbld', 21:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:37 INFO - 'MOZ_NO_REMOTE': '1', 21:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:37 INFO - 'NO_EM_RESTART': '1', 21:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:37 INFO - 'PWD': '/builds/slave/test', 21:20:37 INFO - 'SHELL': '/bin/bash', 21:20:37 INFO - 'SHLVL': '1', 21:20:37 INFO - 'TERM': 'linux', 21:20:37 INFO - 'TMOUT': '86400', 21:20:37 INFO - 'USER': 'cltbld', 21:20:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:37 INFO - '_': '/tools/buildbot/bin/python'} 21:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:37 INFO - Downloading/unpacking psutil>=3.1.1 21:20: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 21:20: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 21:20: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 21:20: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 21:20: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 21:20: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 21:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:20:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:44 INFO - Installing collected packages: psutil 21:20:44 INFO - Running setup.py install for psutil 21:20:44 INFO - building 'psutil._psutil_linux' extension 21:20:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:20:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:20:44 INFO - building 'psutil._psutil_posix' extension 21:20:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:20:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:20:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:44 INFO - Successfully installed psutil 21:20:44 INFO - Cleaning up... 21:20:44 INFO - Return code: 0 21:20:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:45 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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:20:45 INFO - Using env: {'DISPLAY': ':0', 21:20:45 INFO - 'HOME': '/home/cltbld', 21:20:45 INFO - 'LANG': 'en_US.UTF-8', 21:20:45 INFO - 'LANGUAGE': 'en_US:en', 21:20:45 INFO - 'LOGNAME': 'cltbld', 21:20:45 INFO - 'MAIL': '/var/mail/cltbld', 21:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:45 INFO - 'MOZ_NO_REMOTE': '1', 21:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:45 INFO - 'NO_EM_RESTART': '1', 21:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:45 INFO - 'PWD': '/builds/slave/test', 21:20:45 INFO - 'SHELL': '/bin/bash', 21:20:45 INFO - 'SHLVL': '1', 21:20:45 INFO - 'TERM': 'linux', 21:20:45 INFO - 'TMOUT': '86400', 21:20:45 INFO - 'USER': 'cltbld', 21:20:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:45 INFO - '_': '/tools/buildbot/bin/python'} 21:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:20:52 INFO - Installing collected packages: mozsystemmonitor 21:20:52 INFO - Running setup.py install for mozsystemmonitor 21:20:52 INFO - Successfully installed mozsystemmonitor 21:20:52 INFO - Cleaning up... 21:20:52 INFO - Return code: 0 21:20:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:52 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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:20:52 INFO - Using env: {'DISPLAY': ':0', 21:20:52 INFO - 'HOME': '/home/cltbld', 21:20:52 INFO - 'LANG': 'en_US.UTF-8', 21:20:52 INFO - 'LANGUAGE': 'en_US:en', 21:20:52 INFO - 'LOGNAME': 'cltbld', 21:20:52 INFO - 'MAIL': '/var/mail/cltbld', 21:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:52 INFO - 'MOZ_NO_REMOTE': '1', 21:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:52 INFO - 'NO_EM_RESTART': '1', 21:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:52 INFO - 'PWD': '/builds/slave/test', 21:20:52 INFO - 'SHELL': '/bin/bash', 21:20:52 INFO - 'SHLVL': '1', 21:20:52 INFO - 'TERM': 'linux', 21:20:52 INFO - 'TMOUT': '86400', 21:20:52 INFO - 'USER': 'cltbld', 21:20:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:52 INFO - '_': '/tools/buildbot/bin/python'} 21:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:53 INFO - Downloading/unpacking jsonschema==2.5.1 21:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:20:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:55 INFO - Downloading functools32-3.2.3-2.tar.gz 21:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:20:55 INFO - warning: no files found matching '*.txt' 21:20:55 INFO - no previously-included directories found matching 'build' 21:20:55 INFO - no previously-included directories found matching 'dist' 21:20:55 INFO - no previously-included directories found matching '.git*' 21:20:55 INFO - Installing collected packages: jsonschema, functools32 21:20:55 INFO - Running setup.py install for functools32 21:20:55 INFO - warning: no files found matching '*.txt' 21:20:55 INFO - no previously-included directories found matching 'build' 21:20:55 INFO - no previously-included directories found matching 'dist' 21:20:55 INFO - no previously-included directories found matching '.git*' 21:20:55 INFO - Successfully installed jsonschema functools32 21:20:55 INFO - Cleaning up... 21:20:55 INFO - Return code: 0 21:20:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:20:55 INFO - Using env: {'DISPLAY': ':0', 21:20:55 INFO - 'HOME': '/home/cltbld', 21:20:55 INFO - 'LANG': 'en_US.UTF-8', 21:20:55 INFO - 'LANGUAGE': 'en_US:en', 21:20:55 INFO - 'LOGNAME': 'cltbld', 21:20:55 INFO - 'MAIL': '/var/mail/cltbld', 21:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:55 INFO - 'MOZ_NO_REMOTE': '1', 21:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:55 INFO - 'NO_EM_RESTART': '1', 21:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:55 INFO - 'PWD': '/builds/slave/test', 21:20:55 INFO - 'SHELL': '/bin/bash', 21:20:55 INFO - 'SHLVL': '1', 21:20:55 INFO - 'TERM': 'linux', 21:20:55 INFO - 'TMOUT': '86400', 21:20:55 INFO - 'USER': 'cltbld', 21:20:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:55 INFO - '_': '/tools/buildbot/bin/python'} 21:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:20:56 INFO - Cleaning up... 21:20:56 INFO - Return code: 0 21:20:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:20:56 INFO - Using env: {'DISPLAY': ':0', 21:20:56 INFO - 'HOME': '/home/cltbld', 21:20:56 INFO - 'LANG': 'en_US.UTF-8', 21:20:56 INFO - 'LANGUAGE': 'en_US:en', 21:20:56 INFO - 'LOGNAME': 'cltbld', 21:20:56 INFO - 'MAIL': '/var/mail/cltbld', 21:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:56 INFO - 'MOZ_NO_REMOTE': '1', 21:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:56 INFO - 'NO_EM_RESTART': '1', 21:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:56 INFO - 'PWD': '/builds/slave/test', 21:20:56 INFO - 'SHELL': '/bin/bash', 21:20:56 INFO - 'SHLVL': '1', 21:20:56 INFO - 'TERM': 'linux', 21:20:56 INFO - 'TMOUT': '86400', 21:20:56 INFO - 'USER': 'cltbld', 21:20:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:56 INFO - '_': '/tools/buildbot/bin/python'} 21:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:58 INFO - Downloading blobuploader-1.2.4.tar.gz 21:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:20:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:20:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:59 INFO - Downloading docopt-0.6.1.tar.gz 21:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:20:59 INFO - Installing collected packages: blobuploader, requests, docopt 21:20:59 INFO - Running setup.py install for blobuploader 21:20:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:20:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:20:59 INFO - Running setup.py install for requests 21:21:00 INFO - Running setup.py install for docopt 21:21:00 INFO - Successfully installed blobuploader requests docopt 21:21:00 INFO - Cleaning up... 21:21:00 INFO - Return code: 0 21:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:00 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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:21:00 INFO - Using env: {'DISPLAY': ':0', 21:21:00 INFO - 'HOME': '/home/cltbld', 21:21:00 INFO - 'LANG': 'en_US.UTF-8', 21:21:00 INFO - 'LANGUAGE': 'en_US:en', 21:21:00 INFO - 'LOGNAME': 'cltbld', 21:21:00 INFO - 'MAIL': '/var/mail/cltbld', 21:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:00 INFO - 'MOZ_NO_REMOTE': '1', 21:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:00 INFO - 'NO_EM_RESTART': '1', 21:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:00 INFO - 'PWD': '/builds/slave/test', 21:21:00 INFO - 'SHELL': '/bin/bash', 21:21:00 INFO - 'SHLVL': '1', 21:21:00 INFO - 'TERM': 'linux', 21:21:00 INFO - 'TMOUT': '86400', 21:21:00 INFO - 'USER': 'cltbld', 21:21:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:00 INFO - '_': '/tools/buildbot/bin/python'} 21:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:00 INFO - Running setup.py (path:/tmp/pip-YySZDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:00 INFO - Running setup.py (path:/tmp/pip-KsId5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:00 INFO - Running setup.py (path:/tmp/pip-5cOQn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:00 INFO - Running setup.py (path:/tmp/pip-IwoLAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:00 INFO - Running setup.py (path:/tmp/pip-SjNmJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:00 INFO - Running setup.py (path:/tmp/pip-JyQuAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:00 INFO - Running setup.py (path:/tmp/pip-GPzZQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:00 INFO - Running setup.py (path:/tmp/pip-ZMJJTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:00 INFO - Running setup.py (path:/tmp/pip-AwZU6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:01 INFO - Running setup.py (path:/tmp/pip-9s0kYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:01 INFO - Running setup.py (path:/tmp/pip-irUVZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:01 INFO - Running setup.py (path:/tmp/pip-IqNVdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:01 INFO - Running setup.py (path:/tmp/pip-eFsbBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:01 INFO - Running setup.py (path:/tmp/pip-h00kz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:01 INFO - Running setup.py (path:/tmp/pip-GWZ7Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:01 INFO - Running setup.py (path:/tmp/pip-Y8YDNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:01 INFO - Running setup.py (path:/tmp/pip-4nx__q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:21:01 INFO - Running setup.py install for manifestparser 21:21:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:21:01 INFO - Running setup.py install for mozcrash 21:21:01 INFO - Running setup.py install for mozdebug 21:21:01 INFO - Running setup.py install for mozdevice 21:21:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Running setup.py install for mozfile 21:21:02 INFO - Running setup.py install for mozhttpd 21:21:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Running setup.py install for mozinfo 21:21:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Running setup.py install for mozInstall 21:21:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Running setup.py install for mozleak 21:21:02 INFO - Running setup.py install for mozlog 21:21:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Running setup.py install for moznetwork 21:21:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Running setup.py install for mozprocess 21:21:02 INFO - Running setup.py install for mozprofile 21:21:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:21:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:21:03 INFO - Running setup.py install for mozrunner 21:21:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:21:03 INFO - Running setup.py install for mozscreenshot 21:21:03 INFO - Running setup.py install for moztest 21:21:03 INFO - Running setup.py install for mozversion 21:21:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:21:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:21:03 INFO - Cleaning up... 21:21:03 INFO - Return code: 0 21:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:03 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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:21:03 INFO - Using env: {'DISPLAY': ':0', 21:21:03 INFO - 'HOME': '/home/cltbld', 21:21:03 INFO - 'LANG': 'en_US.UTF-8', 21:21:03 INFO - 'LANGUAGE': 'en_US:en', 21:21:03 INFO - 'LOGNAME': 'cltbld', 21:21:03 INFO - 'MAIL': '/var/mail/cltbld', 21:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:03 INFO - 'MOZ_NO_REMOTE': '1', 21:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:03 INFO - 'NO_EM_RESTART': '1', 21:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:03 INFO - 'PWD': '/builds/slave/test', 21:21:03 INFO - 'SHELL': '/bin/bash', 21:21:03 INFO - 'SHLVL': '1', 21:21:03 INFO - 'TERM': 'linux', 21:21:03 INFO - 'TMOUT': '86400', 21:21:03 INFO - 'USER': 'cltbld', 21:21:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:03 INFO - '_': '/tools/buildbot/bin/python'} 21:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:03 INFO - Running setup.py (path:/tmp/pip-lgHZaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:07 INFO - Running setup.py (path:/tmp/pip-QKra1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:07 INFO - Running setup.py (path:/tmp/pip-EemL5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:07 INFO - Running setup.py (path:/tmp/pip-yXSW92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:07 INFO - Running setup.py (path:/tmp/pip-5rHK1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:07 INFO - Running setup.py (path:/tmp/pip-2c3FR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:07 INFO - Running setup.py (path:/tmp/pip-oj7kii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:07 INFO - Running setup.py (path:/tmp/pip-SR5vDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:07 INFO - Running setup.py (path:/tmp/pip-BmKkbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:07 INFO - Running setup.py (path:/tmp/pip-BZrR2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:07 INFO - Running setup.py (path:/tmp/pip-xZDx4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:07 INFO - Running setup.py (path:/tmp/pip-Ihgsz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:07 INFO - Running setup.py (path:/tmp/pip-kAKL_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:07 INFO - Running setup.py (path:/tmp/pip-1XFp1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:07 INFO - Running setup.py (path:/tmp/pip-0T0qLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:08 INFO - Running setup.py (path:/tmp/pip-qtUfY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:08 INFO - Running setup.py (path:/tmp/pip-O9GQnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:21:08 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:21:08 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:21:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:10 INFO - Downloading blessings-1.6.tar.gz 21:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:21:10 INFO - Installing collected packages: blessings 21:21:10 INFO - Running setup.py install for blessings 21:21:10 INFO - Successfully installed blessings 21:21:10 INFO - Cleaning up... 21:21:11 INFO - Return code: 0 21:21:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:11 INFO - Reading from file tmpfile_stdout 21:21:11 INFO - Current package versions: 21:21:11 INFO - argparse == 1.2.1 21:21:11 INFO - blessings == 1.6 21:21:11 INFO - blobuploader == 1.2.4 21:21:11 INFO - docopt == 0.6.1 21:21:11 INFO - functools32 == 3.2.3-2 21:21:11 INFO - jsonschema == 2.5.1 21:21:11 INFO - manifestparser == 1.1 21:21:11 INFO - mozInstall == 1.12 21:21:11 INFO - mozcrash == 1.0 21:21:11 INFO - mozdebug == 0.1 21:21:11 INFO - mozdevice == 0.49 21:21:11 INFO - mozfile == 1.2 21:21:11 INFO - mozhttpd == 0.7 21:21:11 INFO - mozinfo == 0.9 21:21:11 INFO - mozleak == 0.1 21:21:11 INFO - mozlog == 3.4 21:21:11 INFO - moznetwork == 0.27 21:21:11 INFO - mozprocess == 0.23 21:21:11 INFO - mozprofile == 0.28 21:21:11 INFO - mozrunner == 6.13 21:21:11 INFO - mozscreenshot == 0.1 21:21:11 INFO - mozsystemmonitor == 0.3 21:21:11 INFO - moztest == 0.7 21:21:11 INFO - mozversion == 1.4 21:21:11 INFO - psutil == 3.1.1 21:21:11 INFO - requests == 1.2.3 21:21:11 INFO - wsgiref == 0.1.2 21:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:11 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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:21:11 INFO - Using env: {'DISPLAY': ':0', 21:21:11 INFO - 'HOME': '/home/cltbld', 21:21:11 INFO - 'LANG': 'en_US.UTF-8', 21:21:11 INFO - 'LANGUAGE': 'en_US:en', 21:21:11 INFO - 'LOGNAME': 'cltbld', 21:21:11 INFO - 'MAIL': '/var/mail/cltbld', 21:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:11 INFO - 'MOZ_NO_REMOTE': '1', 21:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:11 INFO - 'NO_EM_RESTART': '1', 21:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:11 INFO - 'PWD': '/builds/slave/test', 21:21:11 INFO - 'SHELL': '/bin/bash', 21:21:11 INFO - 'SHLVL': '1', 21:21:11 INFO - 'TERM': 'linux', 21:21:11 INFO - 'TMOUT': '86400', 21:21:11 INFO - 'USER': 'cltbld', 21:21:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:11 INFO - '_': '/tools/buildbot/bin/python'} 21:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:21:11 INFO - Cleaning up... 21:21:11 INFO - Return code: 0 21:21:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:11 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 0x7f300c346e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2329120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, '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': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:21:11 INFO - Using env: {'DISPLAY': ':0', 21:21:11 INFO - 'HOME': '/home/cltbld', 21:21:11 INFO - 'LANG': 'en_US.UTF-8', 21:21:11 INFO - 'LANGUAGE': 'en_US:en', 21:21:11 INFO - 'LOGNAME': 'cltbld', 21:21:11 INFO - 'MAIL': '/var/mail/cltbld', 21:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:11 INFO - 'MOZ_NO_REMOTE': '1', 21:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:11 INFO - 'NO_EM_RESTART': '1', 21:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:11 INFO - 'PWD': '/builds/slave/test', 21:21:11 INFO - 'SHELL': '/bin/bash', 21:21:11 INFO - 'SHLVL': '1', 21:21:11 INFO - 'TERM': 'linux', 21:21:11 INFO - 'TMOUT': '86400', 21:21:11 INFO - 'USER': 'cltbld', 21:21:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:11 INFO - '_': '/tools/buildbot/bin/python'} 21:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:21:11 INFO - Cleaning up... 21:21:11 INFO - Return code: 0 21:21:11 INFO - Running post-action listener: _resource_record_post_action 21:21:11 INFO - Running post-action listener: _start_resource_monitoring 21:21:11 INFO - Starting resource monitoring. 21:21:11 INFO - [mozharness: 2016-12-14 05:21:11.859121Z] Finished create-virtualenv step (success) 21:21:11 INFO - [mozharness: 2016-12-14 05:21:11.859634Z] Running install step. 21:21:11 INFO - Running pre-action listener: _resource_record_pre_action 21:21:11 INFO - Running main action method: install 21:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:12 INFO - Reading from file tmpfile_stdout 21:21:12 INFO - Detecting whether we're running mozinstall >=1.0... 21:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:21:12 INFO - Reading from file tmpfile_stdout 21:21:12 INFO - Output received: 21:21:12 INFO - Usage: mozinstall [options] installer 21:21:12 INFO - Options: 21:21:12 INFO - -h, --help show this help message and exit 21:21:12 INFO - -d DEST, --destination=DEST 21:21:12 INFO - Directory to install application into. [default: 21:21:12 INFO - "/builds/slave/test"] 21:21:12 INFO - --app=APP Application being installed. [default: firefox] 21:21:12 INFO - mkdir: /builds/slave/test/build/application 21:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:21:29 INFO - Reading from file tmpfile_stdout 21:21:29 INFO - Output received: 21:21:29 INFO - /builds/slave/test/build/application/firefox/firefox 21:21:29 INFO - Running post-action listener: _resource_record_post_action 21:21:29 INFO - [mozharness: 2016-12-14 05:21:29.136571Z] Finished install step (success) 21:21:29 INFO - [mozharness: 2016-12-14 05:21:29.136809Z] Running run-tests step. 21:21:29 INFO - Running pre-action listener: _resource_record_pre_action 21:21:29 INFO - Running main action method: run_tests 21:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:21:29 INFO - Python 2.7.3 21:21:29 INFO - Return code: 0 21:21:29 INFO - grabbing minidump binary from tooltool 21:21: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')]} 21:21:29 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 0x23b9f20>, '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 0x2326c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2326f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:21:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:21:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:21:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:21:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:21:29 INFO - Return code: 0 21:21:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:21:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:21:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:21:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:21:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:21:29 INFO - Using env: {'DISPLAY': ':0', 21:21:29 INFO - 'HOME': '/home/cltbld', 21:21:29 INFO - 'LANG': 'en_US.UTF-8', 21:21:29 INFO - 'LANGUAGE': 'en_US:en', 21:21:29 INFO - 'LOGNAME': 'cltbld', 21:21:29 INFO - 'MAIL': '/var/mail/cltbld', 21:21:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:21:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:29 INFO - 'MOZ_NO_REMOTE': '1', 21:21:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:29 INFO - 'NO_EM_RESTART': '1', 21:21:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:29 INFO - 'PWD': '/builds/slave/test', 21:21:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:21:29 INFO - 'SHELL': '/bin/bash', 21:21:29 INFO - 'SHLVL': '1', 21:21:29 INFO - 'TERM': 'linux', 21:21:29 INFO - 'TMOUT': '86400', 21:21:29 INFO - 'USER': 'cltbld', 21:21:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235', 21:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:29 INFO - '_': '/tools/buildbot/bin/python'} 21:21:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:21:29 INFO - mozversion application_buildid: 20161213193155 21:21:29 INFO - mozversion application_changeset: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e 21:21:29 INFO - mozversion application_display_name: Nightly 21:21:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:21:29 INFO - mozversion application_name: Firefox 21:21:29 INFO - mozversion application_remotingname: firefox 21:21:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:21:29 INFO - mozversion application_vendor: Mozilla 21:21:29 INFO - mozversion application_version: 53.0a1 21:21:29 INFO - mozversion platform_buildid: 20161213193155 21:21:29 INFO - mozversion platform_changeset: 1ea0c60db5d25a7d522e2f252c1978ff4fc7538e 21:21:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:21:29 INFO - mozversion platform_version: 53.0a1 21:21:29 INFO - using testdate: 1481692889 21:21:29 INFO - actual date: 1481692889 21:21:29 INFO - starting webserver on 'localhost:44151' 21:21:29 INFO - SUITE-START | Running 2 tests 21:21:29 INFO - TEST-START | dromaeo_css 21:21:29 INFO - operating with platform_type : linux_ 21:21:29 INFO - Initialising browser for dromaeo_css test... 21:21:29 INFO - TEST-INFO | started process 27980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP91lv0/profile http://localhost:44151/getInfo.html) 21:21:34 INFO - PROCESS | 27980 | __metrics Screen width/height:1600/1200 21:21:34 INFO - PROCESS | 27980 | colorDepth:24 21:21:34 INFO - PROCESS | 27980 | Browser inner width/height: 1024/697 21:21:34 INFO - PROCESS | 27980 | __metrics 21:21:35 INFO - PROCESS | 27980 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:21:35 INFO - PROCESS | 27980 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:21:36 INFO - PROCESS | 27980 | console.error: PushService: 21:21:36 INFO - PROCESS | 27980 | stateChangeProcessEnqueue: Error transitioning state 21:21:36 INFO - PROCESS | 27980 | UnknownError 21:21:37 INFO - TEST-INFO | 27980: exit 0 21:21:37 INFO - Browser initialized. 21:21:37 INFO - Running cycle 1/1 for dromaeo_css test... 21:21:37 INFO - TEST-INFO | started process 28064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP91lv0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:49 INFO - PROCESS | 28064 | RSS: Main: 172724224 21:21:49 INFO - PROCESS | 28064 | 21:22:40 INFO - PROCESS | 28064 | 1481692960236 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:24:52 INFO - PROCESS | 28064 | Cycle 1(1): loaded http://localhost:44151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44151/tests/dromaeo/cssquery-ext.html) 21:24:53 INFO - PROCESS | 28064 | RSS: Main: 291799040 21:24:53 INFO - PROCESS | 28064 | 21:27:55 INFO - PROCESS | 28064 | Cycle 1(1): loaded http://localhost:44151/tests/dromaeo/cssquery-ext.html (next: http://localhost:44151/tests/dromaeo/cssquery-jquery.html) 21:27:56 INFO - PROCESS | 28064 | RSS: Main: 279216128 21:27:56 INFO - PROCESS | 28064 | 21:30:58 INFO - PROCESS | 28064 | Cycle 1(1): loaded http://localhost:44151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44151/tests/dromaeo/cssquery-mootools.html) 21:30:59 INFO - PROCESS | 28064 | RSS: Main: 256471040 21:30:59 INFO - PROCESS | 28064 | 21:34:01 INFO - PROCESS | 28064 | Cycle 1(1): loaded http://localhost:44151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44151/tests/dromaeo/cssquery-prototype.html) 21:34:01 INFO - PROCESS | 28064 | RSS: Main: 254181376 21:34:01 INFO - PROCESS | 28064 | 21:37:04 INFO - PROCESS | 28064 | Cycle 1(1): loaded http://localhost:44151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44151/tests/dromaeo/cssquery-yui.html) 21:37:05 INFO - PROCESS | 28064 | RSS: Main: 224673792 21:37:05 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | Cycle 1(1): loaded http://localhost:44151/tests/dromaeo/cssquery-yui.html (next: http://localhost:44151/tests/dromaeo/cssquery-dojo.html) 21:40:08 INFO - PROCESS | 28064 | RSS: Main: 318152704 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | __start_tp_report 21:40:08 INFO - PROCESS | 28064 | _x_x_mozilla_page_load 21:40:08 INFO - PROCESS | 28064 | _x_x_mozilla_page_load_details 21:40:08 INFO - PROCESS | 28064 | |i|pagename|runs| 21:40:08 INFO - PROCESS | 28064 | |0;dojo.html;3236.093893709761;3289.950650740238;3294.6469452352035;3323.7341012718985;3341.916452088699;5234.581233501321;5289.047971365153;5366.436524164965;5435.130379139338;5458.235846981426;5306.230596563496;5318.813841515548;5323.680579165243;5328.866778330544;5331.706756128411;4787.999999999991;4813.446453657839;4815.759212039402;4838.758062096898;4849.175640141185;4912.21404575268;4984.651074424792;4992.975035124819;4996.225585034307;4999.225120106389;4918.336024636682;4969.353983982095;4972.453030166679;4980.950190498103;5001.449840517558;4992.251162325662;5000.549950504472;5008.273800298973;5013.623978201649;5054.241863720435;4739.881502962419;4766.642501812378;4827.275908613701;4911;4933.580645645125;5322.547583455373;5328.600354973392;5328.653637513549;5362.624616276862;5426.158945363475;5700.37295897451;5753.338366087912;5757.366689664175;5759.222504961818;5771.307443106812;5606.635568688022;5660.405657405954;5737.168110623936;5792.957267691814;5798.681072541009;5347.438518955531;5354.9464505354445;5367.543758780547;5415.999999999961;5418.160185171305;5832.679202643811;5846.123081537803;5848.327442344185;5849.970750146307;5853.034249348895;5517.5585953123655;5543.7782488700805;5634.295713035871;5635.408282130317;5636.239107720406;5629.634073785191;5668.688222147822;5698.943010569924;5722.341930677942;5770.24986751728;5635.380108188096;5680.346760122557;5685.772569097273;5689.715514224272;5691.402402747652;5562.833115006556;5690.886182276331;5703.857403564944;5707.486326230659;5709.7716091356715;4364.5635436456105;4398.75806830621;4409.625181859514;4411.426514553087;4430.091831174666;4009.7594144351433;4021.2962731521866;4035.959640403617;4050.4531888194715;4060.025593857453;5433.402325744165;5435.809746658848;5437.157240627709;5437.429069947678;5437.483439073281;5652.491275785199;5709.600327977002;5747.85630359236;5776.768929242783;5829.387914269026;5458.4814442627885;5472.589555783332;5478.698671573022;5504.587155963319;5520.06158952979;4980.626453016038;5017.197248440232;5022.146235140035;5029.396472423333;5030.522100400456;5811.041178205549;5818.0981947798155;5898.14476900847;5967.373425790316;5978.701064946736;5676.091825307931;5680.346760122638;5710.086386178192;5727.713614319351;5780.901628690535;5852.268466441695;5890.911636325544;5893.557983151367;5894.941050589439;5900.291964964232;5497.285352904097;5624.043912534797;5626.549876009827;5626.85932851682;5630.155476678531;5616.241807355955;5724.570657200643;5737.885242295214;5749.7125143741805;5825.0388685866355;5607.130894711327;5629.268195134607;5634.070378387521;5654.321481422256;5659.26429564154;5554.277943867433;5599.412061733622;5606.831795046155;5614.382417934105;5618.381977982501;5371.086915224343;5415.48552887475;5453.454654534515;5509.0359187141285;5513.558915286848;5622.943770562242;5633.8309850704545;5634.408387119293;5635.436456354496;5674.829755107354;5402.648827826179;5435.646682965595;5502.504774570308;5504.091824848855;5505.091659876076 21:40:08 INFO - PROCESS | 28064 | |1;ext.html;537.441061296252;580.8722081142147;581.9592628516006;583.9270091238595;586.1588620329825;31481.21296967577;40631.187376252456;42457;42578.36132458012;45556.772216138954;43428;43873.7806310968;43887.56112438883;43891.78054109733;43932.78033609835;7913.28780409763;8574.228319451264;8764.693235736751;8767.386282960164;8770.035296117421;7876.645550950192;10036.197104231644;10280.640177593787;10290.897091029068;10593.84109238362;10365.637202697908;10427.739306517322;10441.42572158531;10442;10444.63443779464;10313.690589282296;10373.377597344184;10376.688699339033;10387.42869142193;10417.374957502498;10244.897551024469;10288.331258468175;10300.639477618248;10319.535620897077;10322.071013608811;40086;40395;40405.393919091235;40423.59576404228;40461.39307910384;3363.4786608075788;3416.538767266437;3446.483027545888;3463.722902167846;3857.787821669807;31280;31484.21289467759;31781.364372712414;31804.522932156036;31909.202269943205;3953.347697629916;4079.1643760307684;4114.485689288839;4192.832286708528;4337.0458499130145;294183;294979;295416;295907;296905;56934.58392496381;56938.145927811114;56961;57339.71330143323;57356.71321643449;58773.82874798085;59399;59462.70268648629;59575;59587;15271.160086195143;15359.692806143814;15388.153651549272;15403.922980385027;15525.223738813014;10682.572697092184;10920.235583509078;11479.483423245974;11824.23142495735;11829.585964491374;16818.393149061914;17221.827781722022;17413.216405261795;17445.65108697819;17716.20277087534;6401.263854656681;6408.231012278557;6419.614823110628;6661.134052573231;6662.5003124765835;883.2845395229884;1009.8182327181178;1027.2244455436098;1055.8363453664695;1069.9781708468395;30369;30739.38521229563;31148.68851311458;31225.687743122733;31320.53019204714;1056.5456853552892;1099.3623698254994;1107.5016242690822;1143.616888342398;1183;15450.227488625524;16420.6715865682;16509.6698066038;16546.751798723028;16731.91634041822;412582;416101;418148;419231;420136;55647.44352556504;55896;56027;56072.719636401554;56109.43890561124;1161.8547681539808;1221.0780860450302;1266.069438962362;1306.9934650326688;1317.8682131786745;30148.698513015468;31164.37671246517;31918.840405797822;31945.520817188226;32444.188895277806;47817.8045548864;48399.99999999859;48410.273845891636;48458.515414846814;48462.5153748458;333467;335124;336891;337598;337710;24287.63568546438;24582.754172458048;24752.381190470383;25696.100636477633;25820.225393238234;40493.797531012155;40742.79628601838;40775.388369173896;41045.794771025954;41148.1770364597;34147.829260853534;34338.141546461535;34345.141371465914;34709.13227169341;34989;34196.145096371794;34585;34678.479822802175;34892.82553587318;35220.823895880356;33819;34395.312093757486;35041.824790875886;35165.824170880005;35210.8239458801;30131.54802677918;32466.35067298688;32510.34979300448;32558.511622326158;32696.673033269362;23855.284341469785;24877.129300474397;25047.509886522137;25074.498510030062;25312.367190820376 21:40:08 INFO - PROCESS | 28064 | |2;jquery.html;359.65293491780426;377.3735598905817;381.20328513406974;388.3805330497856;412.74409865883155;13969.580912572626;17462.388816391427;18011.54971125721;18887.433376998677;19053.333133340337;17767;18175.909120454413;18262.08689565523;18344.357947471843;18493.81506184938;4919.237518184678;5192;5193.636445448801;5194.454582268864;5195.454477279888;3835.9041023974346;4001.0397504598977;4380.89047773805;5111;5152.098382783017;4178.56125106864;6055.606385584945;6102.633841969474;6167.87664246717;6175.444210021097;5586.581006424493;5614.466625670555;6170.012797952329;6170.167027451282;6180.536459765513;5436.891262174774;5482.095454250044;5487.588430867661;5491.36849262332;5491.615586908918;13672.31638418075;13681.931590342085;13784.172949623055;13890.374933128034;13920.721585568232;2043.427840204745;2124.1715730864976;2179.3570896585547;2239.1155493579945;2250.4148921280585;9948.452835094067;9961.501924903798;10158.492075396201;10467.476626168662;10543.472826358651;1822.3075231411979;1888;1915.348781414326;1927.2387406974308;1964.5462357855226;70735.64632176858;70747;72813;73057;74464.25535744628;10548.789024219474;10567.471626418648;10595.788084238273;10883.67348979532;10963.56145754177;14410.42358305656;14506.782398264035;14560.781588276184;14584.562463126123;14609.634759131106;7335;7674.923250767532;7708.653110610036;7842.803929901684;7922.801929951682;7223.27767223284;7258.419326453976;7281.417486601059;7459.627018649046;7483.176850546435;4487.551244875552;4541.568550987651;4560.338750881104;4615.9076818463445;4703.74129422885;1904.8476121910214;1941.5437372217518;1952.8925909075137;1967.370441458748;1983.652860749363;856.6230858422274;915.7390143808982;927.8283517549276;952.1335584617964;1011.7723512209694;17730.468085957444;18686.906565467358;18711.22243386876;18877.811221887605;18928.526786830163;912.0843752321114;945.5792172483317;949.620151939216;992.712113487095;1011.438651548383;9806.509674516246;10241.334313269614;10380.169586433067;10387.117095046855;10406.895931040744;312609;313543;314753;407943;411200;63053.36946630475;72258.63870680718;73236.26763732295;75223.24776752162;80908;948.5162567090696;979.1872745621117;1000.9599616015278;1003.2174903575223;1004.7739258666742;16184.595385115466;16768.916155419145;17190.14049297555;17209.483715488554;17519.737203941695;34862.82568587141;35536.64463355333;37746.81126594349;38225.426618600184;38595.614043860325;52996;53879.730601346746;54723.89570782128;55058.44941550693;57091.71454142703;8167.387445941459;8402.621882015446;8549.743507694779;8572.185642363966;8837.91162088371;10814.783704325711;12555.74888502243;12621.242725436503;12821.294828784507;12984.805227921399;10883.78232435331;10988.560457581607;11059.22585419013;11339.489722962651;11595.884041159818;6712.060311556288;6980.7207711693;10772.353658780497;11083.334999900031;11287.66137015858;10801.297915635458;11193.216474847008;11225.270357426742;11413.258138220988;11487.885121149016;8314.251717345467;8345.374096942875;8359.791005224917;8484.363672724447;8690.130986901258;9774.609015639295;10819.404932728776;10891.618793342195;11024.889751102386;11072.446377681244 21:40:08 INFO - PROCESS | 28064 | |3;mootools.html;1361.652778541472;1377.958661240163;1467.9192644404561;1639.295103105664;1681.9327226910925;6978.79063628092;7138.535995160324;7309.634518274085;7714.267144621259;7747.883781743279;7411.888821667666;7633.084029916417;7642.426817988659;7815.609219539015;7872;2091.4980404702837;2125.266782959884;2131.6056529542007;2132.3389749177804;2133.328001679474;1874.1753628403526;1945.7956914523984;2143.860649057814;2167.869927804329;2223.6442169252923;2022.4741567192561;2091.811736943675;2103.4320733401973;2104.8947552622385;2106.6524023536176;2119.8198153157;2120.512282175093;2136.5257971999426;2141.4218161096496;2158.8380871434706;2151.483643925447;2160.362693005567;2160.8163306119;2189.4745261137373;2195.3633446300555;7711.228877112244;7800.063992320901;7811;7901.96049019757;7911.485753426009;4847.394075740533;5011.098002359574;5013.749312534395;5016.573591244749;5024.447310795809;3055.5263934090253;3089.582906307642;3128.343047959931;3192.808431494118;3212.662670419619;1042.7028296935337;1065.1851333729703;1866.608012317415;1871.5414723392855;1874.2690350763214;9951.55218015191;9981.351212171186;10095.192384609287;10096.29325947184;10134;4039.555648878621;4112.979435102865;4146.937795933063;4161.313383291723;4327;8670.393072484992;8673.956630216808;8696.13038696138;8706.825863482694;8714.69498567547;4878.487758785347;4893.437254715754;4897.853064408074;4903.387076615423;4907.411110666671;4371.890702732457;4444.488883778342;4577.977110114428;4581.923248036709;4601.171789077931;3328.3509715605223;3348.8493017814258;3350.949735753966;3371.8145501997624;3416.0947348952545;978.5987745024648;1023.8771347438355;1030.5877648940484;1033.4109557552274;1036.5905467340508;793.6745934166964;793.8610743120047;841.7937605286621;860.5181098584812;877.5305211711703;4940.407151141814;5007.273945277914;5041;5089.821856235014;5313.362396512443;840.9873851892227;873.2010210657304;873.9169778870997;905.3571963905569;927.2998885841147;3318.4192766265805;3485.3029394121277;3500.842462089212;3622.7464077514846;3725.5715592707184;8710.21608055278;9017.188453039258;9132.22376098039;9138.68014619485;9157.358984870994;9136.269098472107;9143.679971200976;9150.08499150093;9151.03914089011;9168.587413566405;7074.575525468488;7204.92795072053;7258.346748792634;7421.628918554051;7432.368248698813;5218.478152184751;5279.947200527946;5344.759485823225;5481.780728770805;5580;8639.222469977733;8681.652733890574;8726.171013753683;8859.955700221457;8987.281017518713;8844.557772111497;9164.633414663605;9169.495677737521;9303.72088837336;9304.116108969638;6814.420774234246;6967.686454109678;6978.371946524837;7002.494463690331;7006.439484841302;7137.500374973702;7369.226231245642;7404.185539590533;7413.221611730691;7463.477556570988;6694.263631000684;6704.698288577123;6870.819993107315;7088.468364872759;7147.249538798351;6428.4214420702365;6749.257581666111;6750.763723269662;6904.585724856524;6946.8610627788175;6055.909161362495;6087.421694938974;6097.695115244132;6119.541034422525;6120.877582448237;4419.668524860584;4439.955600443955;4465.687401881837;4486.416765820422;4524.117797029548;4422.071365013383;4450.732956022649;4480.238359478832;4484.932726009178;4659.8136074558 21:40:08 INFO - PROCESS | 28064 | |4;prototype.html;372.39857629927656;383.8023417939761;385.1507426125394;391.9372900335947;394.1663381947181;5096.38843338799;5242.554382877455;5245.501677340656;5277.89444211116;5308.309919710432;5076.593872490201;5204.401493828211;5210.739463026843;5233.075193604796;5240.44975277596;4220.155968806235;4222.451081359419;4222.619964203221;4229.450171477703;4246.490421149467;3956.2108713357015;3993.362721284274;4201.516825565053;4220.451341325624;4233.682473814476;4166.270902592049;4185.686073544481;4186.937195942063;4193.769342686151;4202.453681021463;4169.291220492509;4177.394277829728;4180.352045432963;4189.392538081961;4195.895102622444;3776.15036616759;3781.3193625147464;3782.8486860525545;3783.50814394127;3791.1659434924272;4973.552380285755;5030.773615187325;5083.3391659084455;5099.36257967754;5132.178851383798;4810.927836082462;4818.373611430527;4831.323614693911;4836.202026665596;4842.757862106881;5423.647462914898;5504.2294078829;5506.201600767866;5527.723613819293;5545.916811247835;4153.677058353305;4164.7917604119675;4171.249175148472;4181.832726690959;4188.769617671027;5624.493795558419;5712.400197979194;5716.685582292931;5719.71401429931;5721.914171287434;4231.217224813419;4253.595908388698;4260.488741351058;4271.423357846651;4275.850345237902;4215.302206587787;4282.76444795533;4289.284286285449;4298.376735373354;4335.978320108379;4761.333413322138;4767;4767.356406885096;4785.95214047862;4788.880277993008;5459.863503412446;5480.177973304037;5482.451754824566;5496.835094947158;5506.614536982453;1384.9653758656113;1438.7769895666188;1449.9420023199166;1469.3608280398062;1477.571504263773;1012.8733908261468;1032.9586816527255;1041.9791604167874;1050.9595500454495;1054.1882750282239;5089.287499750038;5142.408623008327;5162.509561591718;5169.431362550116;5170.1986192140275;5355.250264962909;5372.355317361864;5385.30362935674;5399.244105825188;5417.133258678671;4948.946187332217;5067.24184201891;5074.213496907985;5154.690718556899;5166.535011848877;2893.9131826045254;2899.2027192521805;2899.536074228113;2904.3174853909313;2912.3301640622776;5571.9442805572235;5579;5582.804601838916;5585.469380408855;5618.185363122406;5460.535854452416;5557.610967232255;5781.913271300934;5810.6513609183585;5826.650400975955;5862.736176871966;5864.914990726644;5871.4715675589405;5878.970605146947;5888.352281249145;5539.778408863762;5630.380658127521;5734.827955161351;5736.5410767139365;5745.253117094751;5574.91637625444;5584.6492104736835;5590.636608620427;5591.496765290981;5600.719964001865;5722.484976352148;5741.1388291756575;5757.712114394348;5772.56705747079;5773.162891380643;3864.594217607223;4006.759594424344;4017.6584990276156;4034.3545032794614;4061.5735347789237;5579.832605021856;5579.972100139474;5611.7194140292;5619.93221287954;5636.239107720406;5464.28964234647;5470.64440811346;5527.364353099284;5540;5554;5298.470152984671;5489.670619762827;5532.557395408277;5540.390557038642;5560.471755183251;5442;5477.616566840283;5498.752556134904;5506.972465137648;5510;5314;5586.972065139648;5600.663960162403;5616.66300022;5620.494155526022;5369.221462887781;5384.949934762683;5400.7569659364635;5408.323959505062;5408.540274076748 21:40:08 INFO - PROCESS | 28064 | |5;yui.html;722.4906440959121;726.2954933714295;730.6821532633305;760.7223363472334;803.91156972733;13098.738025239501;13915.165090094577;13938.094023888452;13938.790918136236;13949.999999999987;13872.861271387283;13997.790033149486;13998.580042598738;14009.579712608613;14015.579532614038;650.278191207759;662.615682903917;750.7034721285089;755.7052749427714;765.2156539546982;751.6730222353267;751.8609057324385;758.4311766175341;761.3946912204783;761.8057395364202;802.4864086984335;803.2609998801117;804.4288555125838;807.5881300536739;808.014222648371;673.4780545077604;698.0541366448491;787.9369650427952;802.257911431926;802.9638666260032;593.6734795862259;598.019248432571;598.186466405688;598.3806760003375;598.4105655928906;12897.935510322483;12918.095733298673;12936.417861196269;12938;12938.288394138319;13513.932430337785;13854.584362469142;13883.4446622135;13958.09272397301;14103.365348559237;12731.872681273162;12759.298238596873;12774.48902043917;12929.094963352569;13630.182189068688;4189.120284740208;4206.3690446432975;4286.592773686495;4340.218760623086;4438.667099967515;78140.21859781386;80187.59906200548;82302.58848705779;83423;84644.57677711634;10519.31624444424;10572.894271057345;10751.247412681038;10769.676909692722;10873.728156796144;21361.57276854454;21465.356039318845;21569.676454852877;21632.134714611555;21853.890730546245;7347.926520734831;7382.6677799498075;7437.330640242404;7462.776116716507;7518.586477743667;4336.284513055373;4370;4375.124975004948;4382.298832186835;4514.390557274792;3061.1581815001055;3101.7673674474504;3117.7817552771544;3126.4841301185506;3133.592632957701;550.7246376811594;556.6187161794184;558.2435799491631;568.5877738639454;572.9684867332253;565.2171742137169;588.8439563515672;594.1058706646469;619.6096459230656;651.4755621724463;8289.668413263402;8294.958525207456;8342.290905273;8478.788030299293;8570.400071995025;621.3879328861068;640.5356116815271;642.4635429416489;644.2751904107879;645.6803882078401;3998.460207871958;4229.661627069889;4255.893602659959;4263.339182426729;4273.55127711592;60194.69902650546;61071.6946415274;62835;71639.28360716431;78372.21627783764;48371.758141209066;50460.24309635358;54486.727566361915;61828.69085654633;63423.68288158622;57169.714151429805;59430.702846486354;59434;59609.403905961255;60297.69851150804;8462.873056904029;8820;8927.97727532298;8936.910630893608;9007.954960225157;38944.61055389523;39686.801565991984;39812.40281395723;40170;40503.797481013586;53426.73286633542;55129.72435137798;55419;56282.55761635787;56680.43319566917;10868.67393978182;11565.59520416815;11829.290242585472;11941.761164776482;11995;12341.54484794768;12447.751044978868;12561.748765024831;12712;12965.222086674452;12126.539541109185;12974.156679815782;13209.867901320864;13411.865881341062;13721.931390342985;12624.284123449183;12878.35608219604;12968.805467918177;13088;13129.540466083641;12079.818802717791;12171;12304.200226985216;12464.252144871336;12550;9641.180499657608;9694.75763105928;10075.496225188564;10201.59193632276;10669.253152279265;10409.219308552041;10653.79639765126;10785.676429707122;10813.451023978627;10892.673219803419 21:40:08 INFO - PROCESS | 28064 | __end_tp_report 21:40:08 INFO - PROCESS | 28064 | __start_cc_report 21:40:08 INFO - PROCESS | 28064 | _x_x_mozilla_cycle_collect,1069 21:40:08 INFO - PROCESS | 28064 | __end_cc_report 21:40:08 INFO - PROCESS | 28064 | __startTimestamp1481694008650__endTimestamp 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | ------- Summary: start ------- 21:40:08 INFO - PROCESS | 28064 | Number of tests: 6 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | [#0] dojo.html Cycles:165 Average:5334.23 Median:5505.09 stddev:558.71 (10.1%) stddev-sans-first:535.63 21:40:08 INFO - PROCESS | 28064 | Values: 3236.1 3290.0 3294.6 3323.7 3341.9 5234.6 5289.0 5366.4 5435.1 5458.2 5306.2 5318.8 5323.7 5328.9 5331.7 4788.0 4813.4 4815.8 4838.8 4849.2 4912.2 4984.7 4993.0 4996.2 4999.2 4918.3 4969.4 4972.5 4981.0 5001.4 4992.3 5000.5 5008.3 5013.6 5054.2 4739.9 4766.6 4827.3 4911.0 4933.6 5322.5 5328.6 5328.7 5362.6 5426.2 5700.4 5753.3 5757.4 5759.2 5771.3 5606.6 5660.4 5737.2 5793.0 5798.7 5347.4 5354.9 5367.5 5416.0 5418.2 5832.7 5846.1 5848.3 5850.0 5853.0 5517.6 5543.8 5634.3 5635.4 5636.2 5629.6 5668.7 5698.9 5722.3 5770.2 5635.4 5680.3 5685.8 5689.7 5691.4 5562.8 5690.9 5703.9 5707.5 5709.8 4364.6 4398.8 4409.6 4411.4 4430.1 4009.8 4021.3 4036.0 4050.5 4060.0 5433.4 5435.8 5437.2 5437.4 5437.5 5652.5 5709.6 5747.9 5776.8 5829.4 5458.5 5472.6 5478.7 5504.6 5520.1 4980.6 5017.2 5022.1 5029.4 5030.5 5811.0 5818.1 5898.1 5967.4 5978.7 5676.1 5680.3 5710.1 5727.7 5780.9 5852.3 5890.9 5893.6 5894.9 5900.3 5497.3 5624.0 5626.5 5626.9 5630.2 5616.2 5724.6 5737.9 5749.7 5825.0 5607.1 5629.3 5634.1 5654.3 5659.3 5554.3 5599.4 5606.8 5614.4 5618.4 5371.1 5415.5 5453.5 5509.0 5513.6 5622.9 5633.8 5634.4 5635.4 5674.8 5402.6 5435.6 5502.5 5504.1 5505.1 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | [#1] ext.html Cycles:180 Average:51198.01 Median:169243.74 stddev:92981.05 (54.9%) stddev-sans-first:93164.08 21:40:08 INFO - PROCESS | 28064 | Values: 537.4 580.9 582.0 583.9 586.2 31481.2 40631.2 42457.0 42578.4 45556.8 43428.0 43873.8 43887.6 43891.8 43932.8 7913.3 8574.2 8764.7 8767.4 8770.0 7876.6 10036.2 10280.6 10290.9 10593.8 10365.6 10427.7 10441.4 10442.0 10444.6 10313.7 10373.4 10376.7 10387.4 10417.4 10244.9 10288.3 10300.6 10319.5 10322.1 40086.0 40395.0 40405.4 40423.6 40461.4 3363.5 3416.5 3446.5 3463.7 3857.8 31280.0 31484.2 31781.4 31804.5 31909.2 3953.3 4079.2 4114.5 4192.8 4337.0 294183.0 294979.0 295416.0 295907.0 296905.0 56934.6 56938.1 56961.0 57339.7 57356.7 58773.8 59399.0 59462.7 59575.0 59587.0 15271.2 15359.7 15388.2 15403.9 15525.2 10682.6 10920.2 11479.5 11824.2 11829.6 16818.4 17221.8 17413.2 17445.7 17716.2 6401.3 6408.2 6419.6 6661.1 6662.5 883.3 1009.8 1027.2 1055.8 1070.0 30369.0 30739.4 31148.7 31225.7 31320.5 1056.5 1099.4 1107.5 1143.6 1183.0 15450.2 16420.7 16509.7 16546.8 16731.9 412582.0 416101.0 418148.0 419231.0 420136.0 55647.4 55896.0 56027.0 56072.7 56109.4 1161.9 1221.1 1266.1 1307.0 1317.9 30148.7 31164.4 31918.8 31945.5 32444.2 47817.8 48400.0 48410.3 48458.5 48462.5 333467.0 335124.0 336891.0 337598.0 337710.0 24287.6 24582.8 24752.4 25696.1 25820.2 40493.8 40742.8 40775.4 41045.8 41148.2 34147.8 34338.1 34345.1 34709.1 34989.0 34196.1 34585.0 34678.5 34892.8 35220.8 33819.0 34395.3 35041.8 35165.8 35210.8 30131.5 32466.4 32510.3 32558.5 32696.7 23855.3 24877.1 25047.5 25074.5 25312.4 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | [#2] jquery.html Cycles:180 Average:23535.61 Median:19062.09 stddev:58898.64 (309.0%) stddev-sans-first:59038.16 21:40:08 INFO - PROCESS | 28064 | Values: 359.7 377.4 381.2 388.4 412.7 13969.6 17462.4 18011.5 18887.4 19053.3 17767.0 18175.9 18262.1 18344.4 18493.8 4919.2 5192.0 5193.6 5194.5 5195.5 3835.9 4001.0 4380.9 5111.0 5152.1 4178.6 6055.6 6102.6 6167.9 6175.4 5586.6 5614.5 6170.0 6170.2 6180.5 5436.9 5482.1 5487.6 5491.4 5491.6 13672.3 13681.9 13784.2 13890.4 13920.7 2043.4 2124.2 2179.4 2239.1 2250.4 9948.5 9961.5 10158.5 10467.5 10543.5 1822.3 1888.0 1915.3 1927.2 1964.5 70735.6 70747.0 72813.0 73057.0 74464.3 10548.8 10567.5 10595.8 10883.7 10963.6 14410.4 14506.8 14560.8 14584.6 14609.6 7335.0 7674.9 7708.7 7842.8 7922.8 7223.3 7258.4 7281.4 7459.6 7483.2 4487.6 4541.6 4560.3 4615.9 4703.7 1904.8 1941.5 1952.9 1967.4 1983.7 856.6 915.7 927.8 952.1 1011.8 17730.5 18686.9 18711.2 18877.8 18928.5 912.1 945.6 949.6 992.7 1011.4 9806.5 10241.3 10380.2 10387.1 10406.9 312609.0 313543.0 314753.0 407943.0 411200.0 63053.4 72258.6 73236.3 75223.2 80908.0 948.5 979.2 1001.0 1003.2 1004.8 16184.6 16768.9 17190.1 17209.5 17519.7 34862.8 35536.6 37746.8 38225.4 38595.6 52996.0 53879.7 54723.9 55058.4 57091.7 8167.4 8402.6 8549.7 8572.2 8837.9 10814.8 12555.7 12621.2 12821.3 12984.8 10883.8 10988.6 11059.2 11339.5 11595.9 6712.1 6980.7 10772.4 11083.3 11287.7 10801.3 11193.2 11225.3 11413.3 11487.9 8314.3 8345.4 8359.8 8484.4 8690.1 9774.6 10819.4 10891.6 11024.9 11072.4 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | [#3] mootools.html Cycles:180 Average:5096.29 Median:5154.15 stddev:2764.09 (53.6%) stddev-sans-first:2757.60 21:40:08 INFO - PROCESS | 28064 | Values: 1361.7 1378.0 1467.9 1639.3 1681.9 6978.8 7138.5 7309.6 7714.3 7747.9 7411.9 7633.1 7642.4 7815.6 7872.0 2091.5 2125.3 2131.6 2132.3 2133.3 1874.2 1945.8 2143.9 2167.9 2223.6 2022.5 2091.8 2103.4 2104.9 2106.7 2119.8 2120.5 2136.5 2141.4 2158.8 2151.5 2160.4 2160.8 2189.5 2195.4 7711.2 7800.1 7811.0 7902.0 7911.5 4847.4 5011.1 5013.7 5016.6 5024.4 3055.5 3089.6 3128.3 3192.8 3212.7 1042.7 1065.2 1866.6 1871.5 1874.3 9951.6 9981.4 10095.2 10096.3 10134.0 4039.6 4113.0 4146.9 4161.3 4327.0 8670.4 8674.0 8696.1 8706.8 8714.7 4878.5 4893.4 4897.9 4903.4 4907.4 4371.9 4444.5 4578.0 4581.9 4601.2 3328.4 3348.8 3350.9 3371.8 3416.1 978.6 1023.9 1030.6 1033.4 1036.6 793.7 793.9 841.8 860.5 877.5 4940.4 5007.3 5041.0 5089.8 5313.4 841.0 873.2 873.9 905.4 927.3 3318.4 3485.3 3500.8 3622.7 3725.6 8710.2 9017.2 9132.2 9138.7 9157.4 9136.3 9143.7 9150.1 9151.0 9168.6 7074.6 7204.9 7258.3 7421.6 7432.4 5218.5 5279.9 5344.8 5481.8 5580.0 8639.2 8681.7 8726.2 8860.0 8987.3 8844.6 9164.6 9169.5 9303.7 9304.1 6814.4 6967.7 6978.4 7002.5 7006.4 7137.5 7369.2 7404.2 7413.2 7463.5 6694.3 6704.7 6870.8 7088.5 7147.2 6428.4 6749.3 6750.8 6904.6 6946.9 6055.9 6087.4 6097.7 6119.5 6120.9 4419.7 4440.0 4465.7 4486.4 4524.1 4422.1 4450.7 4480.2 4484.9 4659.8 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | [#4] prototype.html Cycles:180 Average:4654.87 Median:5169.81 stddev:1322.52 (25.6%) stddev-sans-first:1286.58 21:40:08 INFO - PROCESS | 28064 | Values: 372.4 383.8 385.2 391.9 394.2 5096.4 5242.6 5245.5 5277.9 5308.3 5076.6 5204.4 5210.7 5233.1 5240.4 4220.2 4222.5 4222.6 4229.5 4246.5 3956.2 3993.4 4201.5 4220.5 4233.7 4166.3 4185.7 4186.9 4193.8 4202.5 4169.3 4177.4 4180.4 4189.4 4195.9 3776.2 3781.3 3782.8 3783.5 3791.2 4973.6 5030.8 5083.3 5099.4 5132.2 4810.9 4818.4 4831.3 4836.2 4842.8 5423.6 5504.2 5506.2 5527.7 5545.9 4153.7 4164.8 4171.2 4181.8 4188.8 5624.5 5712.4 5716.7 5719.7 5721.9 4231.2 4253.6 4260.5 4271.4 4275.9 4215.3 4282.8 4289.3 4298.4 4336.0 4761.3 4767.0 4767.4 4786.0 4788.9 5459.9 5480.2 5482.5 5496.8 5506.6 1385.0 1438.8 1449.9 1469.4 1477.6 1012.9 1033.0 1042.0 1051.0 1054.2 5089.3 5142.4 5162.5 5169.4 5170.2 5355.3 5372.4 5385.3 5399.2 5417.1 4948.9 5067.2 5074.2 5154.7 5166.5 2893.9 2899.2 2899.5 2904.3 2912.3 5571.9 5579.0 5582.8 5585.5 5618.2 5460.5 5557.6 5781.9 5810.7 5826.7 5862.7 5864.9 5871.5 5879.0 5888.4 5539.8 5630.4 5734.8 5736.5 5745.3 5574.9 5584.6 5590.6 5591.5 5600.7 5722.5 5741.1 5757.7 5772.6 5773.2 3864.6 4006.8 4017.7 4034.4 4061.6 5579.8 5580.0 5611.7 5619.9 5636.2 5464.3 5470.6 5527.4 5540.0 5554.0 5298.5 5489.7 5532.6 5540.4 5560.5 5442.0 5477.6 5498.8 5507.0 5510.0 5314.0 5587.0 5600.7 5616.7 5620.5 5369.2 5384.9 5400.8 5408.3 5408.5 21:40:08 INFO - PROCESS | 28064 | 21:40:08 INFO - PROCESS | 28064 | [#5] yui.html Cycles:180 Average:16351.18 Median:4410.48 stddev:20903.92 (474.0%) stddev-sans-first:20929.62 21:40:08 INFO - PROCESS | 28064 | Values: 722.5 726.3 730.7 760.7 803.9 13098.7 13915.2 13938.1 13938.8 13950.0 13872.9 13997.8 13998.6 14009.6 14015.6 650.3 662.6 750.7 755.7 765.2 751.7 751.9 758.4 761.4 761.8 802.5 803.3 804.4 807.6 808.0 673.5 698.1 787.9 802.3 803.0 593.7 598.0 598.2 598.4 598.4 12897.9 12918.1 12936.4 12938.0 12938.3 13513.9 13854.6 13883.4 13958.1 14103.4 12731.9 12759.3 12774.5 12929.1 13630.2 4189.1 4206.4 4286.6 4340.2 4438.7 78140.2 80187.6 82302.6 83423.0 84644.6 10519.3 10572.9 10751.2 10769.7 10873.7 21361.6 21465.4 21569.7 21632.1 21853.9 7347.9 7382.7 7437.3 7462.8 7518.6 4336.3 4370.0 4375.1 4382.3 4514.4 3061.2 3101.8 3117.8 3126.5 3133.6 550.7 556.6 558.2 568.6 573.0 565.2 588.8 594.1 619.6 651.5 8289.7 8295.0 8342.3 8478.8 8570.4 621.4 640.5 642.5 644.3 645.7 3998.5 4229.7 4255.9 4263.3 4273.6 60194.7 61071.7 62835.0 71639.3 78372.2 48371.8 50460.2 54486.7 61828.7 63423.7 57169.7 59430.7 59434.0 59609.4 60297.7 8462.9 8820.0 8928.0 8936.9 9008.0 38944.6 39686.8 39812.4 40170.0 40503.8 53426.7 55129.7 55419.0 56282.6 56680.4 10868.7 11565.6 11829.3 11941.8 11995.0 12341.5 12447.8 12561.7 12712.0 12965.2 12126.5 12974.2 13209.9 13411.9 13721.9 12624.3 12878.4 12968.8 13088.0 13129.5 12079.8 12171.0 12304.2 12464.3 12550.0 9641.2 9694.8 10075.5 10201.6 10669.3 10409.2 10653.8 10785.7 10813.5 10892.7 21:40:08 INFO - PROCESS | 28064 | -------- Summary: end -------- 21:40:08 INFO - PROCESS | 28064 | 21:40:09 INFO - TEST-INFO | 28064: exit 0 21:40:09 INFO - TEST-OK | dromaeo_css | took 1120238ms 21:40:09 INFO - TEST-START | kraken 21:40:09 INFO - operating with platform_type : linux_ 21:40:09 INFO - Initialising browser for kraken test... 21:40:09 INFO - TEST-INFO | started process 28368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsO7Alk/profile http://localhost:44151/getInfo.html) 21:40:14 INFO - PROCESS | 28368 | __metrics Screen width/height:1600/1200 21:40:14 INFO - PROCESS | 28368 | colorDepth:24 21:40:14 INFO - PROCESS | 28368 | Browser inner width/height: 1024/697 21:40:14 INFO - PROCESS | 28368 | __metrics 21:40:15 INFO - PROCESS | 28368 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:40:15 INFO - PROCESS | 28368 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:40:16 INFO - PROCESS | 28368 | console.error: PushService: 21:40:16 INFO - PROCESS | 28368 | stateChangeProcessEnqueue: Error transitioning state 21:40:16 INFO - PROCESS | 28368 | UnknownError 21:40:17 INFO - TEST-INFO | 28368: exit 0 21:40:17 INFO - Browser initialized. 21:40:17 INFO - Running cycle 1/1 for kraken test... 21:40:17 INFO - TEST-INFO | started process 28453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsO7Alk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:40:29 INFO - PROCESS | 28453 | RSS: Main: 172421120 21:40:29 INFO - PROCESS | 28453 | 21:40:32 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44151/tests/kraken/driver.html?testName=audio-beat-detection) 21:40:32 INFO - PROCESS | 28453 | RSS: Main: 230506496 21:40:32 INFO - PROCESS | 28453 | 21:40:35 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44151/tests/kraken/driver.html?testName=audio-dft) 21:40:36 INFO - PROCESS | 28453 | RSS: Main: 217497600 21:40:36 INFO - PROCESS | 28453 | 21:40:39 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44151/tests/kraken/driver.html?testName=audio-fft) 21:40:39 INFO - PROCESS | 28453 | RSS: Main: 298721280 21:40:39 INFO - PROCESS | 28453 | 21:40:41 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44151/tests/kraken/driver.html?testName=audio-oscillator) 21:40:42 INFO - PROCESS | 28453 | RSS: Main: 209039360 21:40:42 INFO - PROCESS | 28453 | 21:40:44 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:40:45 INFO - PROCESS | 28453 | RSS: Main: 213774336 21:40:45 INFO - PROCESS | 28453 | 21:40:48 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44151/tests/kraken/driver.html?testName=imaging-darkroom) 21:40:48 INFO - PROCESS | 28453 | RSS: Main: 252682240 21:40:48 INFO - PROCESS | 28453 | 21:40:52 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44151/tests/kraken/driver.html?testName=imaging-desaturate) 21:40:52 INFO - PROCESS | 28453 | RSS: Main: 253513728 21:40:52 INFO - PROCESS | 28453 | 21:40:55 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44151/tests/kraken/driver.html?testName=json-parse-financial) 21:40:56 INFO - PROCESS | 28453 | RSS: Main: 251961344 21:40:56 INFO - PROCESS | 28453 | 21:40:57 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:40:58 INFO - PROCESS | 28453 | RSS: Main: 214573056 21:40:58 INFO - PROCESS | 28453 | 21:41:00 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:41:00 INFO - PROCESS | 28453 | RSS: Main: 221466624 21:41:00 INFO - PROCESS | 28453 | 21:41:02 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:41:03 INFO - PROCESS | 28453 | RSS: Main: 229629952 21:41:03 INFO - PROCESS | 28453 | 21:41:06 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:41:06 INFO - PROCESS | 28453 | RSS: Main: 239550464 21:41:06 INFO - PROCESS | 28453 | 21:41:09 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:41:10 INFO - PROCESS | 28453 | RSS: Main: 236146688 21:41:10 INFO - PROCESS | 28453 | 21:41:11 INFO - PROCESS | 28453 | Cycle 1(1): loaded http://localhost:44151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44151/tests/kraken/driver.html?testName=ai-astar) 21:41:12 INFO - PROCESS | 28453 | RSS: Main: 287698944 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | __start_tp_report 21:41:12 INFO - PROCESS | 28453 | _x_x_mozilla_page_load 21:41:12 INFO - PROCESS | 28453 | _x_x_mozilla_page_load_details 21:41:12 INFO - PROCESS | 28453 | |i|pagename|runs| 21:41:12 INFO - PROCESS | 28453 | |0;ai-astar;112;113;112;113;112;112;112;113;112;111 21:41:12 INFO - PROCESS | 28453 | |1;audio-beat-detection;150;121;127;166;127;124;126;124;146;123 21:41:12 INFO - PROCESS | 28453 | |2;audio-dft;162;161;160;162;161;163;162;162;161;161 21:41:12 INFO - PROCESS | 28453 | |3;audio-fft;74;74;74;108;78;76;76;76;98;76 21:41:12 INFO - PROCESS | 28453 | |4;audio-oscillator;84;83;111;84;84;84;101;83;83;106 21:41:12 INFO - PROCESS | 28453 | |5;imaging-gaussian-blur;127;127;128;127;127;127;127;127;127;126 21:41:12 INFO - PROCESS | 28453 | |6;imaging-darkroom;146;147;147;145;146;146;146;146;145;146 21:41:12 INFO - PROCESS | 28453 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;97;95 21:41:12 INFO - PROCESS | 28453 | |8;json-parse-financial;52;51;52;52;53;54;52;52;53;53 21:41:12 INFO - PROCESS | 28453 | |9;json-stringify-tinderbox;63;64;63;63;63;63;63;63;64;63 21:41:12 INFO - PROCESS | 28453 | |10;stanford-crypto-aes;83;90;82;82;89;81;80;81;81;82 21:41:12 INFO - PROCESS | 28453 | |11;stanford-crypto-ccm;140;134;140;140;137;130;131;136;187;149 21:41:12 INFO - PROCESS | 28453 | |12;stanford-crypto-pbkdf2;171;172;168;171;168;167;168;168;176;172 21:41:12 INFO - PROCESS | 28453 | |13;stanford-crypto-sha256-iterative;65;65;67;64;68;65;65;65;65;65 21:41:12 INFO - PROCESS | 28453 | __end_tp_report 21:41:12 INFO - PROCESS | 28453 | __start_cc_report 21:41:12 INFO - PROCESS | 28453 | _x_x_mozilla_cycle_collect,1664 21:41:12 INFO - PROCESS | 28453 | __end_cc_report 21:41:12 INFO - PROCESS | 28453 | __startTimestamp1481694072241__endTimestamp 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | ------- Summary: start ------- 21:41:12 INFO - PROCESS | 28453 | Number of tests: 14 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 21:41:12 INFO - PROCESS | 28453 | Values: 112.0 113.0 112.0 113.0 112.0 112.0 112.0 113.0 112.0 111.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:127.00 stddev:15.17 (11.9%) stddev-sans-first:14.86 21:41:12 INFO - PROCESS | 28453 | Values: 150.0 121.0 127.0 166.0 127.0 124.0 126.0 124.0 146.0 123.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 21:41:12 INFO - PROCESS | 28453 | Values: 162.0 161.0 160.0 162.0 161.0 163.0 162.0 162.0 161.0 161.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.90 (15.7%) stddev-sans-first:12.35 21:41:12 INFO - PROCESS | 28453 | Values: 74.0 74.0 74.0 108.0 78.0 76.0 76.0 76.0 98.0 76.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.50 stddev:11.10 (13.3%) stddev-sans-first:11.53 21:41:12 INFO - PROCESS | 28453 | Values: 84.0 83.0 111.0 84.0 84.0 84.0 101.0 83.0 83.0 106.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 21:41:12 INFO - PROCESS | 28453 | Values: 127.0 127.0 128.0 127.0 127.0 127.0 127.0 127.0 127.0 126.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:41:12 INFO - PROCESS | 28453 | Values: 146.0 147.0 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 21:41:12 INFO - PROCESS | 28453 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 97.0 95.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 21:41:12 INFO - PROCESS | 28453 | Values: 52.0 51.0 52.0 52.0 53.0 54.0 52.0 52.0 53.0 53.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 21:41:12 INFO - PROCESS | 28453 | Values: 63.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 63.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:3.48 (4.2%) stddev-sans-first:3.69 21:41:12 INFO - PROCESS | 28453 | Values: 83.0 90.0 82.0 82.0 89.0 81.0 80.0 81.0 81.0 82.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:140.00 stddev:16.58 (11.8%) stddev-sans-first:17.56 21:41:12 INFO - PROCESS | 28453 | Values: 140.0 134.0 140.0 140.0 137.0 130.0 131.0 136.0 187.0 149.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:171.00 stddev:2.81 (1.6%) stddev-sans-first:2.96 21:41:12 INFO - PROCESS | 28453 | Values: 171.0 172.0 168.0 171.0 168.0 167.0 168.0 168.0 176.0 172.0 21:41:12 INFO - PROCESS | 28453 | 21:41:12 INFO - PROCESS | 28453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 21:41:12 INFO - PROCESS | 28453 | Values: 65.0 65.0 67.0 64.0 68.0 65.0 65.0 65.0 65.0 65.0 21:41:12 INFO - PROCESS | 28453 | -------- Summary: end -------- 21:41:12 INFO - PROCESS | 28453 | 21:41:13 INFO - TEST-INFO | 28453: exit 0 21:41:13 INFO - TEST-OK | kraken | took 63935ms 21:41:13 INFO - SUITE-END | took 1184s 21:41:13 INFO - Completed test suite (00:19:44) 21:41:13 INFO - javascript benchmark 21:41:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.093893709761, 3289.950650740238, 3294.6469452352035, 3323.7341012718985, 3341.916452088699, 5234.581233501321, 5289.047971365153, 5366.436524164965, 5435.130379139338, 5458.235846981426, 5306.230596563496, 5318.813841515548, 5323.680579165243, 5328.866778330544, 5331.706756128411, 4787.999999999991, 4813.446453657839, 4815.759212039402, 4838.758062096898, 4849.175640141185, 4912.21404575268, 4984.651074424792, 4992.975035124819, 4996.225585034307, 4999.225120106389, 4918.336024636682, 4969.353983982095, 4972.453030166679, 4980.950190498103, 5001.449840517558, 4992.251162325662, 5000.549950504472, 5008.273800298973, 5013.623978201649, 5054.241863720435, 4739.881502962419, 4766.642501812378, 4827.275908613701, 4911.0, 4933.580645645125, 5322.547583455373, 5328.600354973392, 5328.653637513549, 5362.624616276862, 5426.158945363475, 5700.37295897451, 5753.338366087912, 5757.366689664175, 5759.222504961818, 5771.307443106812, 5606.635568688022, 5660.405657405954, 5737.168110623936, 5792.957267691814, 5798.681072541009, 5347.438518955531, 5354.9464505354445, 5367.543758780547, 5415.999999999961, 5418.160185171305, 5832.679202643811, 5846.123081537803, 5848.327442344185, 5849.970750146307, 5853.034249348895, 5517.5585953123655, 5543.7782488700805, 5634.295713035871, 5635.408282130317, 5636.239107720406, 5629.634073785191, 5668.688222147822, 5698.943010569924, 5722.341930677942, 5770.24986751728, 5635.380108188096, 5680.346760122557, 5685.772569097273, 5689.715514224272, 5691.402402747652, 5562.833115006556, 5690.886182276331, 5703.857403564944, 5707.486326230659, 5709.7716091356715, 4364.5635436456105, 4398.75806830621, 4409.625181859514, 4411.426514553087, 4430.091831174666, 4009.7594144351433, 4021.2962731521866, 4035.959640403617, 4050.4531888194715, 4060.025593857453, 5433.402325744165, 5435.809746658848, 5437.157240627709, 5437.429069947678, 5437.483439073281, 5652.491275785199, 5709.600327977002, 5747.85630359236, 5776.768929242783, 5829.387914269026, 5458.4814442627885, 5472.589555783332, 5478.698671573022, 5504.587155963319, 5520.06158952979, 4980.626453016038, 5017.197248440232, 5022.146235140035, 5029.396472423333, 5030.522100400456, 5811.041178205549, 5818.0981947798155, 5898.14476900847, 5967.373425790316, 5978.701064946736, 5676.091825307931, 5680.346760122638, 5710.086386178192, 5727.713614319351, 5780.901628690535, 5852.268466441695, 5890.911636325544, 5893.557983151367, 5894.941050589439, 5900.291964964232, 5497.285352904097, 5624.043912534797, 5626.549876009827, 5626.85932851682, 5630.155476678531, 5616.241807355955, 5724.570657200643, 5737.885242295214, 5749.7125143741805, 5825.0388685866355, 5607.130894711327, 5629.268195134607, 5634.070378387521, 5654.321481422256, 5659.26429564154, 5554.277943867433, 5599.412061733622, 5606.831795046155, 5614.382417934105, 5618.381977982501, 5371.086915224343, 5415.48552887475, 5453.454654534515, 5509.0359187141285, 5513.558915286848, 5622.943770562242, 5633.8309850704545, 5634.408387119293, 5635.436456354496, 5674.829755107354, 5402.648827826179, 5435.646682965595, 5502.504774570308, 5504.091824848855, 5505.091659876076], "value": 5300.092967013496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.441061296252, 580.8722081142147, 581.9592628516006, 583.9270091238595, 586.1588620329825, 31481.21296967577, 40631.187376252456, 42457.0, 42578.36132458012, 45556.772216138954, 43428.0, 43873.7806310968, 43887.56112438883, 43891.78054109733, 43932.78033609835, 7913.28780409763, 8574.228319451264, 8764.693235736751, 8767.386282960164, 8770.035296117421, 7876.645550950192, 10036.197104231644, 10280.640177593787, 10290.897091029068, 10593.84109238362, 10365.637202697908, 10427.739306517322, 10441.42572158531, 10442.0, 10444.63443779464, 10313.690589282296, 10373.377597344184, 10376.688699339033, 10387.42869142193, 10417.374957502498, 10244.897551024469, 10288.331258468175, 10300.639477618248, 10319.535620897077, 10322.071013608811, 40086.0, 40395.0, 40405.393919091235, 40423.59576404228, 40461.39307910384, 3363.4786608075788, 3416.538767266437, 3446.483027545888, 3463.722902167846, 3857.787821669807, 31280.0, 31484.21289467759, 31781.364372712414, 31804.522932156036, 31909.202269943205, 3953.347697629916, 4079.1643760307684, 4114.485689288839, 4192.832286708528, 4337.0458499130145, 294183.0, 294979.0, 295416.0, 295907.0, 296905.0, 56934.58392496381, 56938.145927811114, 56961.0, 57339.71330143323, 57356.71321643449, 58773.82874798085, 59399.0, 59462.70268648629, 59575.0, 59587.0, 15271.160086195143, 15359.692806143814, 15388.153651549272, 15403.922980385027, 15525.223738813014, 10682.572697092184, 10920.235583509078, 11479.483423245974, 11824.23142495735, 11829.585964491374, 16818.393149061914, 17221.827781722022, 17413.216405261795, 17445.65108697819, 17716.20277087534, 6401.263854656681, 6408.231012278557, 6419.614823110628, 6661.134052573231, 6662.5003124765835, 883.2845395229884, 1009.8182327181178, 1027.2244455436098, 1055.8363453664695, 1069.9781708468395, 30369.0, 30739.38521229563, 31148.68851311458, 31225.687743122733, 31320.53019204714, 1056.5456853552892, 1099.3623698254994, 1107.5016242690822, 1143.616888342398, 1183.0, 15450.227488625524, 16420.6715865682, 16509.6698066038, 16546.751798723028, 16731.91634041822, 412582.0, 416101.0, 418148.0, 419231.0, 420136.0, 55647.44352556504, 55896.0, 56027.0, 56072.719636401554, 56109.43890561124, 1161.8547681539808, 1221.0780860450302, 1266.069438962362, 1306.9934650326688, 1317.8682131786745, 30148.698513015468, 31164.37671246517, 31918.840405797822, 31945.520817188226, 32444.188895277806, 47817.8045548864, 48399.99999999859, 48410.273845891636, 48458.515414846814, 48462.5153748458, 333467.0, 335124.0, 336891.0, 337598.0, 337710.0, 24287.63568546438, 24582.754172458048, 24752.381190470383, 25696.100636477633, 25820.225393238234, 40493.797531012155, 40742.79628601838, 40775.388369173896, 41045.794771025954, 41148.1770364597, 34147.829260853534, 34338.141546461535, 34345.141371465914, 34709.13227169341, 34989.0, 34196.145096371794, 34585.0, 34678.479822802175, 34892.82553587318, 35220.823895880356, 33819.0, 34395.312093757486, 35041.824790875886, 35165.824170880005, 35210.8239458801, 30131.54802677918, 32466.35067298688, 32510.34979300448, 32558.511622326158, 32696.673033269362, 23855.284341469785, 24877.129300474397, 25047.509886522137, 25074.498510030062, 25312.367190820376], "value": 18965.034987710336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.65293491780426, 377.3735598905817, 381.20328513406974, 388.3805330497856, 412.74409865883155, 13969.580912572626, 17462.388816391427, 18011.54971125721, 18887.433376998677, 19053.333133340337, 17767.0, 18175.909120454413, 18262.08689565523, 18344.357947471843, 18493.81506184938, 4919.237518184678, 5192.0, 5193.636445448801, 5194.454582268864, 5195.454477279888, 3835.9041023974346, 4001.0397504598977, 4380.89047773805, 5111.0, 5152.098382783017, 4178.56125106864, 6055.606385584945, 6102.633841969474, 6167.87664246717, 6175.444210021097, 5586.581006424493, 5614.466625670555, 6170.012797952329, 6170.167027451282, 6180.536459765513, 5436.891262174774, 5482.095454250044, 5487.588430867661, 5491.36849262332, 5491.615586908918, 13672.31638418075, 13681.931590342085, 13784.172949623055, 13890.374933128034, 13920.721585568232, 2043.427840204745, 2124.1715730864976, 2179.3570896585547, 2239.1155493579945, 2250.4148921280585, 9948.452835094067, 9961.501924903798, 10158.492075396201, 10467.476626168662, 10543.472826358651, 1822.3075231411979, 1888.0, 1915.348781414326, 1927.2387406974308, 1964.5462357855226, 70735.64632176858, 70747.0, 72813.0, 73057.0, 74464.25535744628, 10548.789024219474, 10567.471626418648, 10595.788084238273, 10883.67348979532, 10963.56145754177, 14410.42358305656, 14506.782398264035, 14560.781588276184, 14584.562463126123, 14609.634759131106, 7335.0, 7674.923250767532, 7708.653110610036, 7842.803929901684, 7922.801929951682, 7223.27767223284, 7258.419326453976, 7281.417486601059, 7459.627018649046, 7483.176850546435, 4487.551244875552, 4541.568550987651, 4560.338750881104, 4615.9076818463445, 4703.74129422885, 1904.8476121910214, 1941.5437372217518, 1952.8925909075137, 1967.370441458748, 1983.652860749363, 856.6230858422274, 915.7390143808982, 927.8283517549276, 952.1335584617964, 1011.7723512209694, 17730.468085957444, 18686.906565467358, 18711.22243386876, 18877.811221887605, 18928.526786830163, 912.0843752321114, 945.5792172483317, 949.620151939216, 992.712113487095, 1011.438651548383, 9806.509674516246, 10241.334313269614, 10380.169586433067, 10387.117095046855, 10406.895931040744, 312609.0, 313543.0, 314753.0, 407943.0, 411200.0, 63053.36946630475, 72258.63870680718, 73236.26763732295, 75223.24776752162, 80908.0, 948.5162567090696, 979.1872745621117, 1000.9599616015278, 1003.2174903575223, 1004.7739258666742, 16184.595385115466, 16768.916155419145, 17190.14049297555, 17209.483715488554, 17519.737203941695, 34862.82568587141, 35536.64463355333, 37746.81126594349, 38225.426618600184, 38595.614043860325, 52996.0, 53879.730601346746, 54723.89570782128, 55058.44941550693, 57091.71454142703, 8167.387445941459, 8402.621882015446, 8549.743507694779, 8572.185642363966, 8837.91162088371, 10814.783704325711, 12555.74888502243, 12621.242725436503, 12821.294828784507, 12984.805227921399, 10883.78232435331, 10988.560457581607, 11059.22585419013, 11339.489722962651, 11595.884041159818, 6712.060311556288, 6980.7207711693, 10772.353658780497, 11083.334999900031, 11287.66137015858, 10801.297915635458, 11193.216474847008, 11225.270357426742, 11413.258138220988, 11487.885121149016, 8314.251717345467, 8345.374096942875, 8359.791005224917, 8484.363672724447, 8690.130986901258, 9774.609015639295, 10819.404932728776, 10891.618793342195, 11024.889751102386, 11072.446377681244], "value": 8503.1336859853, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.652778541472, 1377.958661240163, 1467.9192644404561, 1639.295103105664, 1681.9327226910925, 6978.79063628092, 7138.535995160324, 7309.634518274085, 7714.267144621259, 7747.883781743279, 7411.888821667666, 7633.084029916417, 7642.426817988659, 7815.609219539015, 7872.0, 2091.4980404702837, 2125.266782959884, 2131.6056529542007, 2132.3389749177804, 2133.328001679474, 1874.1753628403526, 1945.7956914523984, 2143.860649057814, 2167.869927804329, 2223.6442169252923, 2022.4741567192561, 2091.811736943675, 2103.4320733401973, 2104.8947552622385, 2106.6524023536176, 2119.8198153157, 2120.512282175093, 2136.5257971999426, 2141.4218161096496, 2158.8380871434706, 2151.483643925447, 2160.362693005567, 2160.8163306119, 2189.4745261137373, 2195.3633446300555, 7711.228877112244, 7800.063992320901, 7811.0, 7901.96049019757, 7911.485753426009, 4847.394075740533, 5011.098002359574, 5013.749312534395, 5016.573591244749, 5024.447310795809, 3055.5263934090253, 3089.582906307642, 3128.343047959931, 3192.808431494118, 3212.662670419619, 1042.7028296935337, 1065.1851333729703, 1866.608012317415, 1871.5414723392855, 1874.2690350763214, 9951.55218015191, 9981.351212171186, 10095.192384609287, 10096.29325947184, 10134.0, 4039.555648878621, 4112.979435102865, 4146.937795933063, 4161.313383291723, 4327.0, 8670.393072484992, 8673.956630216808, 8696.13038696138, 8706.825863482694, 8714.69498567547, 4878.487758785347, 4893.437254715754, 4897.853064408074, 4903.387076615423, 4907.411110666671, 4371.890702732457, 4444.488883778342, 4577.977110114428, 4581.923248036709, 4601.171789077931, 3328.3509715605223, 3348.8493017814258, 3350.949735753966, 3371.8145501997624, 3416.0947348952545, 978.5987745024648, 1023.8771347438355, 1030.5877648940484, 1033.4109557552274, 1036.5905467340508, 793.6745934166964, 793.8610743120047, 841.7937605286621, 860.5181098584812, 877.5305211711703, 4940.407151141814, 5007.273945277914, 5041.0, 5089.821856235014, 5313.362396512443, 840.9873851892227, 873.2010210657304, 873.9169778870997, 905.3571963905569, 927.2998885841147, 3318.4192766265805, 3485.3029394121277, 3500.842462089212, 3622.7464077514846, 3725.5715592707184, 8710.21608055278, 9017.188453039258, 9132.22376098039, 9138.68014619485, 9157.358984870994, 9136.269098472107, 9143.679971200976, 9150.08499150093, 9151.03914089011, 9168.587413566405, 7074.575525468488, 7204.92795072053, 7258.346748792634, 7421.628918554051, 7432.368248698813, 5218.478152184751, 5279.947200527946, 5344.759485823225, 5481.780728770805, 5580.0, 8639.222469977733, 8681.652733890574, 8726.171013753683, 8859.955700221457, 8987.281017518713, 8844.557772111497, 9164.633414663605, 9169.495677737521, 9303.72088837336, 9304.116108969638, 6814.420774234246, 6967.686454109678, 6978.371946524837, 7002.494463690331, 7006.439484841302, 7137.500374973702, 7369.226231245642, 7404.185539590533, 7413.221611730691, 7463.477556570988, 6694.263631000684, 6704.698288577123, 6870.819993107315, 7088.468364872759, 7147.249538798351, 6428.4214420702365, 6749.257581666111, 6750.763723269662, 6904.585724856524, 6946.8610627788175, 6055.909161362495, 6087.421694938974, 6097.695115244132, 6119.541034422525, 6120.877582448237, 4419.668524860584, 4439.955600443955, 4465.687401881837, 4486.416765820422, 4524.117797029548, 4422.071365013383, 4450.732956022649, 4480.238359478832, 4484.932726009178, 4659.8136074558], "value": 4157.82338692451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.39857629927656, 383.8023417939761, 385.1507426125394, 391.9372900335947, 394.1663381947181, 5096.38843338799, 5242.554382877455, 5245.501677340656, 5277.89444211116, 5308.309919710432, 5076.593872490201, 5204.401493828211, 5210.739463026843, 5233.075193604796, 5240.44975277596, 4220.155968806235, 4222.451081359419, 4222.619964203221, 4229.450171477703, 4246.490421149467, 3956.2108713357015, 3993.362721284274, 4201.516825565053, 4220.451341325624, 4233.682473814476, 4166.270902592049, 4185.686073544481, 4186.937195942063, 4193.769342686151, 4202.453681021463, 4169.291220492509, 4177.394277829728, 4180.352045432963, 4189.392538081961, 4195.895102622444, 3776.15036616759, 3781.3193625147464, 3782.8486860525545, 3783.50814394127, 3791.1659434924272, 4973.552380285755, 5030.773615187325, 5083.3391659084455, 5099.36257967754, 5132.178851383798, 4810.927836082462, 4818.373611430527, 4831.323614693911, 4836.202026665596, 4842.757862106881, 5423.647462914898, 5504.2294078829, 5506.201600767866, 5527.723613819293, 5545.916811247835, 4153.677058353305, 4164.7917604119675, 4171.249175148472, 4181.832726690959, 4188.769617671027, 5624.493795558419, 5712.400197979194, 5716.685582292931, 5719.71401429931, 5721.914171287434, 4231.217224813419, 4253.595908388698, 4260.488741351058, 4271.423357846651, 4275.850345237902, 4215.302206587787, 4282.76444795533, 4289.284286285449, 4298.376735373354, 4335.978320108379, 4761.333413322138, 4767.0, 4767.356406885096, 4785.95214047862, 4788.880277993008, 5459.863503412446, 5480.177973304037, 5482.451754824566, 5496.835094947158, 5506.614536982453, 1384.9653758656113, 1438.7769895666188, 1449.9420023199166, 1469.3608280398062, 1477.571504263773, 1012.8733908261468, 1032.9586816527255, 1041.9791604167874, 1050.9595500454495, 1054.1882750282239, 5089.287499750038, 5142.408623008327, 5162.509561591718, 5169.431362550116, 5170.1986192140275, 5355.250264962909, 5372.355317361864, 5385.30362935674, 5399.244105825188, 5417.133258678671, 4948.946187332217, 5067.24184201891, 5074.213496907985, 5154.690718556899, 5166.535011848877, 2893.9131826045254, 2899.2027192521805, 2899.536074228113, 2904.3174853909313, 2912.3301640622776, 5571.9442805572235, 5579.0, 5582.804601838916, 5585.469380408855, 5618.185363122406, 5460.535854452416, 5557.610967232255, 5781.913271300934, 5810.6513609183585, 5826.650400975955, 5862.736176871966, 5864.914990726644, 5871.4715675589405, 5878.970605146947, 5888.352281249145, 5539.778408863762, 5630.380658127521, 5734.827955161351, 5736.5410767139365, 5745.253117094751, 5574.91637625444, 5584.6492104736835, 5590.636608620427, 5591.496765290981, 5600.719964001865, 5722.484976352148, 5741.1388291756575, 5757.712114394348, 5772.56705747079, 5773.162891380643, 3864.594217607223, 4006.759594424344, 4017.6584990276156, 4034.3545032794614, 4061.5735347789237, 5579.832605021856, 5579.972100139474, 5611.7194140292, 5619.93221287954, 5636.239107720406, 5464.28964234647, 5470.64440811346, 5527.364353099284, 5540.0, 5554.0, 5298.470152984671, 5489.670619762827, 5532.557395408277, 5540.390557038642, 5560.471755183251, 5442.0, 5477.616566840283, 5498.752556134904, 5506.972465137648, 5510.0, 5314.0, 5586.972065139648, 5600.663960162403, 5616.66300022, 5620.494155526022, 5369.221462887781, 5384.949934762683, 5400.7569659364635, 5408.323959505062, 5408.540274076748], "value": 4253.240771610459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.4906440959121, 726.2954933714295, 730.6821532633305, 760.7223363472334, 803.91156972733, 13098.738025239501, 13915.165090094577, 13938.094023888452, 13938.790918136236, 13949.999999999987, 13872.861271387283, 13997.790033149486, 13998.580042598738, 14009.579712608613, 14015.579532614038, 650.278191207759, 662.615682903917, 750.7034721285089, 755.7052749427714, 765.2156539546982, 751.6730222353267, 751.8609057324385, 758.4311766175341, 761.3946912204783, 761.8057395364202, 802.4864086984335, 803.2609998801117, 804.4288555125838, 807.5881300536739, 808.014222648371, 673.4780545077604, 698.0541366448491, 787.9369650427952, 802.257911431926, 802.9638666260032, 593.6734795862259, 598.019248432571, 598.186466405688, 598.3806760003375, 598.4105655928906, 12897.935510322483, 12918.095733298673, 12936.417861196269, 12938.0, 12938.288394138319, 13513.932430337785, 13854.584362469142, 13883.4446622135, 13958.09272397301, 14103.365348559237, 12731.872681273162, 12759.298238596873, 12774.48902043917, 12929.094963352569, 13630.182189068688, 4189.120284740208, 4206.3690446432975, 4286.592773686495, 4340.218760623086, 4438.667099967515, 78140.21859781386, 80187.59906200548, 82302.58848705779, 83423.0, 84644.57677711634, 10519.31624444424, 10572.894271057345, 10751.247412681038, 10769.676909692722, 10873.728156796144, 21361.57276854454, 21465.356039318845, 21569.676454852877, 21632.134714611555, 21853.890730546245, 7347.926520734831, 7382.6677799498075, 7437.330640242404, 7462.776116716507, 7518.586477743667, 4336.284513055373, 4370.0, 4375.124975004948, 4382.298832186835, 4514.390557274792, 3061.1581815001055, 3101.7673674474504, 3117.7817552771544, 3126.4841301185506, 3133.592632957701, 550.7246376811594, 556.6187161794184, 558.2435799491631, 568.5877738639454, 572.9684867332253, 565.2171742137169, 588.8439563515672, 594.1058706646469, 619.6096459230656, 651.4755621724463, 8289.668413263402, 8294.958525207456, 8342.290905273, 8478.788030299293, 8570.400071995025, 621.3879328861068, 640.5356116815271, 642.4635429416489, 644.2751904107879, 645.6803882078401, 3998.460207871958, 4229.661627069889, 4255.893602659959, 4263.339182426729, 4273.55127711592, 60194.69902650546, 61071.6946415274, 62835.0, 71639.28360716431, 78372.21627783764, 48371.758141209066, 50460.24309635358, 54486.727566361915, 61828.69085654633, 63423.68288158622, 57169.714151429805, 59430.702846486354, 59434.0, 59609.403905961255, 60297.69851150804, 8462.873056904029, 8820.0, 8927.97727532298, 8936.910630893608, 9007.954960225157, 38944.61055389523, 39686.801565991984, 39812.40281395723, 40170.0, 40503.797481013586, 53426.73286633542, 55129.72435137798, 55419.0, 56282.55761635787, 56680.43319566917, 10868.67393978182, 11565.59520416815, 11829.290242585472, 11941.761164776482, 11995.0, 12341.54484794768, 12447.751044978868, 12561.748765024831, 12712.0, 12965.222086674452, 12126.539541109185, 12974.156679815782, 13209.867901320864, 13411.865881341062, 13721.931390342985, 12624.284123449183, 12878.35608219604, 12968.805467918177, 13088.0, 13129.540466083641, 12079.818802717791, 12171.0, 12304.200226985216, 12464.252144871336, 12550.0, 9641.180499657608, 9694.75763105928, 10075.496225188564, 10201.59193632276, 10669.253152279265, 10409.219308552041, 10653.79639765126, 10785.676429707122, 10813.451023978627, 10892.673219803419], "value": 6714.1475145482045, "unit": "score"}], "name": "dromaeo_css", "value": 6829.77569615696, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0, 111.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 127.0, 166.0, 127.0, 124.0, 126.0, 124.0, 146.0, 123.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 108.0, 78.0, 76.0, 76.0, 76.0, 98.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 111.0, 84.0, 84.0, 84.0, 101.0, 83.0, 83.0, 106.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 53.0, 54.0, 52.0, 52.0, 53.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 82.0, 82.0, 89.0, 81.0, 80.0, 81.0, 81.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 140.0, 140.0, 137.0, 130.0, 131.0, 136.0, 187.0, 149.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 168.0, 171.0, 168.0, 167.0, 168.0, 168.0, 176.0, 172.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 64.0, 68.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1523.6, "alertThreshold": 2.0}]} 21:41:14 INFO - Return code: 0 21:41:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:41:14 INFO - # TBPL SUCCESS # 21:41:14 INFO - Running post-action listener: _resource_record_post_action 21:41:14 INFO - [mozharness: 2016-12-14 05:41:14.072846Z] Finished run-tests step (success) 21:41:14 INFO - Running post-run listener: _resource_record_post_run 21:41:14 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 12288; Write bytes: 297840640; Read time: 480; Write time: 912976 21:41:14 INFO - TinderboxPrint: CPU usage
13.3% 21:41:14 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 480 21:41:14 INFO - TinderboxPrint: I/O write bytes / time
297,840,640 / 912,976 21:41:14 INFO - TinderboxPrint: CPU idle
8,312.2 (86.7%) 21:41:14 INFO - TinderboxPrint: CPU user
1,207.1 (12.6%) 21:41:14 INFO - TinderboxPrint: Swap in / out
0 / 0 21:41:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1650688; Read time: 0; Write time: 524 21:41:14 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296189952; Read time: 472; Write time: 912452 21:41:14 INFO - Running post-run listener: _upload_blobber_files 21:41:14 INFO - Blob upload gear active. 21:41:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:41:14 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 21:41:14 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:41:14 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:41:15 INFO - (blobuploader) - INFO - Open directory for files ... 21:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:41:15 INFO - (blobuploader) - INFO - Done attempting. 21:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:41:19 INFO - (blobuploader) - INFO - Done attempting. 21:41:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:41:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:41:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:41:20 INFO - (blobuploader) - INFO - Done attempting. 21:41:20 INFO - (blobuploader) - INFO - Iteration through files over. 21:41:20 INFO - Return code: 0 21:41:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:41:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:41:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3f6b31a09b360d2c1a5dba492ccad27cb95a306f1f6f2ea0951e198e81d5cc775b56515237654495c9b2a9dee642ce96dc466de0e3788d29d1bd2fb3eee9d00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f19161c90d90d845020d30abb1211b08afeac56f51df1fa755b44b9456eb183899a7a7487f787b4dc4542e120a38374b8fa20eac1984ae72829eb5402f61e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fec408fd4a6a90086bec3da87094f0c1160ef3a14b31fba813ca088ac70f0d40cd88d7b388b5041988824401fb4df0fc1e71f699df7f61457df35534aa1b921"} 21:41:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:41:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:41:20 INFO - Contents: 21:41:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3f6b31a09b360d2c1a5dba492ccad27cb95a306f1f6f2ea0951e198e81d5cc775b56515237654495c9b2a9dee642ce96dc466de0e3788d29d1bd2fb3eee9d00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f19161c90d90d845020d30abb1211b08afeac56f51df1fa755b44b9456eb183899a7a7487f787b4dc4542e120a38374b8fa20eac1984ae72829eb5402f61e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fec408fd4a6a90086bec3da87094f0c1160ef3a14b31fba813ca088ac70f0d40cd88d7b388b5041988824401fb4df0fc1e71f699df7f61457df35534aa1b921"} 21:41:20 INFO - Running post-run listener: copy_logs_to_upload_dir 21:41:20 INFO - Copying logs to upload dir... 21:41:20 INFO - mkdir: /builds/slave/test/build/upload/logs 21:41:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.155856 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-12-13 21:41:20.627434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 21:41:20.631009) ========= 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=8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3f6b31a09b360d2c1a5dba492ccad27cb95a306f1f6f2ea0951e198e81d5cc775b56515237654495c9b2a9dee642ce96dc466de0e3788d29d1bd2fb3eee9d00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f19161c90d90d845020d30abb1211b08afeac56f51df1fa755b44b9456eb183899a7a7487f787b4dc4542e120a38374b8fa20eac1984ae72829eb5402f61e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fec408fd4a6a90086bec3da87094f0c1160ef3a14b31fba813ca088ac70f0d40cd88d7b388b5041988824401fb4df0fc1e71f699df7f61457df35534aa1b921"} build_url:https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/EKUIbXbETQS6BN3Tn2ZBDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3f6b31a09b360d2c1a5dba492ccad27cb95a306f1f6f2ea0951e198e81d5cc775b56515237654495c9b2a9dee642ce96dc466de0e3788d29d1bd2fb3eee9d00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f19161c90d90d845020d30abb1211b08afeac56f51df1fa755b44b9456eb183899a7a7487f787b4dc4542e120a38374b8fa20eac1984ae72829eb5402f61e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fec408fd4a6a90086bec3da87094f0c1160ef3a14b31fba813ca088ac70f0d40cd88d7b388b5041988824401fb4df0fc1e71f699df7f61457df35534aa1b921"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 21:41:20.657661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:41:20.658007) ========= 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=8783db0840cc980e80bb0bd400000236-1481691834.176834-1800960235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 21:41:20.740650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 21:41:20.740970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 21:41:20.741298) ========= ========= Total master_lag: 0.18 =========