builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1476982842.41 results: success (0) buildid: 20161020065049 builduid: 8689e5b19be84d7c951db8ec90d0addb revision: 28693367b10643274c2a1e754b98f35231d765b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.414289) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.414789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.415069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.429762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.430065) ========= 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=32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 10:00:42-- 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% 222M=0s 2016-10-20 10:00:42 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.532668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.532964) ========= 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=32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016872 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.582838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:42.583186) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28693367b10643274c2a1e754b98f35231d765b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28693367b10643274c2a1e754b98f35231d765b7 --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=32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 10:00:43,046 truncating revision to first 12 chars 2016-10-20 10:00:43,046 Setting DEBUG logging. 2016-10-20 10:00:43,046 attempt 1/10 2016-10-20 10:00:43,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/28693367b106?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 10:00:43,375 unpacking tar archive at: mozilla-aurora-28693367b106/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:43.313654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:43.313956) ========= script_repo_revision: 28693367b10643274c2a1e754b98f35231d765b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:43.314359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:43.314625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 10:00:43.325411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-20 10:00:43.325683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:43 INFO - MultiFileLogger online at 20161020 10:00:43 in /builds/slave/test 10:00:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:00:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:43 INFO - {'append_to_log': False, 10:00:43 INFO - 'base_work_dir': '/builds/slave/test', 10:00:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:00:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:43 INFO - 'branch': 'Mozilla-Aurora', 10:00:43 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:43 INFO - 'config_files': ('talos/linux_config.py',), 10:00:43 INFO - 'default_actions': ('clobber', 10:00:43 INFO - 'read-buildbot-config', 10:00:43 INFO - 'download-and-extract', 10:00:43 INFO - 'populate-webroot', 10:00:43 INFO - 'create-virtualenv', 10:00:43 INFO - 'install', 10:00:43 INFO - 'run-tests'), 10:00:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:43 INFO - 'download_minidump_stackwalk': True, 10:00:43 INFO - 'download_symbols': 'ondemand', 10:00:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:43 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:43 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:43 INFO - 'installer_path': 'installer.exe', 10:00:43 INFO - 'log_level': 'info', 10:00:43 INFO - 'log_name': 'talos', 10:00:43 INFO - 'log_to_console': True, 10:00:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:43 INFO - 'opt_config_files': (), 10:00:43 INFO - 'pip_index': False, 10:00:43 INFO - 'sps_profile': False, 10:00:43 INFO - 'sps_profile_interval': 0, 10:00:43 INFO - 'suite': 'dromaeojs', 10:00:43 INFO - 'system_bits': '32', 10:00:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:43 INFO - 'title': 'talos-linux64-ix-008', 10:00:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:43 INFO - 'use_talos_json': True, 10:00:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:43 INFO - 'work_dir': 'build'} 10:00:43 INFO - [mozharness: 2016-10-20 17:00:43.883427Z] Running clobber step. 10:00:43 INFO - Running pre-action listener: _resource_record_pre_action 10:00:43 INFO - Running main action method: clobber 10:00:43 INFO - rmtree: /builds/slave/test/build 10:00:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:44 INFO - Running post-action listener: _resource_record_post_action 10:00:44 INFO - [mozharness: 2016-10-20 17:00:44.350028Z] Finished clobber step (success) 10:00:44 INFO - [mozharness: 2016-10-20 17:00:44.350133Z] Running read-buildbot-config step. 10:00:44 INFO - Running pre-action listener: _resource_record_pre_action 10:00:44 INFO - Running main action method: read_buildbot_config 10:00:44 INFO - Using buildbot properties: 10:00:44 INFO - { 10:00:44 INFO - "project": "", 10:00:44 INFO - "product": "firefox", 10:00:44 INFO - "script_repo_revision": "production", 10:00:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:00:44 INFO - "repository": "", 10:00:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:00:44 INFO - "buildid": "20161020065049", 10:00:44 INFO - "pgo_build": "True", 10:00:44 INFO - "basedir": "/builds/slave/test", 10:00:44 INFO - "buildnumber": 537, 10:00:44 INFO - "slavename": "talos-linux64-ix-008", 10:00:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:00:44 INFO - "platform": "ubuntu64_hw", 10:00:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:00:44 INFO - "branch": "mozilla-aurora", 10:00:44 INFO - "repo_path": "releases/mozilla-aurora", 10:00:44 INFO - "revision": "28693367b10643274c2a1e754b98f35231d765b7", 10:00:44 INFO - "stage_platform": "linux64-pgo", 10:00:44 INFO - "builduid": "8689e5b19be84d7c951db8ec90d0addb", 10:00:44 INFO - "slavebuilddir": "test" 10:00:44 INFO - } 10:00:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 10:00:44 INFO - Running post-action listener: _resource_record_post_action 10:00:44 INFO - [mozharness: 2016-10-20 17:00:44.352545Z] Finished read-buildbot-config step (success) 10:00:44 INFO - [mozharness: 2016-10-20 17:00:44.352634Z] Running download-and-extract step. 10:00:44 INFO - Running pre-action listener: _resource_record_pre_action 10:00:44 INFO - Running main action method: download_and_extract 10:00:44 INFO - mkdir: /builds/slave/test/build/tests 10:00: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')]} 10:00:44 INFO - trying https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 10:00:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 10:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:00:44 INFO - Downloaded 1361 bytes. 10:00:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 10:00:44 INFO - Using the following test package requirements: 10:00:44 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 10:00:44 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:44 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:00:44 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'jsshell-linux-x86_64.zip'], 10:00:44 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:44 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 10:00:44 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:00:44 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:00:44 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:44 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 10:00:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:00:45 INFO - Expected file size: 21907803 10:00:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:00:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 10:00:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:00:50 INFO - Expected file size: 21907803 10:00:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 10:00:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:00:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 10:00:55 INFO - Expected file size: 14414081 10:00: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')]} 10:00:56 INFO - trying https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:00:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:00:57 INFO - Downloaded 64001396 bytes. 10:00:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:00:57 INFO - mkdir: /builds/slave/test/properties 10:00:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:57 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:57 INFO - Contents: 10:00:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 10:00:58 INFO - Running post-action listener: _resource_record_post_action 10:00:58 INFO - Running post-action listener: set_extra_try_arguments 10:00:58 INFO - [mozharness: 2016-10-20 17:00:58.230419Z] Finished download-and-extract step (success) 10:00:58 INFO - [mozharness: 2016-10-20 17:00:58.230718Z] Running populate-webroot step. 10:00:58 INFO - Running pre-action listener: _resource_record_pre_action 10:00:58 INFO - Running main action method: populate_webroot 10:00:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:58 INFO - '--tppagecycles', 10:00:58 INFO - '7'], 10:00:58 INFO - 'tests': ['tsvgm']}}, 10:00:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['damp', 'tps']}, 10:00:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'tests': ['damp', 'tps']}, 10:00:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['dromaeo_dom']}, 10:00:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['basic_compositor_video']}, 10:00:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['a11yr', 10:00:58 INFO - 'ts_paint', 10:00:58 INFO - 'tpaint', 10:00:58 INFO - 'sessionrestore', 10:00:58 INFO - 'sessionrestore_no_auto_restore', 10:00:58 INFO - 'tabpaint']}, 10:00:58 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:58 INFO - 'ts_paint', 10:00:58 INFO - 'tpaint', 10:00:58 INFO - 'sessionrestore', 10:00:58 INFO - 'sessionrestore_no_auto_restore', 10:00:58 INFO - 'tabpaint']}, 10:00:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:58 INFO - 'ts_paint', 10:00:58 INFO - 'tpaint', 10:00:58 INFO - 'sessionrestore', 10:00:58 INFO - 'sessionrestore_no_auto_restore', 10:00:58 INFO - 'tabpaint']}, 10:00:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:58 INFO - 'ts_paint', 10:00:58 INFO - 'tpaint', 10:00:58 INFO - 'sessionrestore', 10:00:58 INFO - 'sessionrestore_no_auto_restore', 10:00:58 INFO - 'tabpaint']}, 10:00:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['a11yr', 10:00:58 INFO - 'ts_paint', 10:00:58 INFO - 'tpaint', 10:00:58 INFO - 'sessionrestore', 10:00:58 INFO - 'sessionrestore_no_auto_restore', 10:00:58 INFO - 'tabpaint']}, 10:00:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['a11yr', 10:00:58 INFO - 'ts_paint', 10:00:58 INFO - 'tpaint', 10:00:58 INFO - 'sessionrestore', 10:00:58 INFO - 'sessionrestore_no_auto_restore', 10:00:58 INFO - 'tabpaint']}, 10:00:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['tsvgx', 10:00:58 INFO - 'tsvgr_opacity', 10:00:58 INFO - 'tart', 10:00:58 INFO - 'tscrollx', 10:00:58 INFO - 'cart']}, 10:00:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:58 INFO - 'tsvgr_opacity', 10:00:58 INFO - 'tart', 10:00:58 INFO - 'tscrollx', 10:00:58 INFO - 'cart']}, 10:00:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'talos_options': ['--disable-e10s'], 10:00:58 INFO - 'tests': ['tp5o']}, 10:00:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'tests': ['tp5o']}, 10:00:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'talos_options': ['--disable-e10s', 10:00:58 INFO - '--xperf_path', 10:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:58 INFO - 'tests': ['tp5n']}, 10:00:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:58 INFO - 'talos_options': ['--xperf_path', 10:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:58 INFO - 'tests': ['tp5n']}}, 10:00:58 INFO - 'talos.zip': {'path': '', 10:00:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:58 INFO - Running post-action listener: _resource_record_post_action 10:00:58 INFO - [mozharness: 2016-10-20 17:00:58.252699Z] Finished populate-webroot step (success) 10:00:58 INFO - [mozharness: 2016-10-20 17:00:58.252791Z] Running create-virtualenv step. 10:00:58 INFO - Running pre-action listener: _resource_record_pre_action 10:00:58 INFO - Running main action method: create_virtualenv 10:00:58 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:58 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 10:00:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:58 INFO - Using real prefix '/usr' 10:00:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:58 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:00 INFO - Installing pip.................done. 10:01:00 INFO - Return code: 0 10:01:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:00 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:00 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 10:01:00 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 10:01:00 INFO - Using env: {'DISPLAY': ':0', 10:01:00 INFO - 'HOME': '/home/cltbld', 10:01:00 INFO - 'LANG': 'en_US.UTF-8', 10:01:00 INFO - 'LANGUAGE': 'en_US:en', 10:01:00 INFO - 'LOGNAME': 'cltbld', 10:01:00 INFO - 'MAIL': '/var/mail/cltbld', 10:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:00 INFO - 'MOZ_NO_REMOTE': '1', 10:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:00 INFO - 'NO_EM_RESTART': '1', 10:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:00 INFO - 'PWD': '/builds/slave/test', 10:01:00 INFO - 'SHELL': '/bin/bash', 10:01:00 INFO - 'SHLVL': '1', 10:01:00 INFO - 'TERM': 'linux', 10:01:00 INFO - 'TMOUT': '86400', 10:01:00 INFO - 'USER': 'cltbld', 10:01:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:00 INFO - '_': '/tools/buildbot/bin/python'} 10:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:01 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 10:01:01 INFO - Cleaning up... 10:01:01 INFO - Return code: 0 10:01:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01:01 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')]} 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:01 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')]} 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:01 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:01 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 10:01:01 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 10:01:01 INFO - Using env: {'DISPLAY': ':0', 10:01:01 INFO - 'HOME': '/home/cltbld', 10:01:01 INFO - 'LANG': 'en_US.UTF-8', 10:01:01 INFO - 'LANGUAGE': 'en_US:en', 10:01:01 INFO - 'LOGNAME': 'cltbld', 10:01:01 INFO - 'MAIL': '/var/mail/cltbld', 10:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:01 INFO - 'MOZ_NO_REMOTE': '1', 10:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:01 INFO - 'NO_EM_RESTART': '1', 10:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:01 INFO - 'PWD': '/builds/slave/test', 10:01:01 INFO - 'SHELL': '/bin/bash', 10:01:01 INFO - 'SHLVL': '1', 10:01:01 INFO - 'TERM': 'linux', 10:01:01 INFO - 'TMOUT': '86400', 10:01:01 INFO - 'USER': 'cltbld', 10:01:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:01 INFO - '_': '/tools/buildbot/bin/python'} 10:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:01 INFO - Downloading/unpacking psutil>=3.1.1 10:01:01 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 10:01:01 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 10:01:01 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 10:01:01 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 10:01:01 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 10:01:01 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 10:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:03 INFO - Installing collected packages: psutil 10:01:03 INFO - Running setup.py install for psutil 10:01:03 INFO - building 'psutil._psutil_linux' extension 10:01:03 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 10:01:03 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 10:01:03 INFO - building 'psutil._psutil_posix' extension 10:01:03 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 10:01:03 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 10:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:03 INFO - Successfully installed psutil 10:01:03 INFO - Cleaning up... 10:01:03 INFO - Return code: 0 10:01:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:03 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 10:01:03 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 10:01:03 INFO - Using env: {'DISPLAY': ':0', 10:01:03 INFO - 'HOME': '/home/cltbld', 10:01:03 INFO - 'LANG': 'en_US.UTF-8', 10:01:03 INFO - 'LANGUAGE': 'en_US:en', 10:01:03 INFO - 'LOGNAME': 'cltbld', 10:01:03 INFO - 'MAIL': '/var/mail/cltbld', 10:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:03 INFO - 'MOZ_NO_REMOTE': '1', 10:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:03 INFO - 'NO_EM_RESTART': '1', 10:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:03 INFO - 'PWD': '/builds/slave/test', 10:01:03 INFO - 'SHELL': '/bin/bash', 10:01:03 INFO - 'SHLVL': '1', 10:01:03 INFO - 'TERM': 'linux', 10:01:03 INFO - 'TMOUT': '86400', 10:01:03 INFO - 'USER': 'cltbld', 10:01:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:03 INFO - '_': '/tools/buildbot/bin/python'} 10:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:06 INFO - Installing collected packages: mozsystemmonitor 10:01:06 INFO - Running setup.py install for mozsystemmonitor 10:01:06 INFO - Successfully installed mozsystemmonitor 10:01:06 INFO - Cleaning up... 10:01:06 INFO - Return code: 0 10:01:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01:06 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')]} 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:06 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')]} 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:06 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:06 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 10:01:06 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 10:01:06 INFO - Using env: {'DISPLAY': ':0', 10:01:06 INFO - 'HOME': '/home/cltbld', 10:01:06 INFO - 'LANG': 'en_US.UTF-8', 10:01:06 INFO - 'LANGUAGE': 'en_US:en', 10:01:06 INFO - 'LOGNAME': 'cltbld', 10:01:06 INFO - 'MAIL': '/var/mail/cltbld', 10:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:06 INFO - 'MOZ_NO_REMOTE': '1', 10:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:06 INFO - 'NO_EM_RESTART': '1', 10:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:06 INFO - 'PWD': '/builds/slave/test', 10:01:06 INFO - 'SHELL': '/bin/bash', 10:01:06 INFO - 'SHLVL': '1', 10:01:06 INFO - 'TERM': 'linux', 10:01:06 INFO - 'TMOUT': '86400', 10:01:06 INFO - 'USER': 'cltbld', 10:01:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:06 INFO - '_': '/tools/buildbot/bin/python'} 10:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:06 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:06 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 10:01:06 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 10:01:06 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 10:01:06 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 10:01:06 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 10:01:06 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 10:01:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:08 INFO - warning: no files found matching '*.txt' 10:01:08 INFO - no previously-included directories found matching 'build' 10:01:08 INFO - no previously-included directories found matching 'dist' 10:01:08 INFO - no previously-included directories found matching '.git*' 10:01:08 INFO - Installing collected packages: jsonschema, functools32 10:01:08 INFO - Running setup.py install for functools32 10:01:08 INFO - warning: no files found matching '*.txt' 10:01:08 INFO - no previously-included directories found matching 'build' 10:01:08 INFO - no previously-included directories found matching 'dist' 10:01:08 INFO - no previously-included directories found matching '.git*' 10:01:08 INFO - Successfully installed jsonschema functools32 10:01:08 INFO - Cleaning up... 10:01:08 INFO - Return code: 0 10:01:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:08 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 10:01:08 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 10:01:08 INFO - Using env: {'DISPLAY': ':0', 10:01:08 INFO - 'HOME': '/home/cltbld', 10:01:08 INFO - 'LANG': 'en_US.UTF-8', 10:01:08 INFO - 'LANGUAGE': 'en_US:en', 10:01:08 INFO - 'LOGNAME': 'cltbld', 10:01:08 INFO - 'MAIL': '/var/mail/cltbld', 10:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:08 INFO - 'MOZ_NO_REMOTE': '1', 10:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:08 INFO - 'NO_EM_RESTART': '1', 10:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:08 INFO - 'PWD': '/builds/slave/test', 10:01:08 INFO - 'SHELL': '/bin/bash', 10:01:08 INFO - 'SHLVL': '1', 10:01:08 INFO - 'TERM': 'linux', 10:01:08 INFO - 'TMOUT': '86400', 10:01:08 INFO - 'USER': 'cltbld', 10:01:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:08 INFO - '_': '/tools/buildbot/bin/python'} 10:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:01:08 INFO - Cleaning up... 10:01:08 INFO - Return code: 0 10:01:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:08 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 10:01:08 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 10:01:09 INFO - Using env: {'DISPLAY': ':0', 10:01:09 INFO - 'HOME': '/home/cltbld', 10:01:09 INFO - 'LANG': 'en_US.UTF-8', 10:01:09 INFO - 'LANGUAGE': 'en_US:en', 10:01:09 INFO - 'LOGNAME': 'cltbld', 10:01:09 INFO - 'MAIL': '/var/mail/cltbld', 10:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:09 INFO - 'MOZ_NO_REMOTE': '1', 10:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:09 INFO - 'NO_EM_RESTART': '1', 10:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:09 INFO - 'PWD': '/builds/slave/test', 10:01:09 INFO - 'SHELL': '/bin/bash', 10:01:09 INFO - 'SHLVL': '1', 10:01:09 INFO - 'TERM': 'linux', 10:01:09 INFO - 'TMOUT': '86400', 10:01:09 INFO - 'USER': 'cltbld', 10:01:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:09 INFO - '_': '/tools/buildbot/bin/python'} 10:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:09 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:09 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 10:01:09 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 10:01:09 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 10:01:09 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 10:01:09 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 10:01:09 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 10:01:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 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 10:01:11 INFO - Downloading docopt-0.6.1.tar.gz 10:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:11 INFO - Running setup.py install for blobuploader 10:01:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:01:12 INFO - Running setup.py install for requests 10:01:12 INFO - Running setup.py install for docopt 10:01:12 INFO - Successfully installed blobuploader requests docopt 10:01:12 INFO - Cleaning up... 10:01:12 INFO - Return code: 0 10:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:12 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:12 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 10:01:12 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 10:01:12 INFO - Using env: {'DISPLAY': ':0', 10:01:12 INFO - 'HOME': '/home/cltbld', 10:01:12 INFO - 'LANG': 'en_US.UTF-8', 10:01:12 INFO - 'LANGUAGE': 'en_US:en', 10:01:12 INFO - 'LOGNAME': 'cltbld', 10:01:12 INFO - 'MAIL': '/var/mail/cltbld', 10:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:12 INFO - 'MOZ_NO_REMOTE': '1', 10:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:12 INFO - 'NO_EM_RESTART': '1', 10:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:12 INFO - 'PWD': '/builds/slave/test', 10:01:12 INFO - 'SHELL': '/bin/bash', 10:01:12 INFO - 'SHLVL': '1', 10:01:12 INFO - 'TERM': 'linux', 10:01:12 INFO - 'TMOUT': '86400', 10:01:12 INFO - 'USER': 'cltbld', 10:01:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:12 INFO - '_': '/tools/buildbot/bin/python'} 10:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:12 INFO - Running setup.py (path:/tmp/pip-_st2DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:12 INFO - Running setup.py (path:/tmp/pip-DEsqtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:12 INFO - Running setup.py (path:/tmp/pip-ZaZ7et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:12 INFO - Running setup.py (path:/tmp/pip-1WnggP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:13 INFO - Running setup.py (path:/tmp/pip-dsv5NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:13 INFO - Running setup.py (path:/tmp/pip-AupeP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:13 INFO - Running setup.py (path:/tmp/pip-uSQ6Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:13 INFO - Running setup.py (path:/tmp/pip-SQdhK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:13 INFO - Running setup.py (path:/tmp/pip-iDCEfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:13 INFO - Running setup.py (path:/tmp/pip-57iv7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:13 INFO - Running setup.py (path:/tmp/pip-EbGdGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:13 INFO - Running setup.py (path:/tmp/pip-jB3cfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:13 INFO - Running setup.py (path:/tmp/pip-2963Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:13 INFO - Running setup.py (path:/tmp/pip-54pQrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:13 INFO - Running setup.py (path:/tmp/pip-ktkkla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:13 INFO - Running setup.py (path:/tmp/pip-qUCbTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:13 INFO - Running setup.py (path:/tmp/pip-V_ysq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:13 INFO - Running setup.py install for manifestparser 10:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Running setup.py install for mozcrash 10:01:14 INFO - Running setup.py install for mozdebug 10:01:14 INFO - Running setup.py install for mozdevice 10:01:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Running setup.py install for mozfile 10:01:14 INFO - Running setup.py install for mozhttpd 10:01:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Running setup.py install for mozinfo 10:01:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Running setup.py install for mozInstall 10:01:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Running setup.py install for mozleak 10:01:14 INFO - Running setup.py install for mozlog 10:01:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:01:14 INFO - Running setup.py install for moznetwork 10:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Running setup.py install for mozprocess 10:01:15 INFO - Running setup.py install for mozprofile 10:01:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Running setup.py install for mozrunner 10:01:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Running setup.py install for mozscreenshot 10:01:15 INFO - Running setup.py install for moztest 10:01:15 INFO - Running setup.py install for mozversion 10:01:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:15 INFO - Cleaning up... 10:01:15 INFO - Return code: 0 10:01:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:15 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:15 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 10:01:15 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 10:01:15 INFO - Using env: {'DISPLAY': ':0', 10:01:15 INFO - 'HOME': '/home/cltbld', 10:01:15 INFO - 'LANG': 'en_US.UTF-8', 10:01:15 INFO - 'LANGUAGE': 'en_US:en', 10:01:15 INFO - 'LOGNAME': 'cltbld', 10:01:15 INFO - 'MAIL': '/var/mail/cltbld', 10:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:15 INFO - 'MOZ_NO_REMOTE': '1', 10:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:15 INFO - 'NO_EM_RESTART': '1', 10:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:15 INFO - 'PWD': '/builds/slave/test', 10:01:15 INFO - 'SHELL': '/bin/bash', 10:01:15 INFO - 'SHLVL': '1', 10:01:15 INFO - 'TERM': 'linux', 10:01:15 INFO - 'TMOUT': '86400', 10:01:15 INFO - 'USER': 'cltbld', 10:01:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:15 INFO - '_': '/tools/buildbot/bin/python'} 10:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:16 INFO - Running setup.py (path:/tmp/pip-qHtave-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:16 INFO - Running setup.py (path:/tmp/pip-R0LuSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:16 INFO - Running setup.py (path:/tmp/pip-99bNoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:16 INFO - Running setup.py (path:/tmp/pip-EyWiYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:16 INFO - Running setup.py (path:/tmp/pip-7sGM8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:16 INFO - Running setup.py (path:/tmp/pip-fqwYHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:16 INFO - Running setup.py (path:/tmp/pip-1GLbEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:16 INFO - Running setup.py (path:/tmp/pip-skZ9CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:16 INFO - Running setup.py (path:/tmp/pip-ZZrX2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:16 INFO - Running setup.py (path:/tmp/pip-IP3Neb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:16 INFO - Running setup.py (path:/tmp/pip-ApU1VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:16 INFO - Running setup.py (path:/tmp/pip-L_l0nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:16 INFO - Running setup.py (path:/tmp/pip-1dsuXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:16 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)) 10:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:16 INFO - Running setup.py (path:/tmp/pip-YPWsQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:17 INFO - Running setup.py (path:/tmp/pip-HH81bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:17 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)) 10:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:17 INFO - Running setup.py (path:/tmp/pip-ruzNxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:17 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)) 10:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:17 INFO - Running setup.py (path:/tmp/pip-5E5QUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:17 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)) 10:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:17 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)) 10:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:17 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 10:01:17 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 10:01:17 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 10:01:17 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 10:01:17 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 10:01:17 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 10:01:19 INFO - Downloading blessings-1.6.tar.gz 10:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:19 INFO - Installing collected packages: blessings 10:01:19 INFO - Running setup.py install for blessings 10:01:19 INFO - Successfully installed blessings 10:01:19 INFO - Cleaning up... 10:01:19 INFO - Return code: 0 10:01:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:19 INFO - Reading from file tmpfile_stdout 10:01:19 INFO - Current package versions: 10:01:19 INFO - argparse == 1.2.1 10:01:19 INFO - blessings == 1.6 10:01:19 INFO - blobuploader == 1.2.4 10:01:19 INFO - docopt == 0.6.1 10:01:19 INFO - functools32 == 3.2.3-2 10:01:19 INFO - jsonschema == 2.5.1 10:01:19 INFO - manifestparser == 1.1 10:01:19 INFO - mozInstall == 1.12 10:01:19 INFO - mozcrash == 0.17 10:01:19 INFO - mozdebug == 0.1 10:01:19 INFO - mozdevice == 0.48 10:01:19 INFO - mozfile == 1.2 10:01:19 INFO - mozhttpd == 0.7 10:01:19 INFO - mozinfo == 0.9 10:01:19 INFO - mozleak == 0.1 10:01:19 INFO - mozlog == 3.4 10:01:19 INFO - moznetwork == 0.27 10:01:19 INFO - mozprocess == 0.23 10:01:19 INFO - mozprofile == 0.28 10:01:19 INFO - mozrunner == 6.12 10:01:19 INFO - mozscreenshot == 0.1 10:01:19 INFO - mozsystemmonitor == 0.3 10:01:19 INFO - moztest == 0.7 10:01:19 INFO - mozversion == 1.4 10:01:19 INFO - psutil == 3.1.1 10:01:19 INFO - requests == 1.2.3 10:01:19 INFO - wsgiref == 0.1.2 10:01:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:19 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:19 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 10:01:19 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 10:01:19 INFO - Using env: {'DISPLAY': ':0', 10:01:19 INFO - 'HOME': '/home/cltbld', 10:01:19 INFO - 'LANG': 'en_US.UTF-8', 10:01:19 INFO - 'LANGUAGE': 'en_US:en', 10:01:19 INFO - 'LOGNAME': 'cltbld', 10:01:19 INFO - 'MAIL': '/var/mail/cltbld', 10:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:19 INFO - 'MOZ_NO_REMOTE': '1', 10:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:19 INFO - 'NO_EM_RESTART': '1', 10:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:19 INFO - 'PWD': '/builds/slave/test', 10:01:19 INFO - 'SHELL': '/bin/bash', 10:01:19 INFO - 'SHLVL': '1', 10:01:19 INFO - 'TERM': 'linux', 10:01:19 INFO - 'TMOUT': '86400', 10:01:19 INFO - 'USER': 'cltbld', 10:01:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:19 INFO - '_': '/tools/buildbot/bin/python'} 10:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 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)) 10:01:19 INFO - Cleaning up... 10:01:19 INFO - Return code: 0 10:01:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:19 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 0x7f1d065ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, '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': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', '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 10:01:19 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 10:01:19 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 10:01:19 INFO - Using env: {'DISPLAY': ':0', 10:01:19 INFO - 'HOME': '/home/cltbld', 10:01:19 INFO - 'LANG': 'en_US.UTF-8', 10:01:19 INFO - 'LANGUAGE': 'en_US:en', 10:01:19 INFO - 'LOGNAME': 'cltbld', 10:01:19 INFO - 'MAIL': '/var/mail/cltbld', 10:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:19 INFO - 'MOZ_NO_REMOTE': '1', 10:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:19 INFO - 'NO_EM_RESTART': '1', 10:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:19 INFO - 'PWD': '/builds/slave/test', 10:01:19 INFO - 'SHELL': '/bin/bash', 10:01:19 INFO - 'SHLVL': '1', 10:01:19 INFO - 'TERM': 'linux', 10:01:19 INFO - 'TMOUT': '86400', 10:01:19 INFO - 'USER': 'cltbld', 10:01:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:19 INFO - '_': '/tools/buildbot/bin/python'} 10:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:01:20 INFO - Cleaning up... 10:01:20 INFO - Return code: 0 10:01:20 INFO - Running post-action listener: _resource_record_post_action 10:01:20 INFO - Running post-action listener: _start_resource_monitoring 10:01:20 INFO - Starting resource monitoring. 10:01:20 INFO - [mozharness: 2016-10-20 17:01:20.134697Z] Finished create-virtualenv step (success) 10:01:20 INFO - [mozharness: 2016-10-20 17:01:20.135148Z] Running install step. 10:01:20 INFO - Running pre-action listener: _resource_record_pre_action 10:01:20 INFO - Running main action method: install 10:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:20 INFO - Reading from file tmpfile_stdout 10:01:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:01:20 INFO - Reading from file tmpfile_stdout 10:01:20 INFO - Output received: 10:01:20 INFO - Usage: mozinstall [options] installer 10:01:20 INFO - Options: 10:01:20 INFO - -h, --help show this help message and exit 10:01:20 INFO - -d DEST, --destination=DEST 10:01:20 INFO - Directory to install application into. [default: 10:01:20 INFO - "/builds/slave/test"] 10:01:20 INFO - --app=APP Application being installed. [default: firefox] 10:01:20 INFO - mkdir: /builds/slave/test/build/application 10:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:01:36 INFO - Reading from file tmpfile_stdout 10:01:36 INFO - Output received: 10:01:36 INFO - /builds/slave/test/build/application/firefox/firefox 10:01:36 INFO - Running post-action listener: _resource_record_post_action 10:01:36 INFO - [mozharness: 2016-10-20 17:01:36.402821Z] Finished install step (success) 10:01:36 INFO - [mozharness: 2016-10-20 17:01:36.403066Z] Running run-tests step. 10:01:36 INFO - Running pre-action listener: _resource_record_pre_action 10:01:36 INFO - Running main action method: run_tests 10:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:36 INFO - Python 2.7.3 10:01:36 INFO - Return code: 0 10:01:36 INFO - grabbing minidump binary from tooltool 10:01: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')]} 10:01:36 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 0x1b75f60>, '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 0x1b76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b771d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:36 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 10:01:36 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 10:01:36 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 10:01:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:36 INFO - Return code: 0 10:01:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:01:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:01:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 10:01:36 INFO - Using env: {'DISPLAY': ':0', 10:01:36 INFO - 'HOME': '/home/cltbld', 10:01:36 INFO - 'LANG': 'en_US.UTF-8', 10:01:36 INFO - 'LANGUAGE': 'en_US:en', 10:01:36 INFO - 'LOGNAME': 'cltbld', 10:01:36 INFO - 'MAIL': '/var/mail/cltbld', 10:01:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:36 INFO - 'MOZ_NO_REMOTE': '1', 10:01:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:36 INFO - 'NO_EM_RESTART': '1', 10:01:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:36 INFO - 'PWD': '/builds/slave/test', 10:01:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:36 INFO - 'SHELL': '/bin/bash', 10:01:36 INFO - 'SHLVL': '1', 10:01:36 INFO - 'TERM': 'linux', 10:01:36 INFO - 'TMOUT': '86400', 10:01:36 INFO - 'USER': 'cltbld', 10:01:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292', 10:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:36 INFO - '_': '/tools/buildbot/bin/python'} 10:01:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:01:36 INFO - mozversion application_buildid: 20161020065049 10:01:36 INFO - mozversion application_changeset: 28693367b10643274c2a1e754b98f35231d765b7 10:01:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:01:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:36 INFO - mozversion application_name: Firefox 10:01:36 INFO - mozversion application_remotingname: firefox-dev 10:01:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:01:36 INFO - mozversion application_vendor: Mozilla 10:01:36 INFO - mozversion application_version: 51.0a2 10:01:36 INFO - mozversion platform_buildid: 20161020065049 10:01:36 INFO - mozversion platform_changeset: 28693367b10643274c2a1e754b98f35231d765b7 10:01:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:01:36 INFO - mozversion platform_version: 51.0a2 10:01:36 INFO - using testdate: 1476982896 10:01:36 INFO - actual date: 1476982896 10:01:36 INFO - starting webserver on 'localhost:43021' 10:01:36 INFO - SUITE-START | Running 2 tests 10:01:36 INFO - TEST-START | dromaeo_css 10:01:36 INFO - operating with platform_type : linux_ 10:01:36 INFO - Initialising browser for dromaeo_css test... 10:01:36 INFO - TEST-INFO | started process 27885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDmliC8/profile http://localhost:43021/getInfo.html) 10:01:40 INFO - PROCESS | 27885 | __metrics Screen width/height:1600/1200 10:01:40 INFO - PROCESS | 27885 | colorDepth:24 10:01:40 INFO - PROCESS | 27885 | Browser inner width/height: 1024/697 10:01:40 INFO - PROCESS | 27885 | __metrics 10:01:41 INFO - PROCESS | 27885 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:01:41 INFO - PROCESS | 27885 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:41 INFO - PROCESS | 27885 | console.error: PushService: 10:01:41 INFO - PROCESS | 27885 | stateChangeProcessEnqueue: Error transitioning state 10:01:41 INFO - PROCESS | 27885 | UnknownError 10:01:42 INFO - TEST-INFO | 27885: exit 0 10:01:42 INFO - Browser initialized. 10:01:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:42 INFO - TEST-INFO | started process 27975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDmliC8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:54 INFO - PROCESS | 27975 | RSS: Main: 144224256 10:01:54 INFO - PROCESS | 27975 | 10:02:45 INFO - PROCESS | 27975 | 1476982965057 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] 10:04:54 INFO - PROCESS | 27975 | Cycle 1(1): loaded http://localhost:43021/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43021/tests/dromaeo/cssquery-ext.html) 10:04:55 INFO - PROCESS | 27975 | RSS: Main: 235143168 10:04:55 INFO - PROCESS | 27975 | 10:07:57 INFO - PROCESS | 27975 | Cycle 1(1): loaded http://localhost:43021/tests/dromaeo/cssquery-ext.html (next: http://localhost:43021/tests/dromaeo/cssquery-jquery.html) 10:07:58 INFO - PROCESS | 27975 | RSS: Main: 233816064 10:07:58 INFO - PROCESS | 27975 | 10:10:59 INFO - PROCESS | 27975 | Cycle 1(1): loaded http://localhost:43021/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43021/tests/dromaeo/cssquery-mootools.html) 10:11:00 INFO - PROCESS | 27975 | RSS: Main: 175280128 10:11:00 INFO - PROCESS | 27975 | 10:14:02 INFO - PROCESS | 27975 | Cycle 1(1): loaded http://localhost:43021/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43021/tests/dromaeo/cssquery-prototype.html) 10:14:03 INFO - PROCESS | 27975 | RSS: Main: 227442688 10:14:03 INFO - PROCESS | 27975 | 10:17:05 INFO - PROCESS | 27975 | Cycle 1(1): loaded http://localhost:43021/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43021/tests/dromaeo/cssquery-yui.html) 10:17:06 INFO - PROCESS | 27975 | RSS: Main: 175661056 10:17:06 INFO - PROCESS | 27975 | 10:20:08 INFO - PROCESS | 27975 | Cycle 1(1): loaded http://localhost:43021/tests/dromaeo/cssquery-yui.html (next: http://localhost:43021/tests/dromaeo/cssquery-dojo.html) 10:20:09 INFO - PROCESS | 27975 | RSS: Main: 267874304 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | __start_tp_report 10:20:09 INFO - PROCESS | 27975 | _x_x_mozilla_page_load 10:20:09 INFO - PROCESS | 27975 | _x_x_mozilla_page_load_details 10:20:09 INFO - PROCESS | 27975 | |i|pagename|runs| 10:20:09 INFO - PROCESS | 27975 | |0;dojo.html;3120.8439578021103;3161.936761264774;3169.4453470642648;3187.2987942652608;3202.679732026796;5507.7246137693155;5579.69311687858;5580.10718285075;5582.413846546115;5595.692236926968;5478.753456094475;5546.278983732119;5552.972235138819;5557.5831812614015;5569.0254205514075;5013.824516141935;5030.748462576857;5070.619703522232;5073.239014147889;5138.075146473652;4964.851054468371;5058.772355244005;5101.4133374662015;5108.080545501808;5113.054084994269;4920.3111564381015;5045.142325804603;5086.237064440326;5088.592912566985;5107.616928730342;5150.793968241266;5162.845114646567;5169.198774190007;5223.843284701465;5226.1638137898135;5075.746212689351;5144.0740666679985;5198.870028249286;5211.322528071364;5233;5413.621046526745;5433.320834895638;5435.83692489226;5464.863378415572;5473.425290344497;5851.970740146272;5863.76544938202;5865.941340586583;5967.761289548456;5978.163057171956;6000.099985002241;6005.879882402372;6009.399060094;6012.789552365646;6016.338202797689;5390.434004429518;5419.701916394597;5528.834134975917;5576.219329293902;5597.188407680864;6086.482648974798;6123.234595675541;6130.448259656563;6130.846728831815;6134.8159555213415;5914.378990205966;5923.466887980103;5935.050391937356;5935.2877654681715;5935.495482884004;5806.68063256525;5810.12848072784;5848.9707551462825;5869.7945571904775;5892.29292484896;5928.525717942554;5936.317323507766;5937.287525496968;5949.672767997802;5956.463918247378;5904.291485021739;5943.791967281124;5961.463468287875;5966.075258334965;5999.370066143079;4442.489113751895;4491.685582009293;4508.954910450919;4576.565226303496;4582.495925448198;4045.2516284486874;4049.6760259179196;4095.344744840811;4105.220008198433;4110.588941105865;5637.46444087811;5646.209530665628;5646.661200327993;5649.096144616841;5649.124385720138;5770.336411312753;5828.504577110993;6014.609050411709;6021.879562408727;6024.698765061817;5635.042042852725;5689.288838895138;5727.1695604138;5790.160426738184;5795.623284486495;5137.640365174402;5144.511271429208;5148.073346797538;5148.588112950955;5153.819616313411;6228.968855155786;6237.407446292595;6282.528810339151;6294.464970477561;6297.622142671455;5836.474717275466;5899.705014749159;5904.173415721716;5927.4665280125;5929.2884853816095;6143.174139895698;6145.047517634774;6145.324014358506;6147.84630384244;6160.476359509492;5848.941510584839;5850.824475265749;5862.355140934408;5872.765089396376;5890.4993075587345;5754.136879468113;5850.2102216200265;5853;5867.6772777497645;5928.4960778334325;5872.765089396376;5874.295084589877;5874.441928016831;5875.735591898289;5884.205632239593;5818.301803783404;5839.0949402842625;5844;5847.06446968483;5852.385499522489;5637.408072152365;5648.604597678123;5818.418158184148;5821.621594596338;5838.036723940502;5901.822945311647;6000.639961602318;6002.969985150221;6029.095635654687;6030.879382412415;5788.884222315614;5828.504577110823;5836.328822185503;5840.795572154954;5841.415858414124 10:20:09 INFO - PROCESS | 27975 | |1;ext.html;596.4125336543503;607.8055022392834;624.5971348480231;626.3517259636271;644.4457766320966;35925.10187245317;38999;46788.76605616971;48047.0390592188;48119;48508;48720.75639621797;48751.26873096897;48948.26577601339;49028.50971490284;8394.076651568323;9399.859002114974;9553.426794392324;9562.521873906311;9563.90436095637;8602.612882420306;8905.73282801517;8913.643454261823;11001.394923279257;11273.774524509505;11480.311181329105;11536.192466527347;11546.769064618702;11547.480363383667;11556.711082222928;11326.886731132707;11386.430678466044;11409.942950285236;11410.828837567444;11420.600278990238;11129.387883666395;11198.104151667847;11200.719982000433;11209.719757006058;11210;45297;45681.54318456839;45710.77144614289;45724.54275457236;45743.771281143716;3824.082220267144;4206.936895946563;4430.9556904430865;4546.931796023062;4585.839495617637;34418.31163376718;34775;35415.11462213465;35546.023660942425;36552.086197845;4444.777761111964;4481;4508.07584445188;4509.526499717515;4714.198586240347;395213;395752;395820;396075;399147;39142.41286380707;62097.689511552155;62335;62473.37526624766;62497;39740.80129599333;41676.166476670296;41884.58115418868;41902.79048604737;41914.58085419107;17314.220860061327;17426.825731742774;17457.912710436365;17463.47609571715;17463.563410914576;13947.511837085856;13971.79042314366;13977.231252281019;13991;14003.089799163023;8946.284297256203;9185.586648600829;9308.720738377859;9532.571034303473;9570.138687518018;3570.553680789901;3633.5821380541047;3659.688926441282;3678.6689197971778;3695.1501154734024;984.6701355045997;1073.2380010192694;1104.2877344113;1140.7547377313751;1208.9335086570147;32431.837840811117;34305.31389372249;34325.65674343224;34843.82578087144;35696.46455303173;1138.6754774889116;1171.4845467994055;1212.1938910624513;1215.6231568213705;1231.132051903406;18048.458546243633;18212.908935455238;18315.54211144732;18326.45020649356;18428.539286517946;567393;567715;568409;568673;572039;63651.68174159192;64559.354406456274;64574.35425645777;64665.35334646687;64719;1418.907770994882;1433.3120102350929;1461.4373466215584;1466.486729644616;1467.757819959716;31949.20126996844;34462.48306275358;34507.65492345044;34750.47874281837;34852.477212842336;55567;56316.43683563112;56341.71829140828;56354.43645563492;56376.7181164108;541927;542819;545422;551809;554572;46536.53463465322;47219.29171062368;47759;48166;48600.54198374054;51699.224511631604;52462.47537524576;52644.736776315876;53362;53837;43690.56309436865;44198.55801441945;45088.54911450975;45455.72345600166;45644;42642.36036459394;42798.78600606977;42867.57132428761;44793;45157.77421112874;44081.55918440774;44587.77706111449;45687.31469027901;45740;45750.77124614356;37191.62808371882;39563.20873582455;39673;40733.38899916445;40823.38764918588;29645.924785264826;29844.701552984192;29971.250718732204;29990.400191996476;30058 10:20:09 INFO - PROCESS | 27975 | |2;jquery.html;393.8778978516662;432.978171515224;436.6310467654832;438.1652951128101;443.4146926057603;16360;19325.453963682907;20701.68947465789;20860.374188774324;21025.36923892282;19561.70657440136;19833.305834295803;20444.897775511137;20517.897410512964;20649.690254646193;5823.970880145594;5847.619904706202;6067.362926892679;6077.5137988961;6079.057746049347;5866.354700982888;5888.440598143191;5943.257092863392;5954.374790646984;5955.34491205967;5746.856328591798;5836.5914385993;5909.054551271797;5910;5915.704214789243;5834.27071616048;5886.293644762613;5889.175515427822;5954.1664167016215;5957.136215248808;5252.395974462947;5300.602454815904;5345.01117293302;5369.7583608737705;5377.4084850666395;23783.048678052855;23941.88029059861;24150.396240093964;24168.879155604285;24207.636885446733;2551.7703406693486;2683.087750164934;2688.2204160793344;2700.0819721294856;3180.316232010106;14615;15313.6171595711;15433.228338583025;15554.688906221925;15801.367945282174;1796.0301437223884;1804.530821986293;1839.0804597701149;1918.5299601597558;1943.5335519475366;81947.18052819515;83066;84213.57893210556;84666;86319.56840215759;10295.330803497749;11282.774344513064;11400.258983166068;11490.195686301879;11525.308481491138;15066.472673456376;15083.924580377028;15950.840491594936;15961.441349552942;16609.584760380847;8909.73270801877;9071.909280907106;9146.86279705805;9175.632974681072;9400.764980875396;8871.733847984571;8931.151540603632;8961.731148065568;9121.270298376114;9165.81668366629;6889.138857642794;7151.928480715126;7176.354128128493;7203.747868824671;7220.783376498714;1995.9600807983759;2012.2152360579387;2063.649179639465;2073.968890466644;2078.3557097299886;991.6033586565432;1041.375174895057;1092.7377429416883;1113.660333598244;1117.0672488472055;20572.691409628867;20890.582188356148;20893.37319880406;21101.306000827004;21195.576088478145;1034.462079718557;1048.5962904281907;1067.199600299775;1099.1701265544464;1101.0695961912172;10705.785884282272;11984.64046078619;12079.818802717966;12191.87808121925;12238;375700;377260;518433;520764;521555;58329;65557;96051.51974240223;97459.51270243745;100574;1033.3851358441716;1034.5654824973528;1059.131512160037;1066.903978641926;1075.7471994081384;18132.365367212613;18404.907975460035;18580.44258672242;18735.156917938453;18740.156692949124;33730.66269337275;39968.80015599904;40076.398854017796;43384.34923476087;45517;54761;54937.725311373186;57916.420835791105;58915.79978031727;59319.40680593139;8500.404971651926;8635.971137335871;8795.296376289754;8851.336149788664;8987.101289870961;9666.613335466502;12853.16454430459;12999.480020799063;13713.520026799015;13866.930665346608;11502.48238829238;11923.642290730944;11953.521859125538;12030.458629361525;12320.815187772012;11443.485043173243;11609.593664221711;11610.361430121424;11633.127515436207;11998.76002479963;11217.270877392943;11287.266327688674;11848.585299514476;12073;12365.381730913597;8335.374846886387;8392.790180245298;8407.327413807003;8475.660973560989;8926.330525210506;10382.948085259526;11085.334879907232;11258.21192516516;11262.324260544394;11743.17797754149 10:20:09 INFO - PROCESS | 27975 | |3;mootools.html;1542.1441100189395;1553.9922300388496;1707.1720215695386;1814.310561986445;1821.4171465131162;8990.865137022949;9696.224302055836;9697.854532182022;9698;9702.369345992514;8340.582970851448;8600.526971016592;8967;9242.768930776734;9467.668631597895;2514.6479492870967;2535.1887396033276;2542.3008672615088;2544.033267358401;2544.1936225279983;2426.8786560671897;2553.0936517536284;2555.591105423133;2560.0783717861555;2560.372708686365;2523.6466894634764;2524.7349028352032;2571.434284457416;2573.9485210295784;2575.163072001598;2464.5194187133516;2473.418746594558;2474.6659201007815;2510.7740303372784;2516.6225066240027;2445.6698345723275;2451.595486744685;2453.0065323543995;2457.9262622121364;2473.5547601431736;9445.905540944572;9549;9599.42403455795;9603.759906002337;9608.183304419133;5507.366652834895;5651.660900345993;5660.632058916157;5663.377028526858;5667.574931880125;3342.5153352763955;3453.4947028765823;3464.84408201629;3475.8609655613745;3530.735194860396;1178.6808289602031;1210;1229.7233122547354;1230.1696354960454;1236.2397125767677;13322;13348.733025339536;13350.532731354357;13377.732445351136;13378.86621133786;4911.926321105187;4912.1158191525865;5030.798768049311;5083.491650834887;5114.897702045938;11341.546338146547;11375.715607109889;11379.146564007568;11381.430928453545;11384.943075284571;5586.16207568868;5631.80288689902;5635.859103522363;5638.830835074954;5640.097584386478;4631.1895418301665;4685.1800934836265;5135.435102138762;5226.477352264819;5273.762680679379;4276.657867370603;4311.590398912098;4379.605835474823;4412.536683648235;4431.645468362588;1355.9186448813102;1390.4855203574741;1390.5133203378737;1401.8668226518464;1405.156905856478;1033.214756784849;1050.3645294596658;1057.4025675493322;1059.057438879398;1061.1510791366875;6394.241583564557;6438.227412710505;6561.901571476432;6565.916623757122;6716.46268298535;497.53231961955646;499.24963967845974;506.29372026024225;507.2442061328594;509.4447052712561;4314.41755363022;4325.480942286946;4358.869233922987;4363.432753742057;4508;11550.249233799945;11832.94083529594;11910.464029118537;11915.642530723919;11939.820902686466;10815.459227038617;11587.420628968517;11788.764224715458;11830.467628956718;11854.881451185378;8331.37514686401;8587.613557389808;8593.957030214933;8597.699080532277;8598.5700714964;6280.654563998841;6334.714937827901;6351.587146835441;6582.308857569887;6605.900911486236;10741.516631751747;10762.838557421488;10981.670549883516;11016.449177540931;11078.224524283545;11135.443227838414;11244.66266012021;11331.490082946451;11337.716557086138;11355.54577816878;7469.663865126191;7672.309492145734;7683.692652293846;8478.957605212181;8560.443571168104;8519.8722019171;9083.227925626396;9169.449833010041;9425.38734982224;9425.905740942502;7901.960490197513;8115.391345648982;8220.917790822015;8348.958255208685;8464.365172611955;8117.228863258218;8148.592570371577;8150.5924703763385;8229.79425514367;8469.915300846913;7555.395568354628;7604.619769011417;7644.847103058019;7802.648880800264;7889.921100788919;5620.522255608319;5623.831285061455;5782.653040817564;5787.56593255516;5954.404559544011;5450.127979523258;5544.168374743821;5552.750126244409;5575.972120139536;5580.693061881636 10:20:09 INFO - PROCESS | 27975 | |4;prototype.html;345.3352296828605;353.1266630525065;359.7104331013535;369.66360611843226;372.6906667466002;5302.496262855023;5426.647267927582;5439.836804895855;5465.234867118596;5488.506034456898;5292.973535132319;5399.271098401724;5425.755840987155;5432;5445.863853403667;4373.846915357955;4374.409454723604;4378.540253273408;4381.715188512737;4392.385066090734;4205.705600607958;4313.654907607384;4357.607815296623;4369.563043695621;4380.408644832954;4306.676999225071;4328.350747387901;4331.805068771912;4333.71830830995;4347.7173983690955;4312.1375724855;4341.131773645284;4349.26062569364;4352.73883566987;4354.825806967718;3642.7450078494517;3764.0025393270807;3769.4157405602177;3775.244951009809;3801.068738159141;5323.653962492425;5335.813246536352;5339.41266460689;5340.946590534084;5346.8395948121615;4896.387951506062;4905.705657660552;4920.655554111214;4932.1861892788;4933.1860243059855;5524.14375771752;5680.289963754531;5728.169415434781;5737.913931291034;5743.368229494752;4130.339145736668;4145.274576949022;4163.666906647461;4164.500259968823;4178.582141785828;5798.304203495608;5907.940920590782;5937.495312898409;5938.8218353449465;5941.910871336933;4138.337865941435;4168.145530166309;4171.33258678616;4176.749395036247;4179.832806687759;4210.536840947493;4210.72630279037;4214.578542145761;4223.331783945325;4223.767692776927;4843.782029808667;4845.491223421561;4851.272309153655;4853.538913803253;4859.854204373874;5495.862603434946;5635.380108188096;5718.656880587095;5728.971355143281;5760.177513018674;1439.2731670506328;1457.9065700724457;1485.2276816055808;1490.3070072416162;1498.7826765119214;958.1903291718487;977.4623956823718;991.7272749993665;995.8008398320364;1002.178213864624;5552.500274975271;5552.52803511706;5556.638818476786;5557.972210139004;5567.498925096761;5838.2702162229725;5853.024928810477;5860.948667966263;5879.3826648202175;5884;5343.625946183807;5557.166425036196;5562.972185139049;5626.774929002794;5671.744771485293;3118.0489950565297;3150.8739650414186;3162.798136708036;3165.667604901498;3169.302753394296;5824.563157763185;6144.969275153685;6179.876402471926;6195.349488303754;6195.628262304276;6045.274567051894;6094.512439004869;6100.267967843798;6131.202943617302;6136.6624835633575;6143.416375444325;6176.845578860564;6178.165947597017;6179.5056395488255;6199.969000154971;5702.857428564153;5894.115882617642;5917.615355001911;5995.6702381367695;5998.670073146019;5855.677937713466;5855.853603659943;5872.354041055566;5879;5892.793752218652;5883.411658834082;6125.1012186222415;6128.846778830565;6141.662208578571;6145.84635384119;4280.116748630592;4288.442502474783;4290.613844753987;4291.549387314412;4300.61294483498;5715.799947001835;5838.598736303342;5926.585139040399;5928.644281343133;5961.105834124916;5666.874921904286;5849.678267695318;5859.158308220424;5863.970680146572;5877.353491115889;5835.066389377679;5842.195746041839;5846.239988801599;5867.442592953663;5867.765289388377;5635.67343621448;5702.887936852274;5722.856928576819;5723.399043100581;5791.391903850204;5805.796797112081;5808;5818;5828.358880523054;5871.354151043296;5442.782288708408;5662.85842853932;5708.429157084424;5715;5715.428457154251 10:20:09 INFO - PROCESS | 27975 | |5;yui.html;757.2351924556197;788.9605519724013;813.2071230550214;849.7238397520807;913.2602591900561;13664.795028074574;14369.209693466855;14391;14413.99102062856;14414.063085899423;12280.631581052583;12294.200876942992;12301.138920275584;12305.261684298948;12864.549740759076;851.1105894340413;877.1929824561387;882.6028287270722;882.7484167012403;883.9867401988976;874.7944233105216;877.0133599700337;877.0615441477621;877.5875338590884;877.6840337478535;930.8184903943734;931.7624005878491;932.6549176804592;932.673564252513;933.0296491648711;923.7413524213231;924.0713083351257;924.075924075924;924.9306302027342;925.3476299209042;679.5514960126343;680.4148432348226;680.601847918968;680.7072958627788;680.7106979533678;13782.93108534461;13788.448462061506;13794.310284485837;13803.51687690926;13807.861921380758;14073.577792666134;14112.294385280695;14172.574822755334;14232.430702771877;14462.204578748164;12108.334041627708;12144.149909506337;12198.939005304917;12267.263964162179;12712.872871271262;4085.44846445729;4139.441175441307;4146.129312844307;4236.110416812473;4260.424842646234;83193;87112.56443717804;87338.56330718305;89022.55488722515;89077;12165;12242.75514489723;12449.502019919102;12568.120231583702;12612.432440540199;23168.76831231666;23236.18673346425;23361;23383.181588644315;23447.882760586086;8026.398020148512;8213.137620549876;8240.752777416687;8455.323574114056;8868.911310886937;4757.167495688241;4898.093852637274;4911.4106307243355;5008.499150085036;5036.043151801146;3770.0951771575174;3901.492805935267;3928.9214215715524;3930.3514920038447;3936.2127574485216;669.3808227389645;671.3957438305466;674.723363420995;679.2324673119343;699.6711545573572;700.94042006429;729.1614643160408;729.9781006569812;735.1472292141091;741.1106671993629;9699.466529340954;9798.65704700332;9883.604655813831;9926.702198934043;9993.80012399748;595.7825393731257;645.22222387919;720.0675125712215;728.2062551818437;736.2122528894032;4377.255866502702;4652.441706995182;4717.976410117996;4738.691985020962;4738.691985020962;121029.39485302517;122036;130051;139297;139673;94803.52598237102;96327.51836240914;111669.44165279284;111821.44089279664;114133;83519.58240208881;91982;93004.53497732469;93153;93790;9662.855057174289;9905.851412228967;10121.898781012096;10280.537375817956;10281.897181028393;54112.729436352565;54630.726846367106;56874.7156264216;56963.715181423824;57556.136657949326;72369.6381518089;77326.61336693281;79046.6047669758;79307;80095.59952200201;12868.292243926673;13285.601431957057;13352.799708004193;13563.186208827501;13812.171269723849;14391.640208994859;15482.767758483407;15575.299111539782;15647.530574082795;15654.686906261582;14154.929225354219;14705.41178352854;15065.924670376578;15098.924505377403;15556.455524056604;13587.184768913501;13696.178229305875;14660.706785864437;14680.192589407685;15591.844081559038;12875.549355772502;13534.86465135336;13747.450101996208;14177.574672759834;14627.268636568342;11064;11204;11581.88418115808;11598.594049208237;11745.882541174478;11871.76256474883;11924.569051713503;12133.393330333625;12364.4436000382;12439.564615238423 10:20:09 INFO - PROCESS | 27975 | __end_tp_report 10:20:09 INFO - PROCESS | 27975 | __start_cc_report 10:20:09 INFO - PROCESS | 27975 | _x_x_mozilla_cycle_collect,814 10:20:09 INFO - PROCESS | 27975 | __end_cc_report 10:20:09 INFO - PROCESS | 27975 | __startTimestamp1476984009117__endTimestamp 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | ------- Summary: start ------- 10:20:09 INFO - PROCESS | 27975 | Number of tests: 6 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | [#0] dojo.html Cycles:165 Average:5540.90 Median:5818.30 stddev:634.57 (10.9%) stddev-sans-first:607.46 10:20:09 INFO - PROCESS | 27975 | Values: 3120.8 3161.9 3169.4 3187.3 3202.7 5507.7 5579.7 5580.1 5582.4 5595.7 5478.8 5546.3 5553.0 5557.6 5569.0 5013.8 5030.7 5070.6 5073.2 5138.1 4964.9 5058.8 5101.4 5108.1 5113.1 4920.3 5045.1 5086.2 5088.6 5107.6 5150.8 5162.8 5169.2 5223.8 5226.2 5075.7 5144.1 5198.9 5211.3 5233.0 5413.6 5433.3 5435.8 5464.9 5473.4 5852.0 5863.8 5865.9 5967.8 5978.2 6000.1 6005.9 6009.4 6012.8 6016.3 5390.4 5419.7 5528.8 5576.2 5597.2 6086.5 6123.2 6130.4 6130.8 6134.8 5914.4 5923.5 5935.1 5935.3 5935.5 5806.7 5810.1 5849.0 5869.8 5892.3 5928.5 5936.3 5937.3 5949.7 5956.5 5904.3 5943.8 5961.5 5966.1 5999.4 4442.5 4491.7 4509.0 4576.6 4582.5 4045.3 4049.7 4095.3 4105.2 4110.6 5637.5 5646.2 5646.7 5649.1 5649.1 5770.3 5828.5 6014.6 6021.9 6024.7 5635.0 5689.3 5727.2 5790.2 5795.6 5137.6 5144.5 5148.1 5148.6 5153.8 6229.0 6237.4 6282.5 6294.5 6297.6 5836.5 5899.7 5904.2 5927.5 5929.3 6143.2 6145.0 6145.3 6147.8 6160.5 5848.9 5850.8 5862.4 5872.8 5890.5 5754.1 5850.2 5853.0 5867.7 5928.5 5872.8 5874.3 5874.4 5875.7 5884.2 5818.3 5839.1 5844.0 5847.1 5852.4 5637.4 5648.6 5818.4 5821.6 5838.0 5901.8 6000.6 6003.0 6029.1 6030.9 5788.9 5828.5 5836.3 5840.8 5841.4 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | [#1] ext.html Cycles:180 Average:66851.77 Median:23424.65 stddev:135454.89 (578.3%) stddev-sans-first:135743.53 10:20:09 INFO - PROCESS | 27975 | Values: 596.4 607.8 624.6 626.4 644.4 35925.1 38999.0 46788.8 48047.0 48119.0 48508.0 48720.8 48751.3 48948.3 49028.5 8394.1 9399.9 9553.4 9562.5 9563.9 8602.6 8905.7 8913.6 11001.4 11273.8 11480.3 11536.2 11546.8 11547.5 11556.7 11326.9 11386.4 11409.9 11410.8 11420.6 11129.4 11198.1 11200.7 11209.7 11210.0 45297.0 45681.5 45710.8 45724.5 45743.8 3824.1 4206.9 4431.0 4546.9 4585.8 34418.3 34775.0 35415.1 35546.0 36552.1 4444.8 4481.0 4508.1 4509.5 4714.2 395213.0 395752.0 395820.0 396075.0 399147.0 39142.4 62097.7 62335.0 62473.4 62497.0 39740.8 41676.2 41884.6 41902.8 41914.6 17314.2 17426.8 17457.9 17463.5 17463.6 13947.5 13971.8 13977.2 13991.0 14003.1 8946.3 9185.6 9308.7 9532.6 9570.1 3570.6 3633.6 3659.7 3678.7 3695.2 984.7 1073.2 1104.3 1140.8 1208.9 32431.8 34305.3 34325.7 34843.8 35696.5 1138.7 1171.5 1212.2 1215.6 1231.1 18048.5 18212.9 18315.5 18326.5 18428.5 567393.0 567715.0 568409.0 568673.0 572039.0 63651.7 64559.4 64574.4 64665.4 64719.0 1418.9 1433.3 1461.4 1466.5 1467.8 31949.2 34462.5 34507.7 34750.5 34852.5 55567.0 56316.4 56341.7 56354.4 56376.7 541927.0 542819.0 545422.0 551809.0 554572.0 46536.5 47219.3 47759.0 48166.0 48600.5 51699.2 52462.5 52644.7 53362.0 53837.0 43690.6 44198.6 45088.5 45455.7 45644.0 42642.4 42798.8 42867.6 44793.0 45157.8 44081.6 44587.8 45687.3 45740.0 45750.8 37191.6 39563.2 39673.0 40733.4 40823.4 29645.9 29844.7 29971.3 29990.4 30058.0 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | [#2] jquery.html Cycles:180 Average:28514.33 Median:24046.14 stddev:77186.73 (321.0%) stddev-sans-first:77374.38 10:20:09 INFO - PROCESS | 27975 | Values: 393.9 433.0 436.6 438.2 443.4 16360.0 19325.5 20701.7 20860.4 21025.4 19561.7 19833.3 20444.9 20517.9 20649.7 5824.0 5847.6 6067.4 6077.5 6079.1 5866.4 5888.4 5943.3 5954.4 5955.3 5746.9 5836.6 5909.1 5910.0 5915.7 5834.3 5886.3 5889.2 5954.2 5957.1 5252.4 5300.6 5345.0 5369.8 5377.4 23783.0 23941.9 24150.4 24168.9 24207.6 2551.8 2683.1 2688.2 2700.1 3180.3 14615.0 15313.6 15433.2 15554.7 15801.4 1796.0 1804.5 1839.1 1918.5 1943.5 81947.2 83066.0 84213.6 84666.0 86319.6 10295.3 11282.8 11400.3 11490.2 11525.3 15066.5 15083.9 15950.8 15961.4 16609.6 8909.7 9071.9 9146.9 9175.6 9400.8 8871.7 8931.2 8961.7 9121.3 9165.8 6889.1 7151.9 7176.4 7203.7 7220.8 1996.0 2012.2 2063.6 2074.0 2078.4 991.6 1041.4 1092.7 1113.7 1117.1 20572.7 20890.6 20893.4 21101.3 21195.6 1034.5 1048.6 1067.2 1099.2 1101.1 10705.8 11984.6 12079.8 12191.9 12238.0 375700.0 377260.0 518433.0 520764.0 521555.0 58329.0 65557.0 96051.5 97459.5 100574.0 1033.4 1034.6 1059.1 1066.9 1075.7 18132.4 18404.9 18580.4 18735.2 18740.2 33730.7 39968.8 40076.4 43384.3 45517.0 54761.0 54937.7 57916.4 58915.8 59319.4 8500.4 8636.0 8795.3 8851.3 8987.1 9666.6 12853.2 12999.5 13713.5 13866.9 11502.5 11923.6 11953.5 12030.5 12320.8 11443.5 11609.6 11610.4 11633.1 11998.8 11217.3 11287.3 11848.6 12073.0 12365.4 8335.4 8392.8 8407.3 8475.7 8926.3 10382.9 11085.3 11258.2 11262.3 11743.2 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | [#3] mootools.html Cycles:180 Average:6229.69 Median:4658.18 stddev:3580.61 (76.9%) stddev-sans-first:3573.33 10:20:09 INFO - PROCESS | 27975 | Values: 1542.1 1554.0 1707.2 1814.3 1821.4 8990.9 9696.2 9697.9 9698.0 9702.4 8340.6 8600.5 8967.0 9242.8 9467.7 2514.6 2535.2 2542.3 2544.0 2544.2 2426.9 2553.1 2555.6 2560.1 2560.4 2523.6 2524.7 2571.4 2573.9 2575.2 2464.5 2473.4 2474.7 2510.8 2516.6 2445.7 2451.6 2453.0 2457.9 2473.6 9445.9 9549.0 9599.4 9603.8 9608.2 5507.4 5651.7 5660.6 5663.4 5667.6 3342.5 3453.5 3464.8 3475.9 3530.7 1178.7 1210.0 1229.7 1230.2 1236.2 13322.0 13348.7 13350.5 13377.7 13378.9 4911.9 4912.1 5030.8 5083.5 5114.9 11341.5 11375.7 11379.1 11381.4 11384.9 5586.2 5631.8 5635.9 5638.8 5640.1 4631.2 4685.2 5135.4 5226.5 5273.8 4276.7 4311.6 4379.6 4412.5 4431.6 1355.9 1390.5 1390.5 1401.9 1405.2 1033.2 1050.4 1057.4 1059.1 1061.2 6394.2 6438.2 6561.9 6565.9 6716.5 497.5 499.2 506.3 507.2 509.4 4314.4 4325.5 4358.9 4363.4 4508.0 11550.2 11832.9 11910.5 11915.6 11939.8 10815.5 11587.4 11788.8 11830.5 11854.9 8331.4 8587.6 8594.0 8597.7 8598.6 6280.7 6334.7 6351.6 6582.3 6605.9 10741.5 10762.8 10981.7 11016.4 11078.2 11135.4 11244.7 11331.5 11337.7 11355.5 7469.7 7672.3 7683.7 8479.0 8560.4 8519.9 9083.2 9169.4 9425.4 9425.9 7902.0 8115.4 8220.9 8349.0 8464.4 8117.2 8148.6 8150.6 8229.8 8469.9 7555.4 7604.6 7644.8 7802.6 7889.9 5620.5 5623.8 5782.7 5787.6 5954.4 5450.1 5544.2 5552.8 5576.0 5580.7 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | [#4] prototype.html Cycles:180 Average:4863.10 Median:5552.51 stddev:1424.75 (25.7%) stddev-sans-first:1387.81 10:20:09 INFO - PROCESS | 27975 | Values: 345.3 353.1 359.7 369.7 372.7 5302.5 5426.6 5439.8 5465.2 5488.5 5293.0 5399.3 5425.8 5432.0 5445.9 4373.8 4374.4 4378.5 4381.7 4392.4 4205.7 4313.7 4357.6 4369.6 4380.4 4306.7 4328.4 4331.8 4333.7 4347.7 4312.1 4341.1 4349.3 4352.7 4354.8 3642.7 3764.0 3769.4 3775.2 3801.1 5323.7 5335.8 5339.4 5340.9 5346.8 4896.4 4905.7 4920.7 4932.2 4933.2 5524.1 5680.3 5728.2 5737.9 5743.4 4130.3 4145.3 4163.7 4164.5 4178.6 5798.3 5907.9 5937.5 5938.8 5941.9 4138.3 4168.1 4171.3 4176.7 4179.8 4210.5 4210.7 4214.6 4223.3 4223.8 4843.8 4845.5 4851.3 4853.5 4859.9 5495.9 5635.4 5718.7 5729.0 5760.2 1439.3 1457.9 1485.2 1490.3 1498.8 958.2 977.5 991.7 995.8 1002.2 5552.5 5552.5 5556.6 5558.0 5567.5 5838.3 5853.0 5860.9 5879.4 5884.0 5343.6 5557.2 5563.0 5626.8 5671.7 3118.0 3150.9 3162.8 3165.7 3169.3 5824.6 6145.0 6179.9 6195.3 6195.6 6045.3 6094.5 6100.3 6131.2 6136.7 6143.4 6176.8 6178.2 6179.5 6200.0 5702.9 5894.1 5917.6 5995.7 5998.7 5855.7 5855.9 5872.4 5879.0 5892.8 5883.4 6125.1 6128.8 6141.7 6145.8 4280.1 4288.4 4290.6 4291.5 4300.6 5715.8 5838.6 5926.6 5928.6 5961.1 5666.9 5849.7 5859.2 5864.0 5877.4 5835.1 5842.2 5846.2 5867.4 5867.8 5635.7 5702.9 5722.9 5723.4 5791.4 5805.8 5808.0 5818.0 5828.4 5871.4 5442.8 5662.9 5708.4 5715.0 5715.4 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - PROCESS | 27975 | [#5] yui.html Cycles:180 Average:22203.29 Median:4318.84 stddev:32977.23 (763.6%) stddev-sans-first:33030.43 10:20:09 INFO - PROCESS | 27975 | Values: 757.2 789.0 813.2 849.7 913.3 13664.8 14369.2 14391.0 14414.0 14414.1 12280.6 12294.2 12301.1 12305.3 12864.5 851.1 877.2 882.6 882.7 884.0 874.8 877.0 877.1 877.6 877.7 930.8 931.8 932.7 932.7 933.0 923.7 924.1 924.1 924.9 925.3 679.6 680.4 680.6 680.7 680.7 13782.9 13788.4 13794.3 13803.5 13807.9 14073.6 14112.3 14172.6 14232.4 14462.2 12108.3 12144.1 12198.9 12267.3 12712.9 4085.4 4139.4 4146.1 4236.1 4260.4 83193.0 87112.6 87338.6 89022.6 89077.0 12165.0 12242.8 12449.5 12568.1 12612.4 23168.8 23236.2 23361.0 23383.2 23447.9 8026.4 8213.1 8240.8 8455.3 8868.9 4757.2 4898.1 4911.4 5008.5 5036.0 3770.1 3901.5 3928.9 3930.4 3936.2 669.4 671.4 674.7 679.2 699.7 700.9 729.2 730.0 735.1 741.1 9699.5 9798.7 9883.6 9926.7 9993.8 595.8 645.2 720.1 728.2 736.2 4377.3 4652.4 4718.0 4738.7 4738.7 121029.4 122036.0 130051.0 139297.0 139673.0 94803.5 96327.5 111669.4 111821.4 114133.0 83519.6 91982.0 93004.5 93153.0 93790.0 9662.9 9905.9 10121.9 10280.5 10281.9 54112.7 54630.7 56874.7 56963.7 57556.1 72369.6 77326.6 79046.6 79307.0 80095.6 12868.3 13285.6 13352.8 13563.2 13812.2 14391.6 15482.8 15575.3 15647.5 15654.7 14154.9 14705.4 15065.9 15098.9 15556.5 13587.2 13696.2 14660.7 14680.2 15591.8 12875.5 13534.9 13747.5 14177.6 14627.3 11064.0 11204.0 11581.9 11598.6 11745.9 11871.8 11924.6 12133.4 12364.4 12439.6 10:20:09 INFO - PROCESS | 27975 | -------- Summary: end -------- 10:20:09 INFO - PROCESS | 27975 | 10:20:09 INFO - TEST-INFO | 27975: exit 0 10:20:09 INFO - TEST-OK | dromaeo_css | took 1113085ms 10:20:09 INFO - TEST-START | kraken 10:20:09 INFO - operating with platform_type : linux_ 10:20:09 INFO - Initialising browser for kraken test... 10:20:09 INFO - TEST-INFO | started process 28294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLDgEfI/profile http://localhost:43021/getInfo.html) 10:20:13 INFO - PROCESS | 28294 | __metrics Screen width/height:1600/1200 10:20:13 INFO - PROCESS | 28294 | colorDepth:24 10:20:13 INFO - PROCESS | 28294 | Browser inner width/height: 1024/697 10:20:13 INFO - PROCESS | 28294 | __metrics 10:20:14 INFO - PROCESS | 28294 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:20:14 INFO - PROCESS | 28294 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:14 INFO - PROCESS | 28294 | console.error: PushService: 10:20:14 INFO - PROCESS | 28294 | stateChangeProcessEnqueue: Error transitioning state 10:20:14 INFO - PROCESS | 28294 | UnknownError 10:20:15 INFO - TEST-INFO | 28294: exit 0 10:20:15 INFO - Browser initialized. 10:20:15 INFO - Running cycle 1/1 for kraken test... 10:20:15 INFO - TEST-INFO | started process 28386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLDgEfI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:27 INFO - PROCESS | 28386 | RSS: Main: 145031168 10:20:27 INFO - PROCESS | 28386 | 10:20:29 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43021/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:30 INFO - PROCESS | 28386 | RSS: Main: 186400768 10:20:30 INFO - PROCESS | 28386 | 10:20:33 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43021/tests/kraken/driver.html?testName=audio-dft) 10:20:33 INFO - PROCESS | 28386 | RSS: Main: 175198208 10:20:33 INFO - PROCESS | 28386 | 10:20:36 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43021/tests/kraken/driver.html?testName=audio-fft) 10:20:37 INFO - PROCESS | 28386 | RSS: Main: 267075584 10:20:37 INFO - PROCESS | 28386 | 10:20:39 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43021/tests/kraken/driver.html?testName=audio-oscillator) 10:20:39 INFO - PROCESS | 28386 | RSS: Main: 172748800 10:20:39 INFO - PROCESS | 28386 | 10:20:41 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43021/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:42 INFO - PROCESS | 28386 | RSS: Main: 174944256 10:20:42 INFO - PROCESS | 28386 | 10:20:45 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43021/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:45 INFO - PROCESS | 28386 | RSS: Main: 210915328 10:20:45 INFO - PROCESS | 28386 | 10:20:49 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43021/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:49 INFO - PROCESS | 28386 | RSS: Main: 210337792 10:20:49 INFO - PROCESS | 28386 | 10:20:52 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43021/tests/kraken/driver.html?testName=json-parse-financial) 10:20:53 INFO - PROCESS | 28386 | RSS: Main: 209788928 10:20:53 INFO - PROCESS | 28386 | 10:20:54 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43021/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:55 INFO - PROCESS | 28386 | RSS: Main: 171311104 10:20:55 INFO - PROCESS | 28386 | 10:20:56 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:57 INFO - PROCESS | 28386 | RSS: Main: 178606080 10:20:57 INFO - PROCESS | 28386 | 10:20:59 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:00 INFO - PROCESS | 28386 | RSS: Main: 188129280 10:21:00 INFO - PROCESS | 28386 | 10:21:02 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:03 INFO - PROCESS | 28386 | RSS: Main: 196243456 10:21:03 INFO - PROCESS | 28386 | 10:21:05 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:06 INFO - PROCESS | 28386 | RSS: Main: 193576960 10:21:06 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | Cycle 1(1): loaded http://localhost:43021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43021/tests/kraken/driver.html?testName=ai-astar) 10:21:08 INFO - PROCESS | 28386 | RSS: Main: 244690944 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | __start_tp_report 10:21:08 INFO - PROCESS | 28386 | _x_x_mozilla_page_load 10:21:08 INFO - PROCESS | 28386 | _x_x_mozilla_page_load_details 10:21:08 INFO - PROCESS | 28386 | |i|pagename|runs| 10:21:08 INFO - PROCESS | 28386 | |0;ai-astar;108;110;110;110;111;109;109;111;109;109 10:21:08 INFO - PROCESS | 28386 | |1;audio-beat-detection;153;122;115;157;117;118;115;120;143;114 10:21:08 INFO - PROCESS | 28386 | |2;audio-dft;160;160;160;161;159;159;159;160;159;160 10:21:08 INFO - PROCESS | 28386 | |3;audio-fft;75;77;77;114;75;75;75;76;97;76 10:21:08 INFO - PROCESS | 28386 | |4;audio-oscillator;82;82;109;81;82;82;104;82;82;113 10:21:08 INFO - PROCESS | 28386 | |5;imaging-gaussian-blur;117;116;118;117;117;117;117;116;117;117 10:21:08 INFO - PROCESS | 28386 | |6;imaging-darkroom;146;146;145;146;145;146;146;146;145;145 10:21:08 INFO - PROCESS | 28386 | |7;imaging-desaturate;95;95;95;99;94;95;94;94;95;95 10:21:08 INFO - PROCESS | 28386 | |8;json-parse-financial;51;52;49;49;49;50;50;49;50;49 10:21:08 INFO - PROCESS | 28386 | |9;json-stringify-tinderbox;58;58;59;60;59;59;59;59;59;60 10:21:08 INFO - PROCESS | 28386 | |10;stanford-crypto-aes;77;74;73;73;81;74;74;73;73;74 10:21:08 INFO - PROCESS | 28386 | |11;stanford-crypto-ccm;124;127;122;120;117;129;117;124;169;123 10:21:08 INFO - PROCESS | 28386 | |12;stanford-crypto-pbkdf2;155;152;154;153;154;154;154;152;151;151 10:21:08 INFO - PROCESS | 28386 | |13;stanford-crypto-sha256-iterative;63;65;64;62;62;63;64;62;64;62 10:21:08 INFO - PROCESS | 28386 | __end_tp_report 10:21:08 INFO - PROCESS | 28386 | __start_cc_report 10:21:08 INFO - PROCESS | 28386 | _x_x_mozilla_cycle_collect,1627 10:21:08 INFO - PROCESS | 28386 | __end_cc_report 10:21:08 INFO - PROCESS | 28386 | __startTimestamp1476984068472__endTimestamp 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | ------- Summary: start ------- 10:21:08 INFO - PROCESS | 28386 | Number of tests: 14 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:0.97 (0.9%) stddev-sans-first:0.83 10:21:08 INFO - PROCESS | 28386 | Values: 108.0 110.0 110.0 110.0 111.0 109.0 109.0 111.0 109.0 109.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:121.00 stddev:16.81 (13.9%) stddev-sans-first:15.06 10:21:08 INFO - PROCESS | 28386 | Values: 153.0 122.0 115.0 157.0 117.0 118.0 115.0 120.0 143.0 114.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:21:08 INFO - PROCESS | 28386 | Values: 160.0 160.0 160.0 161.0 159.0 159.0 159.0 160.0 159.0 160.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:13.19 (17.4%) stddev-sans-first:13.77 10:21:08 INFO - PROCESS | 28386 | Values: 75.0 77.0 77.0 114.0 75.0 75.0 75.0 76.0 97.0 76.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.13 (16.0%) stddev-sans-first:13.61 10:21:08 INFO - PROCESS | 28386 | Values: 82.0 82.0 109.0 81.0 82.0 82.0 104.0 82.0 82.0 113.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:21:08 INFO - PROCESS | 28386 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:21:08 INFO - PROCESS | 28386 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.45 (1.5%) stddev-sans-first:1.54 10:21:08 INFO - PROCESS | 28386 | Values: 95.0 95.0 95.0 99.0 94.0 95.0 94.0 94.0 95.0 95.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:1.03 (2.1%) stddev-sans-first:1.00 10:21:08 INFO - PROCESS | 28386 | Values: 51.0 52.0 49.0 49.0 49.0 50.0 50.0 49.0 50.0 49.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 10:21:08 INFO - PROCESS | 28386 | Values: 58.0 58.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:2.55 (3.4%) stddev-sans-first:2.55 10:21:08 INFO - PROCESS | 28386 | Values: 77.0 74.0 73.0 73.0 81.0 74.0 74.0 73.0 73.0 74.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:124.00 stddev:15.19 (12.2%) stddev-sans-first:16.06 10:21:08 INFO - PROCESS | 28386 | Values: 124.0 127.0 122.0 120.0 117.0 129.0 117.0 124.0 169.0 123.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:154.00 stddev:1.41 (0.9%) stddev-sans-first:1.30 10:21:08 INFO - PROCESS | 28386 | Values: 155.0 152.0 154.0 153.0 154.0 154.0 154.0 152.0 151.0 151.0 10:21:08 INFO - PROCESS | 28386 | 10:21:08 INFO - PROCESS | 28386 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.10 (1.7%) stddev-sans-first:1.17 10:21:08 INFO - PROCESS | 28386 | Values: 63.0 65.0 64.0 62.0 62.0 63.0 64.0 62.0 64.0 62.0 10:21:08 INFO - PROCESS | 28386 | -------- Summary: end -------- 10:21:08 INFO - PROCESS | 28386 | 10:21:09 INFO - TEST-INFO | 28386: exit 0 10:21:09 INFO - TEST-OK | kraken | took 59588ms 10:21:09 INFO - SUITE-END | took 1172s 10:21:09 INFO - Completed test suite (00:19:32) 10:21:09 INFO - javascript benchmark 10:21:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.8439578021103, 3161.936761264774, 3169.4453470642648, 3187.2987942652608, 3202.679732026796, 5507.7246137693155, 5579.69311687858, 5580.10718285075, 5582.413846546115, 5595.692236926968, 5478.753456094475, 5546.278983732119, 5552.972235138819, 5557.5831812614015, 5569.0254205514075, 5013.824516141935, 5030.748462576857, 5070.619703522232, 5073.239014147889, 5138.075146473652, 4964.851054468371, 5058.772355244005, 5101.4133374662015, 5108.080545501808, 5113.054084994269, 4920.3111564381015, 5045.142325804603, 5086.237064440326, 5088.592912566985, 5107.616928730342, 5150.793968241266, 5162.845114646567, 5169.198774190007, 5223.843284701465, 5226.1638137898135, 5075.746212689351, 5144.0740666679985, 5198.870028249286, 5211.322528071364, 5233.0, 5413.621046526745, 5433.320834895638, 5435.83692489226, 5464.863378415572, 5473.425290344497, 5851.970740146272, 5863.76544938202, 5865.941340586583, 5967.761289548456, 5978.163057171956, 6000.099985002241, 6005.879882402372, 6009.399060094, 6012.789552365646, 6016.338202797689, 5390.434004429518, 5419.701916394597, 5528.834134975917, 5576.219329293902, 5597.188407680864, 6086.482648974798, 6123.234595675541, 6130.448259656563, 6130.846728831815, 6134.8159555213415, 5914.378990205966, 5923.466887980103, 5935.050391937356, 5935.2877654681715, 5935.495482884004, 5806.68063256525, 5810.12848072784, 5848.9707551462825, 5869.7945571904775, 5892.29292484896, 5928.525717942554, 5936.317323507766, 5937.287525496968, 5949.672767997802, 5956.463918247378, 5904.291485021739, 5943.791967281124, 5961.463468287875, 5966.075258334965, 5999.370066143079, 4442.489113751895, 4491.685582009293, 4508.954910450919, 4576.565226303496, 4582.495925448198, 4045.2516284486874, 4049.6760259179196, 4095.344744840811, 4105.220008198433, 4110.588941105865, 5637.46444087811, 5646.209530665628, 5646.661200327993, 5649.096144616841, 5649.124385720138, 5770.336411312753, 5828.504577110993, 6014.609050411709, 6021.879562408727, 6024.698765061817, 5635.042042852725, 5689.288838895138, 5727.1695604138, 5790.160426738184, 5795.623284486495, 5137.640365174402, 5144.511271429208, 5148.073346797538, 5148.588112950955, 5153.819616313411, 6228.968855155786, 6237.407446292595, 6282.528810339151, 6294.464970477561, 6297.622142671455, 5836.474717275466, 5899.705014749159, 5904.173415721716, 5927.4665280125, 5929.2884853816095, 6143.174139895698, 6145.047517634774, 6145.324014358506, 6147.84630384244, 6160.476359509492, 5848.941510584839, 5850.824475265749, 5862.355140934408, 5872.765089396376, 5890.4993075587345, 5754.136879468113, 5850.2102216200265, 5853.0, 5867.6772777497645, 5928.4960778334325, 5872.765089396376, 5874.295084589877, 5874.441928016831, 5875.735591898289, 5884.205632239593, 5818.301803783404, 5839.0949402842625, 5844.0, 5847.06446968483, 5852.385499522489, 5637.408072152365, 5648.604597678123, 5818.418158184148, 5821.621594596338, 5838.036723940502, 5901.822945311647, 6000.639961602318, 6002.969985150221, 6029.095635654687, 6030.879382412415, 5788.884222315614, 5828.504577110823, 5836.328822185503, 5840.795572154954, 5841.415858414124], "value": 5497.199940627396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4125336543503, 607.8055022392834, 624.5971348480231, 626.3517259636271, 644.4457766320966, 35925.10187245317, 38999.0, 46788.76605616971, 48047.0390592188, 48119.0, 48508.0, 48720.75639621797, 48751.26873096897, 48948.26577601339, 49028.50971490284, 8394.076651568323, 9399.859002114974, 9553.426794392324, 9562.521873906311, 9563.90436095637, 8602.612882420306, 8905.73282801517, 8913.643454261823, 11001.394923279257, 11273.774524509505, 11480.311181329105, 11536.192466527347, 11546.769064618702, 11547.480363383667, 11556.711082222928, 11326.886731132707, 11386.430678466044, 11409.942950285236, 11410.828837567444, 11420.600278990238, 11129.387883666395, 11198.104151667847, 11200.719982000433, 11209.719757006058, 11210.0, 45297.0, 45681.54318456839, 45710.77144614289, 45724.54275457236, 45743.771281143716, 3824.082220267144, 4206.936895946563, 4430.9556904430865, 4546.931796023062, 4585.839495617637, 34418.31163376718, 34775.0, 35415.11462213465, 35546.023660942425, 36552.086197845, 4444.777761111964, 4481.0, 4508.07584445188, 4509.526499717515, 4714.198586240347, 395213.0, 395752.0, 395820.0, 396075.0, 399147.0, 39142.41286380707, 62097.689511552155, 62335.0, 62473.37526624766, 62497.0, 39740.80129599333, 41676.166476670296, 41884.58115418868, 41902.79048604737, 41914.58085419107, 17314.220860061327, 17426.825731742774, 17457.912710436365, 17463.47609571715, 17463.563410914576, 13947.511837085856, 13971.79042314366, 13977.231252281019, 13991.0, 14003.089799163023, 8946.284297256203, 9185.586648600829, 9308.720738377859, 9532.571034303473, 9570.138687518018, 3570.553680789901, 3633.5821380541047, 3659.688926441282, 3678.6689197971778, 3695.1501154734024, 984.6701355045997, 1073.2380010192694, 1104.2877344113, 1140.7547377313751, 1208.9335086570147, 32431.837840811117, 34305.31389372249, 34325.65674343224, 34843.82578087144, 35696.46455303173, 1138.6754774889116, 1171.4845467994055, 1212.1938910624513, 1215.6231568213705, 1231.132051903406, 18048.458546243633, 18212.908935455238, 18315.54211144732, 18326.45020649356, 18428.539286517946, 567393.0, 567715.0, 568409.0, 568673.0, 572039.0, 63651.68174159192, 64559.354406456274, 64574.35425645777, 64665.35334646687, 64719.0, 1418.907770994882, 1433.3120102350929, 1461.4373466215584, 1466.486729644616, 1467.757819959716, 31949.20126996844, 34462.48306275358, 34507.65492345044, 34750.47874281837, 34852.477212842336, 55567.0, 56316.43683563112, 56341.71829140828, 56354.43645563492, 56376.7181164108, 541927.0, 542819.0, 545422.0, 551809.0, 554572.0, 46536.53463465322, 47219.29171062368, 47759.0, 48166.0, 48600.54198374054, 51699.224511631604, 52462.47537524576, 52644.736776315876, 53362.0, 53837.0, 43690.56309436865, 44198.55801441945, 45088.54911450975, 45455.72345600166, 45644.0, 42642.36036459394, 42798.78600606977, 42867.57132428761, 44793.0, 45157.77421112874, 44081.55918440774, 44587.77706111449, 45687.31469027901, 45740.0, 45750.77124614356, 37191.62808371882, 39563.20873582455, 39673.0, 40733.38899916445, 40823.38764918588, 29645.924785264826, 29844.701552984192, 29971.250718732204, 29990.400191996476, 30058.0], "value": 21164.820886237507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.8778978516662, 432.978171515224, 436.6310467654832, 438.1652951128101, 443.4146926057603, 16360.0, 19325.453963682907, 20701.68947465789, 20860.374188774324, 21025.36923892282, 19561.70657440136, 19833.305834295803, 20444.897775511137, 20517.897410512964, 20649.690254646193, 5823.970880145594, 5847.619904706202, 6067.362926892679, 6077.5137988961, 6079.057746049347, 5866.354700982888, 5888.440598143191, 5943.257092863392, 5954.374790646984, 5955.34491205967, 5746.856328591798, 5836.5914385993, 5909.054551271797, 5910.0, 5915.704214789243, 5834.27071616048, 5886.293644762613, 5889.175515427822, 5954.1664167016215, 5957.136215248808, 5252.395974462947, 5300.602454815904, 5345.01117293302, 5369.7583608737705, 5377.4084850666395, 23783.048678052855, 23941.88029059861, 24150.396240093964, 24168.879155604285, 24207.636885446733, 2551.7703406693486, 2683.087750164934, 2688.2204160793344, 2700.0819721294856, 3180.316232010106, 14615.0, 15313.6171595711, 15433.228338583025, 15554.688906221925, 15801.367945282174, 1796.0301437223884, 1804.530821986293, 1839.0804597701149, 1918.5299601597558, 1943.5335519475366, 81947.18052819515, 83066.0, 84213.57893210556, 84666.0, 86319.56840215759, 10295.330803497749, 11282.774344513064, 11400.258983166068, 11490.195686301879, 11525.308481491138, 15066.472673456376, 15083.924580377028, 15950.840491594936, 15961.441349552942, 16609.584760380847, 8909.73270801877, 9071.909280907106, 9146.86279705805, 9175.632974681072, 9400.764980875396, 8871.733847984571, 8931.151540603632, 8961.731148065568, 9121.270298376114, 9165.81668366629, 6889.138857642794, 7151.928480715126, 7176.354128128493, 7203.747868824671, 7220.783376498714, 1995.9600807983759, 2012.2152360579387, 2063.649179639465, 2073.968890466644, 2078.3557097299886, 991.6033586565432, 1041.375174895057, 1092.7377429416883, 1113.660333598244, 1117.0672488472055, 20572.691409628867, 20890.582188356148, 20893.37319880406, 21101.306000827004, 21195.576088478145, 1034.462079718557, 1048.5962904281907, 1067.199600299775, 1099.1701265544464, 1101.0695961912172, 10705.785884282272, 11984.64046078619, 12079.818802717966, 12191.87808121925, 12238.0, 375700.0, 377260.0, 518433.0, 520764.0, 521555.0, 58329.0, 65557.0, 96051.51974240223, 97459.51270243745, 100574.0, 1033.3851358441716, 1034.5654824973528, 1059.131512160037, 1066.903978641926, 1075.7471994081384, 18132.365367212613, 18404.907975460035, 18580.44258672242, 18735.156917938453, 18740.156692949124, 33730.66269337275, 39968.80015599904, 40076.398854017796, 43384.34923476087, 45517.0, 54761.0, 54937.725311373186, 57916.420835791105, 58915.79978031727, 59319.40680593139, 8500.404971651926, 8635.971137335871, 8795.296376289754, 8851.336149788664, 8987.101289870961, 9666.613335466502, 12853.16454430459, 12999.480020799063, 13713.520026799015, 13866.930665346608, 11502.48238829238, 11923.642290730944, 11953.521859125538, 12030.458629361525, 12320.815187772012, 11443.485043173243, 11609.593664221711, 11610.361430121424, 11633.127515436207, 11998.76002479963, 11217.270877392943, 11287.266327688674, 11848.585299514476, 12073.0, 12365.381730913597, 8335.374846886387, 8392.790180245298, 8407.327413807003, 8475.660973560989, 8926.330525210506, 10382.948085259526, 11085.334879907232, 11258.21192516516, 11262.324260544394, 11743.17797754149], "value": 9689.648881426097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.1441100189395, 1553.9922300388496, 1707.1720215695386, 1814.310561986445, 1821.4171465131162, 8990.865137022949, 9696.224302055836, 9697.854532182022, 9698.0, 9702.369345992514, 8340.582970851448, 8600.526971016592, 8967.0, 9242.768930776734, 9467.668631597895, 2514.6479492870967, 2535.1887396033276, 2542.3008672615088, 2544.033267358401, 2544.1936225279983, 2426.8786560671897, 2553.0936517536284, 2555.591105423133, 2560.0783717861555, 2560.372708686365, 2523.6466894634764, 2524.7349028352032, 2571.434284457416, 2573.9485210295784, 2575.163072001598, 2464.5194187133516, 2473.418746594558, 2474.6659201007815, 2510.7740303372784, 2516.6225066240027, 2445.6698345723275, 2451.595486744685, 2453.0065323543995, 2457.9262622121364, 2473.5547601431736, 9445.905540944572, 9549.0, 9599.42403455795, 9603.759906002337, 9608.183304419133, 5507.366652834895, 5651.660900345993, 5660.632058916157, 5663.377028526858, 5667.574931880125, 3342.5153352763955, 3453.4947028765823, 3464.84408201629, 3475.8609655613745, 3530.735194860396, 1178.6808289602031, 1210.0, 1229.7233122547354, 1230.1696354960454, 1236.2397125767677, 13322.0, 13348.733025339536, 13350.532731354357, 13377.732445351136, 13378.86621133786, 4911.926321105187, 4912.1158191525865, 5030.798768049311, 5083.491650834887, 5114.897702045938, 11341.546338146547, 11375.715607109889, 11379.146564007568, 11381.430928453545, 11384.943075284571, 5586.16207568868, 5631.80288689902, 5635.859103522363, 5638.830835074954, 5640.097584386478, 4631.1895418301665, 4685.1800934836265, 5135.435102138762, 5226.477352264819, 5273.762680679379, 4276.657867370603, 4311.590398912098, 4379.605835474823, 4412.536683648235, 4431.645468362588, 1355.9186448813102, 1390.4855203574741, 1390.5133203378737, 1401.8668226518464, 1405.156905856478, 1033.214756784849, 1050.3645294596658, 1057.4025675493322, 1059.057438879398, 1061.1510791366875, 6394.241583564557, 6438.227412710505, 6561.901571476432, 6565.916623757122, 6716.46268298535, 497.53231961955646, 499.24963967845974, 506.29372026024225, 507.2442061328594, 509.4447052712561, 4314.41755363022, 4325.480942286946, 4358.869233922987, 4363.432753742057, 4508.0, 11550.249233799945, 11832.94083529594, 11910.464029118537, 11915.642530723919, 11939.820902686466, 10815.459227038617, 11587.420628968517, 11788.764224715458, 11830.467628956718, 11854.881451185378, 8331.37514686401, 8587.613557389808, 8593.957030214933, 8597.699080532277, 8598.5700714964, 6280.654563998841, 6334.714937827901, 6351.587146835441, 6582.308857569887, 6605.900911486236, 10741.516631751747, 10762.838557421488, 10981.670549883516, 11016.449177540931, 11078.224524283545, 11135.443227838414, 11244.66266012021, 11331.490082946451, 11337.716557086138, 11355.54577816878, 7469.663865126191, 7672.309492145734, 7683.692652293846, 8478.957605212181, 8560.443571168104, 8519.8722019171, 9083.227925626396, 9169.449833010041, 9425.38734982224, 9425.905740942502, 7901.960490197513, 8115.391345648982, 8220.917790822015, 8348.958255208685, 8464.365172611955, 8117.228863258218, 8148.592570371577, 8150.5924703763385, 8229.79425514367, 8469.915300846913, 7555.395568354628, 7604.619769011417, 7644.847103058019, 7802.648880800264, 7889.921100788919, 5620.522255608319, 5623.831285061455, 5782.653040817564, 5787.56593255516, 5954.404559544011, 5450.127979523258, 5544.168374743821, 5552.750126244409, 5575.972120139536, 5580.693061881636], "value": 4902.762774487509, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3352296828605, 353.1266630525065, 359.7104331013535, 369.66360611843226, 372.6906667466002, 5302.496262855023, 5426.647267927582, 5439.836804895855, 5465.234867118596, 5488.506034456898, 5292.973535132319, 5399.271098401724, 5425.755840987155, 5432.0, 5445.863853403667, 4373.846915357955, 4374.409454723604, 4378.540253273408, 4381.715188512737, 4392.385066090734, 4205.705600607958, 4313.654907607384, 4357.607815296623, 4369.563043695621, 4380.408644832954, 4306.676999225071, 4328.350747387901, 4331.805068771912, 4333.71830830995, 4347.7173983690955, 4312.1375724855, 4341.131773645284, 4349.26062569364, 4352.73883566987, 4354.825806967718, 3642.7450078494517, 3764.0025393270807, 3769.4157405602177, 3775.244951009809, 3801.068738159141, 5323.653962492425, 5335.813246536352, 5339.41266460689, 5340.946590534084, 5346.8395948121615, 4896.387951506062, 4905.705657660552, 4920.655554111214, 4932.1861892788, 4933.1860243059855, 5524.14375771752, 5680.289963754531, 5728.169415434781, 5737.913931291034, 5743.368229494752, 4130.339145736668, 4145.274576949022, 4163.666906647461, 4164.500259968823, 4178.582141785828, 5798.304203495608, 5907.940920590782, 5937.495312898409, 5938.8218353449465, 5941.910871336933, 4138.337865941435, 4168.145530166309, 4171.33258678616, 4176.749395036247, 4179.832806687759, 4210.536840947493, 4210.72630279037, 4214.578542145761, 4223.331783945325, 4223.767692776927, 4843.782029808667, 4845.491223421561, 4851.272309153655, 4853.538913803253, 4859.854204373874, 5495.862603434946, 5635.380108188096, 5718.656880587095, 5728.971355143281, 5760.177513018674, 1439.2731670506328, 1457.9065700724457, 1485.2276816055808, 1490.3070072416162, 1498.7826765119214, 958.1903291718487, 977.4623956823718, 991.7272749993665, 995.8008398320364, 1002.178213864624, 5552.500274975271, 5552.52803511706, 5556.638818476786, 5557.972210139004, 5567.498925096761, 5838.2702162229725, 5853.024928810477, 5860.948667966263, 5879.3826648202175, 5884.0, 5343.625946183807, 5557.166425036196, 5562.972185139049, 5626.774929002794, 5671.744771485293, 3118.0489950565297, 3150.8739650414186, 3162.798136708036, 3165.667604901498, 3169.302753394296, 5824.563157763185, 6144.969275153685, 6179.876402471926, 6195.349488303754, 6195.628262304276, 6045.274567051894, 6094.512439004869, 6100.267967843798, 6131.202943617302, 6136.6624835633575, 6143.416375444325, 6176.845578860564, 6178.165947597017, 6179.5056395488255, 6199.969000154971, 5702.857428564153, 5894.115882617642, 5917.615355001911, 5995.6702381367695, 5998.670073146019, 5855.677937713466, 5855.853603659943, 5872.354041055566, 5879.0, 5892.793752218652, 5883.411658834082, 6125.1012186222415, 6128.846778830565, 6141.662208578571, 6145.84635384119, 4280.116748630592, 4288.442502474783, 4290.613844753987, 4291.549387314412, 4300.61294483498, 5715.799947001835, 5838.598736303342, 5926.585139040399, 5928.644281343133, 5961.105834124916, 5666.874921904286, 5849.678267695318, 5859.158308220424, 5863.970680146572, 5877.353491115889, 5835.066389377679, 5842.195746041839, 5846.239988801599, 5867.442592953663, 5867.765289388377, 5635.67343621448, 5702.887936852274, 5722.856928576819, 5723.399043100581, 5791.391903850204, 5805.796797112081, 5808.0, 5818.0, 5828.358880523054, 5871.354151043296, 5442.782288708408, 5662.85842853932, 5708.429157084424, 5715.0, 5715.428457154251], "value": 4412.952593195435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.2351924556197, 788.9605519724013, 813.2071230550214, 849.7238397520807, 913.2602591900561, 13664.795028074574, 14369.209693466855, 14391.0, 14413.99102062856, 14414.063085899423, 12280.631581052583, 12294.200876942992, 12301.138920275584, 12305.261684298948, 12864.549740759076, 851.1105894340413, 877.1929824561387, 882.6028287270722, 882.7484167012403, 883.9867401988976, 874.7944233105216, 877.0133599700337, 877.0615441477621, 877.5875338590884, 877.6840337478535, 930.8184903943734, 931.7624005878491, 932.6549176804592, 932.673564252513, 933.0296491648711, 923.7413524213231, 924.0713083351257, 924.075924075924, 924.9306302027342, 925.3476299209042, 679.5514960126343, 680.4148432348226, 680.601847918968, 680.7072958627788, 680.7106979533678, 13782.93108534461, 13788.448462061506, 13794.310284485837, 13803.51687690926, 13807.861921380758, 14073.577792666134, 14112.294385280695, 14172.574822755334, 14232.430702771877, 14462.204578748164, 12108.334041627708, 12144.149909506337, 12198.939005304917, 12267.263964162179, 12712.872871271262, 4085.44846445729, 4139.441175441307, 4146.129312844307, 4236.110416812473, 4260.424842646234, 83193.0, 87112.56443717804, 87338.56330718305, 89022.55488722515, 89077.0, 12165.0, 12242.75514489723, 12449.502019919102, 12568.120231583702, 12612.432440540199, 23168.76831231666, 23236.18673346425, 23361.0, 23383.181588644315, 23447.882760586086, 8026.398020148512, 8213.137620549876, 8240.752777416687, 8455.323574114056, 8868.911310886937, 4757.167495688241, 4898.093852637274, 4911.4106307243355, 5008.499150085036, 5036.043151801146, 3770.0951771575174, 3901.492805935267, 3928.9214215715524, 3930.3514920038447, 3936.2127574485216, 669.3808227389645, 671.3957438305466, 674.723363420995, 679.2324673119343, 699.6711545573572, 700.94042006429, 729.1614643160408, 729.9781006569812, 735.1472292141091, 741.1106671993629, 9699.466529340954, 9798.65704700332, 9883.604655813831, 9926.702198934043, 9993.80012399748, 595.7825393731257, 645.22222387919, 720.0675125712215, 728.2062551818437, 736.2122528894032, 4377.255866502702, 4652.441706995182, 4717.976410117996, 4738.691985020962, 4738.691985020962, 121029.39485302517, 122036.0, 130051.0, 139297.0, 139673.0, 94803.52598237102, 96327.51836240914, 111669.44165279284, 111821.44089279664, 114133.0, 83519.58240208881, 91982.0, 93004.53497732469, 93153.0, 93790.0, 9662.855057174289, 9905.851412228967, 10121.898781012096, 10280.537375817956, 10281.897181028393, 54112.729436352565, 54630.726846367106, 56874.7156264216, 56963.715181423824, 57556.136657949326, 72369.6381518089, 77326.61336693281, 79046.6047669758, 79307.0, 80095.59952200201, 12868.292243926673, 13285.601431957057, 13352.799708004193, 13563.186208827501, 13812.171269723849, 14391.640208994859, 15482.767758483407, 15575.299111539782, 15647.530574082795, 15654.686906261582, 14154.929225354219, 14705.41178352854, 15065.924670376578, 15098.924505377403, 15556.455524056604, 13587.184768913501, 13696.178229305875, 14660.706785864437, 14680.192589407685, 15591.844081559038, 12875.549355772502, 13534.86465135336, 13747.450101996208, 14177.574672759834, 14627.268636568342, 11064.0, 11204.0, 11581.88418115808, 11598.594049208237, 11745.882541174478, 11871.76256474883, 11924.569051713503, 12133.393330333625, 12364.4436000382, 12439.564615238423], "value": 7886.509538440315, "unit": "score"}], "name": "dromaeo_css", "value": 7597.903330503397, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 110.0, 110.0, 111.0, 109.0, 109.0, 111.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 115.0, 157.0, 117.0, 118.0, 115.0, 120.0, 143.0, 114.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 159.0, 159.0, 159.0, 160.0, 159.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 114.0, 75.0, 75.0, 75.0, 76.0, 97.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 109.0, 81.0, 82.0, 82.0, 104.0, 82.0, 82.0, 113.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 99.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 49.0, 49.0, 49.0, 50.0, 50.0, 49.0, 50.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 73.0, 73.0, 81.0, 74.0, 74.0, 73.0, 73.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 122.0, 120.0, 117.0, 129.0, 117.0, 124.0, 169.0, 123.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 152.0, 154.0, 153.0, 154.0, 154.0, 154.0, 152.0, 151.0, 151.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 62.0, 62.0, 63.0, 64.0, 62.0, 64.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1452.5999999999997, "alertThreshold": 2.0}]} 10:21:09 INFO - Return code: 0 10:21:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:09 INFO - # TBPL SUCCESS # 10:21:09 INFO - Running post-action listener: _resource_record_post_action 10:21:09 INFO - [mozharness: 2016-10-20 17:21:09.789694Z] Finished run-tests step (success) 10:21:09 INFO - Running post-run listener: _resource_record_post_run 10:21:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2129920; Write bytes: 358334464; Read time: 344; Write time: 205784 10:21:09 INFO - TinderboxPrint: CPU usage
12.9% 10:21:09 INFO - TinderboxPrint: I/O read bytes / time
2,129,920 / 344 10:21:09 INFO - TinderboxPrint: I/O write bytes / time
358,334,464 / 205,784 10:21:09 INFO - TinderboxPrint: CPU idle
8,264.2 (87.1%) 10:21:09 INFO - TinderboxPrint: CPU user
1,182.3 (12.5%) 10:21:09 INFO - TinderboxPrint: Swap in / out
0 / 0 10:21:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107577344; Read time: 0; Write time: 91480 10:21:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250142720; Read time: 16; Write time: 114304 10:21:10 INFO - Running post-run listener: _upload_blobber_files 10:21:10 INFO - Blob upload gear active. 10:21:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:10 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 10:21:10 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:21:10 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:21:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:14 INFO - (blobuploader) - INFO - Done attempting. 10:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:21:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:15 INFO - (blobuploader) - INFO - Done attempting. 10:21:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:21:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:21:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:15 INFO - (blobuploader) - INFO - Done attempting. 10:21:15 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:15 INFO - Return code: 0 10:21:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44b9a13763051c40dba5334d56a3423df4d65d38017a5e5c153649ac63a93a26ad6b4f75a0084e983c229fc4e5d3c435d9ca3675f81d1a64aa85d3524b023d89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb56012f9df005682327b29ad0887d6fa3f22610e80f6a0a58f9e93798e5450ec9a88067d849d57975fa7c7e1e783aaf199da581cd369a653b315addcf14ff7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7169ce40374de047a9c94d761e0742a22bea76aa5b2d13eec41809d004f9978c5e63298db5ffc720868fd6665ccb4927926cd11b6c1d9d193ffa623795b13dc9"} 10:21:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:15 INFO - Contents: 10:21:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44b9a13763051c40dba5334d56a3423df4d65d38017a5e5c153649ac63a93a26ad6b4f75a0084e983c229fc4e5d3c435d9ca3675f81d1a64aa85d3524b023d89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb56012f9df005682327b29ad0887d6fa3f22610e80f6a0a58f9e93798e5450ec9a88067d849d57975fa7c7e1e783aaf199da581cd369a653b315addcf14ff7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7169ce40374de047a9c94d761e0742a22bea76aa5b2d13eec41809d004f9978c5e63298db5ffc720868fd6665ccb4927926cd11b6c1d9d193ffa623795b13dc9"} 10:21:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:15 INFO - Copying logs to upload dir... 10:21:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:21:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.059192 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-20 10:21:15.394908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 10:21:15.400546) ========= 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=32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44b9a13763051c40dba5334d56a3423df4d65d38017a5e5c153649ac63a93a26ad6b4f75a0084e983c229fc4e5d3c435d9ca3675f81d1a64aa85d3524b023d89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb56012f9df005682327b29ad0887d6fa3f22610e80f6a0a58f9e93798e5450ec9a88067d849d57975fa7c7e1e783aaf199da581cd369a653b315addcf14ff7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7169ce40374de047a9c94d761e0742a22bea76aa5b2d13eec41809d004f9978c5e63298db5ffc720868fd6665ccb4927926cd11b6c1d9d193ffa623795b13dc9"} build_url:https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011605 build_url: 'https://queue.taskcluster.net/v1/task/Ofgl_kNyTB-0u4oh3k-InA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44b9a13763051c40dba5334d56a3423df4d65d38017a5e5c153649ac63a93a26ad6b4f75a0084e983c229fc4e5d3c435d9ca3675f81d1a64aa85d3524b023d89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb56012f9df005682327b29ad0887d6fa3f22610e80f6a0a58f9e93798e5450ec9a88067d849d57975fa7c7e1e783aaf199da581cd369a653b315addcf14ff7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7169ce40374de047a9c94d761e0742a22bea76aa5b2d13eec41809d004f9978c5e63298db5ffc720868fd6665ccb4927926cd11b6c1d9d193ffa623795b13dc9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 10:21:15.426477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:21:15.426791) ========= 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=32c5991c409366f7fec8a718000001d2-1476982840.734430-1711195292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:21:15.509106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 10:21:15.509447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 10:21:15.509736) ========= ========= Total master_lag: 0.16 =========