builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1479419035.54 results: success (0) buildid: 20161117105628 builduid: 99e8c3f8f27b4f3eb3d3715b71f7f2fb revision: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.535690) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.536066) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.536363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.572682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.572963) ========= 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=bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 13:43:56-- 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% 30.9M=0s 2016-11-17 13:43:56 (30.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118157 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.708265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.711598) ========= 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=bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014205 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:55.761297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 13:43:55.761796) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 --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-beta --rev 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 --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=bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 13:43:56,387 truncating revision to first 12 chars 2016-11-17 13:43:56,387 Setting DEBUG logging. 2016-11-17 13:43:56,387 attempt 1/10 2016-11-17 13:43:56,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4a50f24275d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 13:43:57,187 unpacking tar archive at: mozilla-beta-4a50f24275d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140269 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 13:43:56.915286) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:56.915597) ========= script_repo_revision: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:56.915998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:56.916264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 13:43:56.924971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-17 13:43:56.925275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:43:57 INFO - MultiFileLogger online at 20161117 13:43:57 in /builds/slave/test 13:43:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:43:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:57 INFO - {'append_to_log': False, 13:43:57 INFO - 'base_work_dir': '/builds/slave/test', 13:43:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:43:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:57 INFO - 'branch': 'Mozilla-Beta', 13:43:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:57 INFO - 'config_files': ('talos/linux_config.py',), 13:43:57 INFO - 'default_actions': ('clobber', 13:43:57 INFO - 'read-buildbot-config', 13:43:57 INFO - 'download-and-extract', 13:43:57 INFO - 'populate-webroot', 13:43:57 INFO - 'create-virtualenv', 13:43:57 INFO - 'install', 13:43:57 INFO - 'run-tests'), 13:43:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:57 INFO - 'download_minidump_stackwalk': True, 13:43:57 INFO - 'download_symbols': 'ondemand', 13:43:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:57 INFO - 'installer_path': 'installer.exe', 13:43:57 INFO - 'log_level': 'info', 13:43:57 INFO - 'log_name': 'talos', 13:43:57 INFO - 'log_to_console': True, 13:43:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:43:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:43:57 INFO - 'opt_config_files': (), 13:43:57 INFO - 'pip_index': False, 13:43:57 INFO - 'sps_profile': False, 13:43:57 INFO - 'sps_profile_interval': 0, 13:43:57 INFO - 'suite': 'dromaeojs', 13:43:57 INFO - 'system_bits': '32', 13:43:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:57 INFO - 'title': 'talos-linux64-ix-055', 13:43:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:57 INFO - 'use_talos_json': True, 13:43:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:57 INFO - 'work_dir': 'build'} 13:43:57 INFO - [mozharness: 2016-11-17 21:43:57.640097Z] Running clobber step. 13:43:57 INFO - Running pre-action listener: _resource_record_pre_action 13:43:57 INFO - Running main action method: clobber 13:43:57 INFO - rmtree: /builds/slave/test/build 13:43:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:58 INFO - Running post-action listener: _resource_record_post_action 13:43:58 INFO - [mozharness: 2016-11-17 21:43:58.101367Z] Finished clobber step (success) 13:43:58 INFO - [mozharness: 2016-11-17 21:43:58.101467Z] Running read-buildbot-config step. 13:43:58 INFO - Running pre-action listener: _resource_record_pre_action 13:43:58 INFO - Running main action method: read_buildbot_config 13:43:58 INFO - Using buildbot properties: 13:43:58 INFO - { 13:43:58 INFO - "project": "", 13:43:58 INFO - "product": "firefox", 13:43:58 INFO - "script_repo_revision": "production", 13:43:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:43:58 INFO - "repository": "", 13:43:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:43:58 INFO - "buildid": "20161117105628", 13:43:58 INFO - "pgo_build": "True", 13:43:58 INFO - "basedir": "/builds/slave/test", 13:43:58 INFO - "buildnumber": 467, 13:43:58 INFO - "slavename": "talos-linux64-ix-055", 13:43:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:43:58 INFO - "platform": "ubuntu64_hw", 13:43:58 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:43:58 INFO - "branch": "mozilla-beta", 13:43:58 INFO - "repo_path": "releases/mozilla-beta", 13:43:58 INFO - "revision": "4a50f24275d4f5d0afb68752ca228c5fbf2a6784", 13:43:58 INFO - "stage_platform": "linux64-pgo", 13:43:58 INFO - "builduid": "99e8c3f8f27b4f3eb3d3715b71f7f2fb", 13:43:58 INFO - "slavebuilddir": "test" 13:43:58 INFO - } 13:43:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 13:43:58 INFO - Running post-action listener: _resource_record_post_action 13:43:58 INFO - [mozharness: 2016-11-17 21:43:58.103902Z] Finished read-buildbot-config step (success) 13:43:58 INFO - [mozharness: 2016-11-17 21:43:58.103991Z] Running download-and-extract step. 13:43:58 INFO - Running pre-action listener: _resource_record_pre_action 13:43:58 INFO - Running main action method: download_and_extract 13:43:58 INFO - mkdir: /builds/slave/test/build/tests 13:43:58 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')]} 13:43:58 INFO - trying https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 13:43:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 13:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:43:58 INFO - Downloaded 1327 bytes. 13:43:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 13:43:58 INFO - Using the following test package requirements: 13:43:58 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 13:43:58 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:58 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 13:43:58 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'jsshell-linux-x86_64.zip'], 13:43:58 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:58 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 13:43:58 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 13:43:58 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 13:43:58 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:58 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 13:43:58 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:58 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 13:43:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:58 INFO - Fetch https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 13:43:59 INFO - Expected file size: 21962106 13:44:04 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:44:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 13:44:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:44:04 INFO - Fetch https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 13:44:04 INFO - Expected file size: 21962106 13:44:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 13:44:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:44:09 INFO - Fetch https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 13:44:10 INFO - Expected file size: 14414089 13:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:11 INFO - trying https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 13:44:11 INFO - Downloading https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 13:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:44:13 INFO - Downloaded 56960683 bytes. 13:44:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 13:44:13 INFO - mkdir: /builds/slave/test/properties 13:44:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:44:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:44:13 INFO - Contents: 13:44:13 INFO - build_url:https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 13:44:13 INFO - Running post-action listener: _resource_record_post_action 13:44:13 INFO - Running post-action listener: set_extra_try_arguments 13:44:13 INFO - [mozharness: 2016-11-17 21:44:13.859339Z] Finished download-and-extract step (success) 13:44:13 INFO - [mozharness: 2016-11-17 21:44:13.859566Z] Running populate-webroot step. 13:44:13 INFO - Running pre-action listener: _resource_record_pre_action 13:44:13 INFO - Running main action method: populate_webroot 13:44:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:44:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:44:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:44:13 INFO - '--tppagecycles', 13:44:13 INFO - '7'], 13:44:13 INFO - 'tests': ['tsvgm']}}, 13:44:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:44:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:44:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:44:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:44:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['damp', 'tps']}, 13:44:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'tests': ['damp', 'tps']}, 13:44:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['dromaeo_dom']}, 13:44:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:44:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['basic_compositor_video']}, 13:44:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:44:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['a11yr', 13:44:13 INFO - 'ts_paint', 13:44:13 INFO - 'tpaint', 13:44:13 INFO - 'sessionrestore', 13:44:13 INFO - 'sessionrestore_no_auto_restore', 13:44:13 INFO - 'tabpaint']}, 13:44:13 INFO - 'other-e10s': {'tests': ['a11yr', 13:44:13 INFO - 'ts_paint', 13:44:13 INFO - 'tpaint', 13:44:13 INFO - 'sessionrestore', 13:44:13 INFO - 'sessionrestore_no_auto_restore', 13:44:13 INFO - 'tabpaint']}, 13:44:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:44:13 INFO - 'ts_paint', 13:44:13 INFO - 'tpaint', 13:44:13 INFO - 'sessionrestore', 13:44:13 INFO - 'sessionrestore_no_auto_restore', 13:44:13 INFO - 'tabpaint']}, 13:44:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:44:13 INFO - 'ts_paint', 13:44:13 INFO - 'tpaint', 13:44:13 INFO - 'sessionrestore', 13:44:13 INFO - 'sessionrestore_no_auto_restore', 13:44:13 INFO - 'tabpaint']}, 13:44:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['a11yr', 13:44:13 INFO - 'ts_paint', 13:44:13 INFO - 'tpaint', 13:44:13 INFO - 'sessionrestore', 13:44:13 INFO - 'sessionrestore_no_auto_restore', 13:44:13 INFO - 'tabpaint']}, 13:44:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['a11yr', 13:44:13 INFO - 'ts_paint', 13:44:13 INFO - 'tpaint', 13:44:13 INFO - 'sessionrestore', 13:44:13 INFO - 'sessionrestore_no_auto_restore', 13:44:13 INFO - 'tabpaint']}, 13:44:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['tsvgx', 13:44:13 INFO - 'tsvgr_opacity', 13:44:13 INFO - 'tart', 13:44:13 INFO - 'tscrollx', 13:44:13 INFO - 'cart']}, 13:44:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:44:13 INFO - 'tsvgr_opacity', 13:44:13 INFO - 'tart', 13:44:13 INFO - 'tscrollx', 13:44:13 INFO - 'cart']}, 13:44:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'talos_options': ['--disable-e10s'], 13:44:13 INFO - 'tests': ['tp5o']}, 13:44:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'tests': ['tp5o']}, 13:44:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'talos_options': ['--disable-e10s', 13:44:13 INFO - '--xperf_path', 13:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:13 INFO - 'tests': ['tp5n']}, 13:44:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:13 INFO - 'talos_options': ['--xperf_path', 13:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:13 INFO - 'tests': ['tp5n']}}, 13:44:13 INFO - 'talos.zip': {'path': '', 13:44:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:44:13 INFO - Running post-action listener: _resource_record_post_action 13:44:13 INFO - [mozharness: 2016-11-17 21:44:13.881499Z] Finished populate-webroot step (success) 13:44:13 INFO - [mozharness: 2016-11-17 21:44:13.881593Z] Running create-virtualenv step. 13:44:13 INFO - Running pre-action listener: _resource_record_pre_action 13:44:13 INFO - Running main action method: create_virtualenv 13:44:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:44:13 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 13:44:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:44:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:44:13 INFO - Using real prefix '/usr' 13:44:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:44:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:16 INFO - Installing pip.................done. 13:44:16 INFO - Return code: 0 13:44:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44:16 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')]} 13:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:16 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')]} 13:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:16 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:16 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 13:44:16 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 13:44:16 INFO - Using env: {'DISPLAY': ':0', 13:44:16 INFO - 'HOME': '/home/cltbld', 13:44:16 INFO - 'LANG': 'en_US.UTF-8', 13:44:16 INFO - 'LANGUAGE': 'en_US:en', 13:44:16 INFO - 'LOGNAME': 'cltbld', 13:44:16 INFO - 'MAIL': '/var/mail/cltbld', 13:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:16 INFO - 'MOZ_NO_REMOTE': '1', 13:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:16 INFO - 'NO_EM_RESTART': '1', 13:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:16 INFO - 'PWD': '/builds/slave/test', 13:44:16 INFO - 'SHELL': '/bin/bash', 13:44:16 INFO - 'SHLVL': '1', 13:44:16 INFO - 'TERM': 'linux', 13:44:16 INFO - 'TMOUT': '86400', 13:44:16 INFO - 'USER': 'cltbld', 13:44:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:16 INFO - '_': '/tools/buildbot/bin/python'} 13:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:16 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 13:44:16 INFO - Cleaning up... 13:44:16 INFO - Return code: 0 13:44:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:44:16 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')]} 13:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:16 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')]} 13:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:16 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:16 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 13:44:16 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 13:44:16 INFO - Using env: {'DISPLAY': ':0', 13:44:16 INFO - 'HOME': '/home/cltbld', 13:44:16 INFO - 'LANG': 'en_US.UTF-8', 13:44:16 INFO - 'LANGUAGE': 'en_US:en', 13:44:16 INFO - 'LOGNAME': 'cltbld', 13:44:16 INFO - 'MAIL': '/var/mail/cltbld', 13:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:16 INFO - 'MOZ_NO_REMOTE': '1', 13:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:16 INFO - 'NO_EM_RESTART': '1', 13:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:16 INFO - 'PWD': '/builds/slave/test', 13:44:16 INFO - 'SHELL': '/bin/bash', 13:44:16 INFO - 'SHLVL': '1', 13:44:16 INFO - 'TERM': 'linux', 13:44:16 INFO - 'TMOUT': '86400', 13:44:16 INFO - 'USER': 'cltbld', 13:44:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:16 INFO - '_': '/tools/buildbot/bin/python'} 13:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:16 INFO - Downloading/unpacking psutil>=3.1.1 13:44:16 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 13:44:16 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 13:44:16 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 13:44:16 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 13:44:16 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 13:44:16 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 13:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:18 INFO - Installing collected packages: psutil 13:44:18 INFO - Running setup.py install for psutil 13:44:19 INFO - building 'psutil._psutil_linux' extension 13:44:19 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 13:44:19 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 13:44:19 INFO - building 'psutil._psutil_posix' extension 13:44:19 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 13:44:19 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 13:44:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:19 INFO - Successfully installed psutil 13:44:19 INFO - Cleaning up... 13:44:19 INFO - Return code: 0 13:44:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:44: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 mozsystemmonitor==0.3 13:44:19 INFO - Using env: {'DISPLAY': ':0', 13:44:19 INFO - 'HOME': '/home/cltbld', 13:44:19 INFO - 'LANG': 'en_US.UTF-8', 13:44:19 INFO - 'LANGUAGE': 'en_US:en', 13:44:19 INFO - 'LOGNAME': 'cltbld', 13:44:19 INFO - 'MAIL': '/var/mail/cltbld', 13:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:19 INFO - 'MOZ_NO_REMOTE': '1', 13:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:19 INFO - 'NO_EM_RESTART': '1', 13:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:19 INFO - 'PWD': '/builds/slave/test', 13:44:19 INFO - 'SHELL': '/bin/bash', 13:44:19 INFO - 'SHLVL': '1', 13:44:19 INFO - 'TERM': 'linux', 13:44:19 INFO - 'TMOUT': '86400', 13:44:19 INFO - 'USER': 'cltbld', 13:44:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:19 INFO - '_': '/tools/buildbot/bin/python'} 13:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:44:21 INFO - Installing collected packages: mozsystemmonitor 13:44:21 INFO - Running setup.py install for mozsystemmonitor 13:44:21 INFO - Successfully installed mozsystemmonitor 13:44:21 INFO - Cleaning up... 13:44:21 INFO - Return code: 0 13:44:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:44:21 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')]} 13:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:21 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')]} 13:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:21 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:21 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 13:44:21 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 13:44:21 INFO - Using env: {'DISPLAY': ':0', 13:44:21 INFO - 'HOME': '/home/cltbld', 13:44:21 INFO - 'LANG': 'en_US.UTF-8', 13:44:21 INFO - 'LANGUAGE': 'en_US:en', 13:44:21 INFO - 'LOGNAME': 'cltbld', 13:44:21 INFO - 'MAIL': '/var/mail/cltbld', 13:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:21 INFO - 'MOZ_NO_REMOTE': '1', 13:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:21 INFO - 'NO_EM_RESTART': '1', 13:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:21 INFO - 'PWD': '/builds/slave/test', 13:44:21 INFO - 'SHELL': '/bin/bash', 13:44:21 INFO - 'SHLVL': '1', 13:44:21 INFO - 'TERM': 'linux', 13:44:21 INFO - 'TMOUT': '86400', 13:44:21 INFO - 'USER': 'cltbld', 13:44:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:21 INFO - '_': '/tools/buildbot/bin/python'} 13:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:22 INFO - Downloading/unpacking jsonschema==2.5.1 13:44:22 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 13:44:22 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 13:44:22 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 13:44:22 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 13:44:22 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 13:44:22 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 13:44:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:24 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:24 INFO - warning: no files found matching '*.txt' 13:44:24 INFO - no previously-included directories found matching 'build' 13:44:24 INFO - no previously-included directories found matching 'dist' 13:44:24 INFO - no previously-included directories found matching '.git*' 13:44:24 INFO - Installing collected packages: jsonschema, functools32 13:44:24 INFO - Running setup.py install for functools32 13:44:24 INFO - warning: no files found matching '*.txt' 13:44:24 INFO - no previously-included directories found matching 'build' 13:44:24 INFO - no previously-included directories found matching 'dist' 13:44:24 INFO - no previously-included directories found matching '.git*' 13:44:24 INFO - Successfully installed jsonschema functools32 13:44:24 INFO - Cleaning up... 13:44:24 INFO - Return code: 0 13:44:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:24 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:24 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 13:44:24 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 13:44:24 INFO - Using env: {'DISPLAY': ':0', 13:44:24 INFO - 'HOME': '/home/cltbld', 13:44:24 INFO - 'LANG': 'en_US.UTF-8', 13:44:24 INFO - 'LANGUAGE': 'en_US:en', 13:44:24 INFO - 'LOGNAME': 'cltbld', 13:44:24 INFO - 'MAIL': '/var/mail/cltbld', 13:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:24 INFO - 'MOZ_NO_REMOTE': '1', 13:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:24 INFO - 'NO_EM_RESTART': '1', 13:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:24 INFO - 'PWD': '/builds/slave/test', 13:44:24 INFO - 'SHELL': '/bin/bash', 13:44:24 INFO - 'SHLVL': '1', 13:44:24 INFO - 'TERM': 'linux', 13:44:24 INFO - 'TMOUT': '86400', 13:44:24 INFO - 'USER': 'cltbld', 13:44:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:24 INFO - '_': '/tools/buildbot/bin/python'} 13:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:44:24 INFO - Cleaning up... 13:44:24 INFO - Return code: 0 13:44:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:24 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:24 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 13:44:24 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 13:44:24 INFO - Using env: {'DISPLAY': ':0', 13:44:24 INFO - 'HOME': '/home/cltbld', 13:44:24 INFO - 'LANG': 'en_US.UTF-8', 13:44:24 INFO - 'LANGUAGE': 'en_US:en', 13:44:24 INFO - 'LOGNAME': 'cltbld', 13:44:24 INFO - 'MAIL': '/var/mail/cltbld', 13:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:24 INFO - 'MOZ_NO_REMOTE': '1', 13:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:24 INFO - 'NO_EM_RESTART': '1', 13:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:24 INFO - 'PWD': '/builds/slave/test', 13:44:24 INFO - 'SHELL': '/bin/bash', 13:44:24 INFO - 'SHLVL': '1', 13:44:24 INFO - 'TERM': 'linux', 13:44:24 INFO - 'TMOUT': '86400', 13:44:24 INFO - 'USER': 'cltbld', 13:44:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:24 INFO - '_': '/tools/buildbot/bin/python'} 13:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:24 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:24 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 13:44:24 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 13:44:24 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 13:44:24 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 13:44:24 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 13:44:24 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 13:44:26 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:26 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 13:44:26 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 13:44:26 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 13:44:26 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 13:44:26 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 13:44:26 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 13:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:27 INFO - Downloading docopt-0.6.1.tar.gz 13:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:27 INFO - Running setup.py install for blobuploader 13:44:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:27 INFO - Running setup.py install for requests 13:44:28 INFO - Running setup.py install for docopt 13:44:28 INFO - Successfully installed blobuploader requests docopt 13:44:28 INFO - Cleaning up... 13:44:28 INFO - Return code: 0 13:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:28 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')]} 13:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:28 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')]} 13:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:28 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:28 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 13:44:28 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 13:44:28 INFO - Using env: {'DISPLAY': ':0', 13:44:28 INFO - 'HOME': '/home/cltbld', 13:44:28 INFO - 'LANG': 'en_US.UTF-8', 13:44:28 INFO - 'LANGUAGE': 'en_US:en', 13:44:28 INFO - 'LOGNAME': 'cltbld', 13:44:28 INFO - 'MAIL': '/var/mail/cltbld', 13:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:28 INFO - 'MOZ_NO_REMOTE': '1', 13:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:28 INFO - 'NO_EM_RESTART': '1', 13:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:28 INFO - 'PWD': '/builds/slave/test', 13:44:28 INFO - 'SHELL': '/bin/bash', 13:44:28 INFO - 'SHLVL': '1', 13:44:28 INFO - 'TERM': 'linux', 13:44:28 INFO - 'TMOUT': '86400', 13:44:28 INFO - 'USER': 'cltbld', 13:44:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:28 INFO - '_': '/tools/buildbot/bin/python'} 13:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:28 INFO - Running setup.py (path:/tmp/pip-dtBFL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:28 INFO - Running setup.py (path:/tmp/pip-2fvwBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:28 INFO - Running setup.py (path:/tmp/pip-N6cjcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:28 INFO - Running setup.py (path:/tmp/pip-rxAe5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:28 INFO - Running setup.py (path:/tmp/pip-C7UpgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:28 INFO - Running setup.py (path:/tmp/pip-23pFk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:28 INFO - Running setup.py (path:/tmp/pip-7NGLby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:28 INFO - Running setup.py (path:/tmp/pip-pebknb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:28 INFO - Running setup.py (path:/tmp/pip-EImyCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:29 INFO - Running setup.py (path:/tmp/pip-NNl4rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:29 INFO - Running setup.py (path:/tmp/pip-g4IJSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:29 INFO - Running setup.py (path:/tmp/pip-ZShM5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:29 INFO - Running setup.py (path:/tmp/pip-PxBQE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:29 INFO - Running setup.py (path:/tmp/pip-TZrIvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:29 INFO - Running setup.py (path:/tmp/pip-B8TsFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:29 INFO - Running setup.py (path:/tmp/pip-U124ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:29 INFO - Running setup.py (path:/tmp/pip-ILief6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:29 INFO - Running setup.py install for manifestparser 13:44:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:29 INFO - Running setup.py install for mozcrash 13:44:29 INFO - Running setup.py install for mozdebug 13:44:29 INFO - Running setup.py install for mozdevice 13:44:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for mozfile 13:44:30 INFO - Running setup.py install for mozhttpd 13:44:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for mozinfo 13:44:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for mozInstall 13:44:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for mozleak 13:44:30 INFO - Running setup.py install for mozlog 13:44:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for moznetwork 13:44:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for mozprocess 13:44:30 INFO - Running setup.py install for mozprofile 13:44:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:30 INFO - Running setup.py install for mozrunner 13:44:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:31 INFO - Running setup.py install for mozscreenshot 13:44:31 INFO - Running setup.py install for moztest 13:44:31 INFO - Running setup.py install for mozversion 13:44:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:31 INFO - Cleaning up... 13:44:31 INFO - Return code: 0 13:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:31 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')]} 13:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:31 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')]} 13:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:31 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:31 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 13:44:31 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 13:44:31 INFO - Using env: {'DISPLAY': ':0', 13:44:31 INFO - 'HOME': '/home/cltbld', 13:44:31 INFO - 'LANG': 'en_US.UTF-8', 13:44:31 INFO - 'LANGUAGE': 'en_US:en', 13:44:31 INFO - 'LOGNAME': 'cltbld', 13:44:31 INFO - 'MAIL': '/var/mail/cltbld', 13:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:31 INFO - 'MOZ_NO_REMOTE': '1', 13:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:31 INFO - 'NO_EM_RESTART': '1', 13:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:31 INFO - 'PWD': '/builds/slave/test', 13:44:31 INFO - 'SHELL': '/bin/bash', 13:44:31 INFO - 'SHLVL': '1', 13:44:31 INFO - 'TERM': 'linux', 13:44:31 INFO - 'TMOUT': '86400', 13:44:31 INFO - 'USER': 'cltbld', 13:44:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:31 INFO - '_': '/tools/buildbot/bin/python'} 13:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:31 INFO - Running setup.py (path:/tmp/pip-42CeCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:31 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)) 13:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:31 INFO - Running setup.py (path:/tmp/pip-h5EzBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:31 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)) 13:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:31 INFO - Running setup.py (path:/tmp/pip-WuaQMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:31 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)) 13:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:31 INFO - Running setup.py (path:/tmp/pip-wiyTus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:31 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)) 13:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:31 INFO - Running setup.py (path:/tmp/pip-AtF_9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:32 INFO - Running setup.py (path:/tmp/pip-w5iuKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:32 INFO - Running setup.py (path:/tmp/pip-yBedDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:32 INFO - Running setup.py (path:/tmp/pip-FFx_jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:32 INFO - Running setup.py (path:/tmp/pip-HRbArC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:32 INFO - Running setup.py (path:/tmp/pip-pQoY1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:32 INFO - Running setup.py (path:/tmp/pip-T2Jt2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:32 INFO - Running setup.py (path:/tmp/pip-689RIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:32 INFO - Running setup.py (path:/tmp/pip-MkI0Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:32 INFO - Running setup.py (path:/tmp/pip-97VcKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:32 INFO - Running setup.py (path:/tmp/pip-OM6xq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:32 INFO - Running setup.py (path:/tmp/pip-ok9_Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:32 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)) 13:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:32 INFO - Running setup.py (path:/tmp/pip-4vh3BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:32 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)) 13:44:32 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)) 13:44:32 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)) 13:44:32 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)) 13:44:32 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)) 13:44:32 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)) 13:44:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:34 INFO - Downloading blessings-1.6.tar.gz 13:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:34 INFO - Installing collected packages: blessings 13:44:34 INFO - Running setup.py install for blessings 13:44:34 INFO - Successfully installed blessings 13:44:34 INFO - Cleaning up... 13:44:35 INFO - Return code: 0 13:44:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:35 INFO - Reading from file tmpfile_stdout 13:44:35 INFO - Current package versions: 13:44:35 INFO - argparse == 1.2.1 13:44:35 INFO - blessings == 1.6 13:44:35 INFO - blobuploader == 1.2.4 13:44:35 INFO - docopt == 0.6.1 13:44:35 INFO - functools32 == 3.2.3-2 13:44:35 INFO - jsonschema == 2.5.1 13:44:35 INFO - manifestparser == 1.1 13:44:35 INFO - mozInstall == 1.12 13:44:35 INFO - mozcrash == 0.17 13:44:35 INFO - mozdebug == 0.1 13:44:35 INFO - mozdevice == 0.48 13:44:35 INFO - mozfile == 1.2 13:44:35 INFO - mozhttpd == 0.7 13:44:35 INFO - mozinfo == 0.9 13:44:35 INFO - mozleak == 0.1 13:44:35 INFO - mozlog == 3.4 13:44:35 INFO - moznetwork == 0.27 13:44:35 INFO - mozprocess == 0.23 13:44:35 INFO - mozprofile == 0.28 13:44:35 INFO - mozrunner == 6.12 13:44:35 INFO - mozscreenshot == 0.1 13:44:35 INFO - mozsystemmonitor == 0.3 13:44:35 INFO - moztest == 0.7 13:44:35 INFO - mozversion == 1.4 13:44:35 INFO - psutil == 3.1.1 13:44:35 INFO - requests == 1.2.3 13:44:35 INFO - wsgiref == 0.1.2 13:44:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:35 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:35 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 13:44:35 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 13:44:35 INFO - Using env: {'DISPLAY': ':0', 13:44:35 INFO - 'HOME': '/home/cltbld', 13:44:35 INFO - 'LANG': 'en_US.UTF-8', 13:44:35 INFO - 'LANGUAGE': 'en_US:en', 13:44:35 INFO - 'LOGNAME': 'cltbld', 13:44:35 INFO - 'MAIL': '/var/mail/cltbld', 13:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:35 INFO - 'MOZ_NO_REMOTE': '1', 13:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:35 INFO - 'NO_EM_RESTART': '1', 13:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:35 INFO - 'PWD': '/builds/slave/test', 13:44:35 INFO - 'SHELL': '/bin/bash', 13:44:35 INFO - 'SHLVL': '1', 13:44:35 INFO - 'TERM': 'linux', 13:44:35 INFO - 'TMOUT': '86400', 13:44:35 INFO - 'USER': 'cltbld', 13:44:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:35 INFO - '_': '/tools/buildbot/bin/python'} 13:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 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)) 13:44:35 INFO - Cleaning up... 13:44:35 INFO - Return code: 0 13:44:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:35 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 0x7f99712ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', '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 13:44:35 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 13:44:35 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 13:44:35 INFO - Using env: {'DISPLAY': ':0', 13:44:35 INFO - 'HOME': '/home/cltbld', 13:44:35 INFO - 'LANG': 'en_US.UTF-8', 13:44:35 INFO - 'LANGUAGE': 'en_US:en', 13:44:35 INFO - 'LOGNAME': 'cltbld', 13:44:35 INFO - 'MAIL': '/var/mail/cltbld', 13:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:35 INFO - 'MOZ_NO_REMOTE': '1', 13:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:35 INFO - 'NO_EM_RESTART': '1', 13:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:35 INFO - 'PWD': '/builds/slave/test', 13:44:35 INFO - 'SHELL': '/bin/bash', 13:44:35 INFO - 'SHLVL': '1', 13:44:35 INFO - 'TERM': 'linux', 13:44:35 INFO - 'TMOUT': '86400', 13:44:35 INFO - 'USER': 'cltbld', 13:44:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:35 INFO - '_': '/tools/buildbot/bin/python'} 13:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:44:35 INFO - Cleaning up... 13:44:35 INFO - Return code: 0 13:44:35 INFO - Running post-action listener: _resource_record_post_action 13:44:35 INFO - Running post-action listener: _start_resource_monitoring 13:44:35 INFO - Starting resource monitoring. 13:44:35 INFO - [mozharness: 2016-11-17 21:44:35.730111Z] Finished create-virtualenv step (success) 13:44:35 INFO - [mozharness: 2016-11-17 21:44:35.730607Z] Running install step. 13:44:35 INFO - Running pre-action listener: _resource_record_pre_action 13:44:35 INFO - Running main action method: install 13:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:35 INFO - Reading from file tmpfile_stdout 13:44:35 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:44:36 INFO - Reading from file tmpfile_stdout 13:44:36 INFO - Output received: 13:44:36 INFO - Usage: mozinstall [options] installer 13:44:36 INFO - Options: 13:44:36 INFO - -h, --help show this help message and exit 13:44:36 INFO - -d DEST, --destination=DEST 13:44:36 INFO - Directory to install application into. [default: 13:44:36 INFO - "/builds/slave/test"] 13:44:36 INFO - --app=APP Application being installed. [default: firefox] 13:44:36 INFO - mkdir: /builds/slave/test/build/application 13:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:44:49 INFO - Reading from file tmpfile_stdout 13:44:49 INFO - Output received: 13:44:49 INFO - /builds/slave/test/build/application/firefox/firefox 13:44:49 INFO - Running post-action listener: _resource_record_post_action 13:44:49 INFO - [mozharness: 2016-11-17 21:44:49.530595Z] Finished install step (success) 13:44:49 INFO - [mozharness: 2016-11-17 21:44:49.530838Z] Running run-tests step. 13:44:49 INFO - Running pre-action listener: _resource_record_pre_action 13:44:49 INFO - Running main action method: run_tests 13:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:44:49 INFO - Python 2.7.3 13:44:49 INFO - Return code: 0 13:44:49 INFO - grabbing minidump binary from tooltool 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:49 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 0x1b87f60>, '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 0x1b88d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b891d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:44:49 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 13:44:49 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 13:44:49 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 13:44:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:44:49 INFO - Return code: 0 13:44:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:44:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:44:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:44:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:44:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 13:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 13:44:49 INFO - Using env: {'DISPLAY': ':0', 13:44:49 INFO - 'HOME': '/home/cltbld', 13:44:49 INFO - 'LANG': 'en_US.UTF-8', 13:44:49 INFO - 'LANGUAGE': 'en_US:en', 13:44:49 INFO - 'LOGNAME': 'cltbld', 13:44:49 INFO - 'MAIL': '/var/mail/cltbld', 13:44:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:44:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:49 INFO - 'MOZ_NO_REMOTE': '1', 13:44:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:49 INFO - 'NO_EM_RESTART': '1', 13:44:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:49 INFO - 'PWD': '/builds/slave/test', 13:44:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:44:49 INFO - 'SHELL': '/bin/bash', 13:44:49 INFO - 'SHLVL': '1', 13:44:49 INFO - 'TERM': 'linux', 13:44:49 INFO - 'TMOUT': '86400', 13:44:49 INFO - 'USER': 'cltbld', 13:44:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403', 13:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:49 INFO - '_': '/tools/buildbot/bin/python'} 13:44:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 13:44:49 INFO - mozversion application_buildid: 20161117105628 13:44:49 INFO - mozversion application_changeset: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 13:44:49 INFO - mozversion application_display_name: Firefox 13:44:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:44:49 INFO - mozversion application_name: Firefox 13:44:49 INFO - mozversion application_remotingname: firefox 13:44:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:44:49 INFO - mozversion application_vendor: Mozilla 13:44:49 INFO - mozversion application_version: 51.0 13:44:49 INFO - mozversion platform_buildid: 20161117105628 13:44:49 INFO - mozversion platform_changeset: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 13:44:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:44:49 INFO - mozversion platform_version: 51.0 13:44:49 INFO - using testdate: 1479419089 13:44:49 INFO - actual date: 1479419089 13:44:49 INFO - starting webserver on 'localhost:56820' 13:44:49 INFO - SUITE-START | Running 2 tests 13:44:49 INFO - TEST-START | dromaeo_css 13:44:49 INFO - operating with platform_type : linux_ 13:44:49 INFO - Initialising browser for dromaeo_css test... 13:44:49 INFO - TEST-INFO | started process 17421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt9lMRP/profile http://localhost:56820/getInfo.html) 13:44:53 INFO - PROCESS | 17421 | __metrics Screen width/height:1600/1200 13:44:53 INFO - PROCESS | 17421 | colorDepth:24 13:44:53 INFO - PROCESS | 17421 | Browser inner width/height: 1024/697 13:44:53 INFO - PROCESS | 17421 | __metrics 13:44:54 INFO - PROCESS | 17421 | 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" 13:44:54 INFO - PROCESS | 17421 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:44:54 INFO - PROCESS | 17421 | console.error: PushService: 13:44:54 INFO - PROCESS | 17421 | stateChangeProcessEnqueue: Error transitioning state 13:44:54 INFO - PROCESS | 17421 | UnknownError 13:44:55 INFO - TEST-INFO | 17421: exit 0 13:44:55 INFO - Browser initialized. 13:44:55 INFO - Running cycle 1/1 for dromaeo_css test... 13:44:55 INFO - TEST-INFO | started process 17511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt9lMRP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:06 INFO - PROCESS | 17511 | RSS: Main: 142737408 13:45:06 INFO - PROCESS | 17511 | 13:45:58 INFO - PROCESS | 17511 | 1479419158248 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] 13:48:07 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:56820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56820/tests/dromaeo/cssquery-ext.html) 13:48:08 INFO - PROCESS | 17511 | RSS: Main: 251936768 13:48:08 INFO - PROCESS | 17511 | 13:51:11 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:56820/tests/dromaeo/cssquery-ext.html (next: http://localhost:56820/tests/dromaeo/cssquery-jquery.html) 13:51:11 INFO - PROCESS | 17511 | RSS: Main: 232071168 13:51:11 INFO - PROCESS | 17511 | 13:54:13 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:56820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56820/tests/dromaeo/cssquery-mootools.html) 13:54:13 INFO - PROCESS | 17511 | RSS: Main: 207228928 13:54:13 INFO - PROCESS | 17511 | 13:57:15 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:56820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56820/tests/dromaeo/cssquery-prototype.html) 13:57:16 INFO - PROCESS | 17511 | RSS: Main: 173674496 13:57:16 INFO - PROCESS | 17511 | 14:00:19 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:56820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56820/tests/dromaeo/cssquery-yui.html) 14:00:19 INFO - PROCESS | 17511 | RSS: Main: 174325760 14:00:19 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | Cycle 1(1): loaded http://localhost:56820/tests/dromaeo/cssquery-yui.html (next: http://localhost:56820/tests/dromaeo/cssquery-dojo.html) 14:03:22 INFO - PROCESS | 17511 | RSS: Main: 261611520 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | __start_tp_report 14:03:22 INFO - PROCESS | 17511 | _x_x_mozilla_page_load 14:03:22 INFO - PROCESS | 17511 | _x_x_mozilla_page_load_details 14:03:22 INFO - PROCESS | 17511 | |i|pagename|runs| 14:03:22 INFO - PROCESS | 17511 | |0;dojo.html;3183.5224716292555;3200.039988003599;3241.5623890774737;3242.9189270268225;3275.934481310374;5737.34020587632;5784.2480477537965;5795.362510123889;5801.47786699197;5803.970980145104;5675.063614503612;5754.050581654022;5759.913601295984;5761.740721667525;5765.625234359774;5200.6099542534275;5217.321748172732;5231.346081739783;5294.735263236842;5298.629095963284;5154;5306;5313.335833020872;5318.840434786963;5321.920171197435;5112.616553758483;5174.793008279683;5195.116830138866;5211.218317252405;5224.843254702365;5239.397469291023;5273.288106105665;5275.709835959021;5341.706206158659;5353.357597088336;4972.328735620681;5183.766730497136;5263.210518422229;5273.1035723927025;5341.225522299244;5490.533304669108;5539.307586551681;5553.16702494629;5618.410066942953;5684.7157642118145;5956.612820166675;5966.492848107916;6041.758329666808;6048.274207095177;6060.515158787331;5787.045137552299;6088.391160883921;6097.969510152465;6104.908426373608;6109;5457;5600.4959553640365;5652.886942261173;5658.773649054074;5671.716414179275;6287.1198032275515;6290.968545157337;6296.748130074838;6297.149884765589;6299.307076221612;5866.7653293868625;5973.402659734079;5975.492083172892;5983.730732117066;5984.611000284967;5951.642901425928;5980.282366116094;5981;5983.431574000463;6101.572889897665;6021.458068773832;6046.425589568984;6061.54538409621;6063.484603808725;6118.479929206067;6033.879322413527;6086.452219300196;6091.51267898567;6093.482054025458;6103.908441373383;4553.362529245842;4612.7462989535225;4634.073185362941;4637;4662.347271382009;4136.875893723133;4166;4168.270552653274;4172.144710334374;4197.139586384784;5876.059830427197;5883.61756485827;5887.793927212527;5891.764329426775;5931.288245410492;5978.103284507359;5985.9401405986255;6099.481544068715;6106.816795496142;6139.907901381483;5780.219670344533;5780.508656764222;5787.94212057874;5802.535797136219;5812.79655212074;5229.712365819916;5236.24074509194;5236.92144617831;5238.554722848525;5297.867553311121;6084.969575152184;6103.786367477117;6133.294671112879;6175.876482470326;6268.028455589391;5990.7304171311525;5995.250593675791;6027.427394397525;6036.486898613667;6067.878642427215;6177.505799536116;6211.751529938751;6215.658138802229;6224.1597384352535;6227.750889964351;5755.280589926259;5774.740136693775;5883.058710606282;5900.7049647518315;5988.760449581968;6132.569672417391;6231.906521402092;6243.188385509855;6248.562600617913;6249.187605611241;6056.273247210363;6069.9089513656445;6079.240094988127;6084.960388003423;6105.053716673922;5813.447722466359;5914.58597898143;6054.061620448838;6073.271207455134;6080.817575472743;5992.43071908168;6020.096985452217;6030.30651475086;6078.422549857756;6088.117223002729;6124.356942521149;6131.552947516549;6138.171346868295;6139.140520327247;6144.969275153596;5609.1305847593685;5649.491545760901;5844.415558444121;5992.1910542078;6015.428534289235 14:03:22 INFO - PROCESS | 17511 | |1;ext.html;593.7476572456704;630.1430055125032;637.5919411576591;659.5086660437975;664.8504086580518;34750.82624586877;45769.54230457694;46605.30092048614;46692.29961550571;46723.532764672425;48001;48473.51526484734;48572.75713621436;48618.75690621542;48645.75677121618;8318.70884519042;8538.06081331053;9371.625134994609;9513.33406661534;9534.427934323929;11067.944660276688;11359.943200284028;11363.204575679665;11680.0655947524;11697.239679420853;11377;11394.71513212168;11450.828237576443;11474.368909709963;11491.080713542939;11277.774444511106;11325.660230193107;11331.37677427741;11339.886601134007;11344.319340839493;11171.888281117248;11211.551537938472;11213.831792523119;11227.494762735696;11236.606718764886;44995;45370.77314613406;45416.54583454156;45439.77280113578;45541.544584554395;3824.285303194166;3864.574896761354;3997.9400308995387;4225.492940847118;4559.316102584606;34744.47883281753;34803.30393392118;34828;34905.82547087274;34943.126421839406;4660.464046634646;4661.580457758784;4683.88290292742;4742.644301677354;4827.758612069382;355202;356568;357041;357298;357808;60013.39986600078;60100.39899601036;60320.39679603236;60392.69803651042;60490.69754651198;39759.60240397617;41230;41298.79350603228;42975.56195504352;42993.14013719708;19271;19436.125374358187;19439.8056019438;19452.70820937687;19453.513662158275;12676;12908;14453.566393008226;14831;15017.098974061591;20578.485537861372;20597.794022059887;20851.8957405212;21037;21085.68371474429;7596.627930744016;7611.7269574083675;7766.689332426753;7780.338671212897;7822.452428330076;1044.7753732947301;1126.572569800691;1160.257435241446;1210.515793682534;1216.683662247822;34726.82636586852;34799.65200348015;35133.121671958404;35154.82422587871;35352.29295414077;1146.2893006336126;1208.9214201076902;1242.3788105947026;1242.937853107341;1306.7059911520023;18186.36347727823;19395.90302048509;19500.70748938767;19613.705794413094;20127.698084528743;547874;551832;553130;553257;555157;64413.35586644167;64863.35136648573;64884.351156488774;64894;64899.67550162219;1318.6439661291397;1369.1169195868808;1428.4714655577502;1453.0772959171002;1495.0730547060675;33132.33735325328;34946.602135914276;35074.82462587671;35370.432233264306;35510.64489355177;51368;60089.39910600838;61560.38439615547;61950.38049619446;65847;505072;512734;513129;513234;514210;39650.60349396584;40218.19563608653;44807.327890081026;46541.30188047114;48074;51388;51988.74005629947;52047.73976130095;52062;52833.47166528286;44464.33303500515;44613.77693111644;44720.32919506275;45245.54754452545;45503.772481137385;44660.33009504925;45793;46441.303380449994;46835.53164468312;47315.76342118267;44728.55271447244;45525.54474455213;46375.3043704338;46548.53451465442;46645.76677116593;37887.62112378841;39980.2003959925;40219.3967090488;40655.43896484668;41217.38173927333;29690.406191876475;29972.250693732833;30309.848450757607;30686.232844179074;30719.38561228718 14:03:22 INFO - PROCESS | 17511 | |2;jquery.html;433.38892162051513;438.8091180336553;444.33793647465285;445.7080612199011;454.76806828517465;19257.614847703037;19418.12618432172;20419.897900510514;20592;20985.37043888682;19662.115204815782;20286.797132028674;20571.485712857186;20618.072186751593;20663.690044649342;5876.236089308384;6156.692165391735;6159;6160.0759886017;6161.784337548187;5940.61386009908;6080;6080.300765411968;6108.786192483264;6111.755529778803;6060.818175454743;6083.756649734028;6084.452399284063;6088.391160883898;6088.66512341821;5805.36141024487;6078.513718902499;6101.450869421729;6106.694665266763;6107.358727333611;5344.198370244456;5505.532029777473;5510.0632892408385;5511.063119269734;5511.9724401378135;15209.467668631545;15318.540443786704;21798.019089141028;22373.664395034088;24194.758052419602;2399.8800059997106;2507.335556077641;2640.3663120850856;2661.3479697474245;3052.9619929224173;11075.612353567667;11581.710457238552;11647.126465515035;11824.290542567473;11841.703957401047;1928.852332861945;1950.9902450487798;1958.5984873101122;1971.714101455281;2011.688188330811;82890.58554707248;85914;86071.13928860694;87291.56354218251;95881.5205923966;11500.137489688306;11715.121365897592;11770.293782372913;11802.645920622223;12167.817482737766;16941.745873811902;17005.57486062858;17029.31882724677;17031.659366812593;17070.743938840926;8600.655973761104;8708.129187081367;8785.385023048453;8873;8896.822063558693;8002;8100.797480063045;8126.593670316579;8140.308073813792;8636.136386361313;5052.8484145475695;5163.4062082860955;5167.405748338989;5236.214567814858;5255.237990491358;2094.2460714142894;2109.862858914166;2112.8098471137673;2140.197425965263;2241.540484200735;973.7468258252906;1012.3976234140822;1076.9138468922467;1090;1102.979743737056;20812.27157049496;20943.8952805235;20952;21120.366389008355;21555.67666485004;1047.7171163785736;1072.2976450424985;1076.9084627806567;1131.7736452709491;1144.9885501144881;11129.610463633733;11695.415229238504;11956.940215299042;11977.161598688008;11983.34091624969;498921;512178;556783;574375;578027;96443;99541;99647;101614.49192754137;102511;989.9703008909744;1040.942748148859;1053.4469403563191;1056.9312994655477;1071.5392381276126;17979.820201797815;18186.181621826785;18565.658181527455;18721.625567488303;18910.810891890906;44097.77951110224;44751.77624111858;44951.775241124895;45032.77483612561;45888;59313.703431482565;60278;60283.397166027775;60797;61318.69340653268;9011.864822027806;9039.909600903908;9406.153446189875;9409.34134610598;9501.762455938657;10732.463376831283;13845.584632461043;13945.721085578434;14331.996760226684;14714.117152970855;11923.463444145207;12307.507699691912;12523.874761252271;12794.296313702836;13095.541656041993;12251.142420030512;12263.325517096646;12473.812892806796;12515.499380024698;12577.119601627799;12728.490860365482;12828.166169199345;12844.807327889903;12846.329977102916;13210.339483026002;9257.67598134062;9477.431354118775;9495.38280011797;9534.380265282734;9841;12241.143119981873;12732.23606583608;12758.170718903242;12823.294718790183;12957.093003489665 14:03:22 INFO - PROCESS | 17511 | |3;mootools.html;1334.0461569977465;1518.2712298096912;1521.0037425486307;1675.1624187906048;1805.9819401805978;7799.220077992198;8664.653413863445;8938;8969.327300452467;9228.6308547658;8976.730698079067;9069.13843184898;9081.682141125062;9082.228010619088;9084.454932704042;2418.8548687078787;2441.8779061046966;2442.4870777136734;2448.436859522311;2453.4847681986803;2398.6521954316613;2427.672264244322;2440.4386990992084;2445;2445.7065152181763;2382.3924899150693;2398.7481314461993;2407.5305315463406;2438.0247900839627;2441.426264827764;2388.820838437124;2403.6875206223167;2413.6379543068506;2417.7944874685586;2444.1201167579657;2356.2577787996725;2405.338531903723;2413.384586930339;2420.8668523231217;2427.1747605814107;8139.064007639138;8405.327573794082;9011.324150688724;9051.502167380791;9151.450912945245;4877.609791216694;5419.241306217094;5606.21512988182;5612.803551875665;5687.857803554903;3466.9479957800654;3520.7291297113475;3522.6125126236093;3531.646835316448;3597.2985267872778;1179.7699448607525;1204.1871736577775;1210.3282678113644;1210.7215340471653;1214.0348423003734;11747.177697561174;11751;11798.469068891834;11800.40997950099;11810.586629467927;4747.715137091785;4773.431352040565;4849.563539281411;4938.753062346868;4962.20604703253;9989.600415983425;10007.14939230159;10033.949830250947;10055.446950417798;10075.445850478147;5502.2296878437055;5526.530244929146;5539.750711218005;5545.805896793593;5563.054280772279;5065.848024559269;5072.492750724898;5094.847154585368;5106.821261255838;5128.102582048126;4192.203481338597;4217.52386664671;4256.957430425656;4291.935620965688;4294.484661840599;1407.9718405632034;1418.319206780751;1423.288355822089;1430.249119212401;1432.8567143285588;1028.4806172882647;1032.442481060219;1039.3711804358254;1043.9373637581768;1056.4770438632927;6231.875362492725;6451.645159516272;6453;6463.192100987377;6496.420023883151;476.77114984807486;479.70737849911524;486.26331108370846;501.05551036296845;501.9046381187563;4233.491980962304;4321.546237645065;4364.8254069837485;4391;4407.27279998803;9891.35706179096;10297.897021029843;10459.424731639681;10857.077148442313;10857.294275872044;11088.33469991803;11108.111351091893;11122.55509779616;11124.55501779936;11131.777364452666;7944.165862584461;8064.798380040428;8069.515829050276;8076.030876294764;8080.515169089874;6087.178230938766;6104.298005729221;6209.96895015522;6255.31191568918;6334.239891212899;10031.54858031405;10055.748606284902;10083.546240419346;10116.08955194036;10132.898671013196;10507.684769456928;10733.463326833471;10736.194785391282;10787.67636970892;10859.782804343711;8188.385871059813;8222.671093156207;8239.546824924686;8331.125231850569;8380.95809520973;8785.604647790993;8830.735077947671;8856.955715221382;8857.911420885708;8861.955690221508;7888.171741967011;7942.761717148494;8166.877496837434;8281.875771863306;8351.665933362841;7736.92263077362;7754.651040703069;7770.844583108194;7819.765407037798;7880.684772609261;7372.59450730215;7386.519876208029;7465.477416581004;7473.588952607442;7479.70081196746;5418.891622167455;5616.073347897551;5616.887662246814;5626.212330273683;5642.971785141048;5371;5535.114381698909;5540.889182216414;5595.468430499259;5699.5725320600295 14:03:22 INFO - PROCESS | 17511 | |4;prototype.html;357.89084329279575;360.30101602890375;360.8700867687632;362.3568166504454;363.698130551642;5512.72436378181;5528.7788488460465;5556.388797232301;5573.47052030057;5586.636868603538;5463.699496527689;5481.451854814517;5485.42185172969;5490.890182196354;5498.230247765316;4233.51314598822;4293.613574778269;4329.913401731964;4332.891677708067;4354.47746270448;4313.460817397825;4329.783510824462;4333.653307735373;4336.349547567858;4346.913061738764;4299.978500107495;4300.548442413548;4303.956960430387;4309.892252693677;4316.633086187678;4176.707630465853;4303.311470164775;4335.523092459858;4356.237658409797;4363.738175709467;3851.2105018471148;3855.3253180693546;3863.787491687956;3867.7679339239735;3868.6324799144036;5392;5400.702961337125;5424.83725488236;5426.294581704353;5428.864278393033;4694.882627934295;4941.184704523749;4987.451380348159;4992.251162325644;5019.5231453012275;5755.597108202427;5766.682832444214;5783.450572195635;5785.47930686236;5785.739641716133;4250.298700714378;4253.510846252659;4254.489461264637;4260.25445547028;4263.147370525876;5787.594868359217;5999.490043346321;6007.369226231226;6008.098785182214;6035.374612043775;4352.846495678647;4357.433533640607;4358.6295164911335;4359.607635312837;4363.367311739843;4404.7357158570585;4414.337849322563;4421.037904603859;4425.291953287458;4426.44669416323;4815.2054910940005;4920.975395123001;4957.677750946177;4972.254161875748;4974.602031837444;5819.214406055128;5827.88344233113;5831.970840145772;5832.708364581754;5845.532357411482;1477.5788900163616;1495.9027663201857;1497.5507347795617;1497.7528707763315;1500.7373709600777;974.7368210583103;983.8278301297245;990.7225976726528;1047.8428235764695;1063.2716589136467;5601.355844077902;5621.353544342453;5621.381648018714;5625.184348269478;5643.576731745054;5882.470577648032;5893.5874488785375;5908.793192238251;5919.319278283053;5936.970315148396;5491.203775452537;5578.44215578447;5633.324001119892;5674.914876276859;5732.484076433141;3174.5238214268043;3189;3201.8399080045906;3204.276365089702;3210.9036728898172;5958.970205149033;6162.907556386658;6163.229596300463;6173.629582225081;6200.782972595937;5878.412158784173;6148.831721972811;6159.538034647419;6160.784372546939;6174.228221472316;5990.670513121733;6055.757769689251;6163.876722465526;6189.566730328834;6206.627602343783;6005.8288633716;6007.399260074132;6012.218411606463;6018.699065046642;6037.396260373927;5553.694546799803;5692.260006199168;5860.355360910211;5961.314448838439;5986.491148252448;6119.296280927751;6175.96912015455;6203.2245969253845;6215.720292586754;6241.843953901189;4202.26460369428;4272.722273052242;4281.122369914222;4285.250081235834;4303.956960430481;5951.184888609016;5970.194023806731;5987.473194335416;6000.159977603226;6000.339962604023;5820.206300975471;5838.299404071538;5854.765809367577;5884.6469211847425;5916.290045194604;5639.661620302795;5803.767849285981;5818.592698511064;5844.386339434468;5875.353711091691;5790;5791.276090488689;5815.302163740378;5827.155062515996;5830.2420685310635;5555.861103472445;5740.339860915881;5816.098504731774;5866.178734977021;5869.501092407193;5741.827745167651;5756.769729210785;5760.193572899713;5763.913541296968;5782.161586570008 14:03:22 INFO - PROCESS | 17511 | |5;yui.html;720.2581341218544;749.7759633575627;867.3364875869959;912.8904531456225;914.2229105260525;17170.22733976971;18140.99999999998;18151.81848181518;18155.273789048457;18213.817861821393;16745.581360465996;16913.661726765487;16914.23885925133;16942.745858812097;16949.152542372893;722.6856317501877;738.9150247721527;848.7538613802021;869.6999535160376;874.0734821089634;875.7766769473807;885.8316919785252;885.8848349714528;886.2688282167205;886.3706768194589;942.8302905477011;949.7435692363058;950.3490109275134;952;952.0527075559828;944.7354740672554;945.394947233771;945.7210123013728;946.0019679238435;946.1390134977138;689.4932224814758;693.5873155472536;693.6635731670136;693.9410150137245;694.2606124477416;16253.593660158473;16403.58991025222;16409.42567010149;16416.917915410348;16417.507474775775;16254.51236462908;16524.421645242357;16550.089745064015;16960;17032;12697.365131743376;12759.553415630502;12861.228326300452;13005.60983170497;13629.659258518517;4068.776217308047;4076.9184616307803;4111.259973204822;4184.686148538872;4226.091390351058;79691.6015419925;80401;80541;81572;81787.5910620449;12123.878761212274;12297.407710019985;12479.126461147633;12561.560345387868;12805.551805686757;25387.238382848544;25433.10984115547;25441.236762897144;25441.74558254394;25472.108476203244;9318.580663870142;9327.393719408217;9370.156685898302;9420.293477989178;9871.506424678737;4894.1679914414635;5216.403521446033;5331;5350.732463376816;5382.654336415896;3722.571904230994;3838.5777564467885;3838.7696738195796;3839.1745774658584;3840.231953609289;634.765136899341;643.9967800161063;647.3785166240368;648.7178077536287;687.4637782529635;689.9965500172567;749.7638243953137;776.6194564663388;813.2314962360513;838.890944177253;10756.462176891124;10878.005449482416;10982.945085274523;11174.329540227613;11363.375014374124;768.2317682317682;775.685847231872;790.6995341770206;803.6263137641025;806.6087947345533;5326.414094449608;5436.565074794007;5440.6735595864375;5490.533304669068;5519.69641669712;76662.23337766662;107888.46055769672;109995;116859;139777;90578.54710726404;94102.05897941069;113823.43088284506;119594;119822;58451.4154858446;90857;92832.53583732038;93632;95216.0478395221;10484.790304194026;10640.52117654692;10744.570217191225;10789.56841726322;10815.35107893529;55226.72386638041;57048;57599.71200143972;58455.12317315159;58644;75675.62162189154;83435.5828220855;83568.16431835604;83728;84270;13545.932270338586;13731.656708581966;14042.087264327785;14158.254510770063;14433.855661443671;14493.85506144925;15054.172020538976;15075;15309.540713778604;16256.756148658016;14091.929540352232;14255;14466.349014294172;14475.782863257271;14660.047096938664;12750.298733569743;12938.288394138037;13236.801447978096;13541.458341666223;14537.781933270799;12227.266364018187;13126.934365328112;14587.708245835236;14890.478833240784;16032.038077715375;11470;11850.111241657083;12194.756104877675;12406.379681016093;12456.31490268044;12647.01923028981;12747.362631868555;12853.678658033625;12895.41970611306;12930.612081637566 14:03:22 INFO - PROCESS | 17511 | __end_tp_report 14:03:22 INFO - PROCESS | 17511 | __start_cc_report 14:03:22 INFO - PROCESS | 17511 | _x_x_mozilla_cycle_collect,978 14:03:22 INFO - PROCESS | 17511 | __end_cc_report 14:03:22 INFO - PROCESS | 17511 | __startTimestamp1479420202603__endTimestamp 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | ------- Summary: start ------- 14:03:22 INFO - PROCESS | 17511 | Number of tests: 6 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | [#0] dojo.html Cycles:165 Average:5664.48 Median:5891.76 stddev:643.58 (10.9%) stddev-sans-first:615.42 14:03:22 INFO - PROCESS | 17511 | Values: 3183.5 3200.0 3241.6 3242.9 3275.9 5737.3 5784.2 5795.4 5801.5 5804.0 5675.1 5754.1 5759.9 5761.7 5765.6 5200.6 5217.3 5231.3 5294.7 5298.6 5154.0 5306.0 5313.3 5318.8 5321.9 5112.6 5174.8 5195.1 5211.2 5224.8 5239.4 5273.3 5275.7 5341.7 5353.4 4972.3 5183.8 5263.2 5273.1 5341.2 5490.5 5539.3 5553.2 5618.4 5684.7 5956.6 5966.5 6041.8 6048.3 6060.5 5787.0 6088.4 6098.0 6104.9 6109.0 5457.0 5600.5 5652.9 5658.8 5671.7 6287.1 6291.0 6296.7 6297.1 6299.3 5866.8 5973.4 5975.5 5983.7 5984.6 5951.6 5980.3 5981.0 5983.4 6101.6 6021.5 6046.4 6061.5 6063.5 6118.5 6033.9 6086.5 6091.5 6093.5 6103.9 4553.4 4612.7 4634.1 4637.0 4662.3 4136.9 4166.0 4168.3 4172.1 4197.1 5876.1 5883.6 5887.8 5891.8 5931.3 5978.1 5985.9 6099.5 6106.8 6139.9 5780.2 5780.5 5787.9 5802.5 5812.8 5229.7 5236.2 5236.9 5238.6 5297.9 6085.0 6103.8 6133.3 6175.9 6268.0 5990.7 5995.3 6027.4 6036.5 6067.9 6177.5 6211.8 6215.7 6224.2 6227.8 5755.3 5774.7 5883.1 5900.7 5988.8 6132.6 6231.9 6243.2 6248.6 6249.2 6056.3 6069.9 6079.2 6085.0 6105.1 5813.4 5914.6 6054.1 6073.3 6080.8 5992.4 6020.1 6030.3 6078.4 6088.1 6124.4 6131.6 6138.2 6139.1 6145.0 5609.1 5649.5 5844.4 5992.2 6015.4 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | [#1] ext.html Cycles:180 Average:65068.39 Median:40936.41 stddev:127331.16 (311.0%) stddev-sans-first:127596.34 14:03:22 INFO - PROCESS | 17511 | Values: 593.7 630.1 637.6 659.5 664.9 34750.8 45769.5 46605.3 46692.3 46723.5 48001.0 48473.5 48572.8 48618.8 48645.8 8318.7 8538.1 9371.6 9513.3 9534.4 11067.9 11359.9 11363.2 11680.1 11697.2 11377.0 11394.7 11450.8 11474.4 11491.1 11277.8 11325.7 11331.4 11339.9 11344.3 11171.9 11211.6 11213.8 11227.5 11236.6 44995.0 45370.8 45416.5 45439.8 45541.5 3824.3 3864.6 3997.9 4225.5 4559.3 34744.5 34803.3 34828.0 34905.8 34943.1 4660.5 4661.6 4683.9 4742.6 4827.8 355202.0 356568.0 357041.0 357298.0 357808.0 60013.4 60100.4 60320.4 60392.7 60490.7 39759.6 41230.0 41298.8 42975.6 42993.1 19271.0 19436.1 19439.8 19452.7 19453.5 12676.0 12908.0 14453.6 14831.0 15017.1 20578.5 20597.8 20851.9 21037.0 21085.7 7596.6 7611.7 7766.7 7780.3 7822.5 1044.8 1126.6 1160.3 1210.5 1216.7 34726.8 34799.7 35133.1 35154.8 35352.3 1146.3 1208.9 1242.4 1242.9 1306.7 18186.4 19395.9 19500.7 19613.7 20127.7 547874.0 551832.0 553130.0 553257.0 555157.0 64413.4 64863.4 64884.4 64894.0 64899.7 1318.6 1369.1 1428.5 1453.1 1495.1 33132.3 34946.6 35074.8 35370.4 35510.6 51368.0 60089.4 61560.4 61950.4 65847.0 505072.0 512734.0 513129.0 513234.0 514210.0 39650.6 40218.2 44807.3 46541.3 48074.0 51388.0 51988.7 52047.7 52062.0 52833.5 44464.3 44613.8 44720.3 45245.5 45503.8 44660.3 45793.0 46441.3 46835.5 47315.8 44728.6 45525.5 46375.3 46548.5 46645.8 37887.6 39980.2 40219.4 40655.4 41217.4 29690.4 29972.3 30309.8 30686.2 30719.4 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | [#2] jquery.html Cycles:180 Average:31502.33 Median:21676.85 stddev:89811.75 (414.3%) stddev-sans-first:90033.40 14:03:22 INFO - PROCESS | 17511 | Values: 433.4 438.8 444.3 445.7 454.8 19257.6 19418.1 20419.9 20592.0 20985.4 19662.1 20286.8 20571.5 20618.1 20663.7 5876.2 6156.7 6159.0 6160.1 6161.8 5940.6 6080.0 6080.3 6108.8 6111.8 6060.8 6083.8 6084.5 6088.4 6088.7 5805.4 6078.5 6101.5 6106.7 6107.4 5344.2 5505.5 5510.1 5511.1 5512.0 15209.5 15318.5 21798.0 22373.7 24194.8 2399.9 2507.3 2640.4 2661.3 3053.0 11075.6 11581.7 11647.1 11824.3 11841.7 1928.9 1951.0 1958.6 1971.7 2011.7 82890.6 85914.0 86071.1 87291.6 95881.5 11500.1 11715.1 11770.3 11802.6 12167.8 16941.7 17005.6 17029.3 17031.7 17070.7 8600.7 8708.1 8785.4 8873.0 8896.8 8002.0 8100.8 8126.6 8140.3 8636.1 5052.8 5163.4 5167.4 5236.2 5255.2 2094.2 2109.9 2112.8 2140.2 2241.5 973.7 1012.4 1076.9 1090.0 1103.0 20812.3 20943.9 20952.0 21120.4 21555.7 1047.7 1072.3 1076.9 1131.8 1145.0 11129.6 11695.4 11956.9 11977.2 11983.3 498921.0 512178.0 556783.0 574375.0 578027.0 96443.0 99541.0 99647.0 101614.5 102511.0 990.0 1040.9 1053.4 1056.9 1071.5 17979.8 18186.2 18565.7 18721.6 18910.8 44097.8 44751.8 44951.8 45032.8 45888.0 59313.7 60278.0 60283.4 60797.0 61318.7 9011.9 9039.9 9406.2 9409.3 9501.8 10732.5 13845.6 13945.7 14332.0 14714.1 11923.5 12307.5 12523.9 12794.3 13095.5 12251.1 12263.3 12473.8 12515.5 12577.1 12728.5 12828.2 12844.8 12846.3 13210.3 9257.7 9477.4 9495.4 9534.4 9841.0 12241.1 12732.2 12758.2 12823.3 12957.1 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | [#3] mootools.html Cycles:180 Average:5941.13 Median:2626.57 stddev:3278.52 (124.8%) stddev-sans-first:3269.43 14:03:22 INFO - PROCESS | 17511 | Values: 1334.0 1518.3 1521.0 1675.2 1806.0 7799.2 8664.7 8938.0 8969.3 9228.6 8976.7 9069.1 9081.7 9082.2 9084.5 2418.9 2441.9 2442.5 2448.4 2453.5 2398.7 2427.7 2440.4 2445.0 2445.7 2382.4 2398.7 2407.5 2438.0 2441.4 2388.8 2403.7 2413.6 2417.8 2444.1 2356.3 2405.3 2413.4 2420.9 2427.2 8139.1 8405.3 9011.3 9051.5 9151.5 4877.6 5419.2 5606.2 5612.8 5687.9 3466.9 3520.7 3522.6 3531.6 3597.3 1179.8 1204.2 1210.3 1210.7 1214.0 11747.2 11751.0 11798.5 11800.4 11810.6 4747.7 4773.4 4849.6 4938.8 4962.2 9989.6 10007.1 10033.9 10055.4 10075.4 5502.2 5526.5 5539.8 5545.8 5563.1 5065.8 5072.5 5094.8 5106.8 5128.1 4192.2 4217.5 4257.0 4291.9 4294.5 1408.0 1418.3 1423.3 1430.2 1432.9 1028.5 1032.4 1039.4 1043.9 1056.5 6231.9 6451.6 6453.0 6463.2 6496.4 476.8 479.7 486.3 501.1 501.9 4233.5 4321.5 4364.8 4391.0 4407.3 9891.4 10297.9 10459.4 10857.1 10857.3 11088.3 11108.1 11122.6 11124.6 11131.8 7944.2 8064.8 8069.5 8076.0 8080.5 6087.2 6104.3 6210.0 6255.3 6334.2 10031.5 10055.7 10083.5 10116.1 10132.9 10507.7 10733.5 10736.2 10787.7 10859.8 8188.4 8222.7 8239.5 8331.1 8381.0 8785.6 8830.7 8857.0 8857.9 8862.0 7888.2 7942.8 8166.9 8281.9 8351.7 7736.9 7754.7 7770.8 7819.8 7880.7 7372.6 7386.5 7465.5 7473.6 7479.7 5418.9 5616.1 5616.9 5626.2 5643.0 5371.0 5535.1 5540.9 5595.5 5699.6 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | [#4] prototype.html Cycles:180 Average:4913.10 Median:5594.00 stddev:1432.16 (25.6%) stddev-sans-first:1394.77 14:03:22 INFO - PROCESS | 17511 | Values: 357.9 360.3 360.9 362.4 363.7 5512.7 5528.8 5556.4 5573.5 5586.6 5463.7 5481.5 5485.4 5490.9 5498.2 4233.5 4293.6 4329.9 4332.9 4354.5 4313.5 4329.8 4333.7 4336.3 4346.9 4300.0 4300.5 4304.0 4309.9 4316.6 4176.7 4303.3 4335.5 4356.2 4363.7 3851.2 3855.3 3863.8 3867.8 3868.6 5392.0 5400.7 5424.8 5426.3 5428.9 4694.9 4941.2 4987.5 4992.3 5019.5 5755.6 5766.7 5783.5 5785.5 5785.7 4250.3 4253.5 4254.5 4260.3 4263.1 5787.6 5999.5 6007.4 6008.1 6035.4 4352.8 4357.4 4358.6 4359.6 4363.4 4404.7 4414.3 4421.0 4425.3 4426.4 4815.2 4921.0 4957.7 4972.3 4974.6 5819.2 5827.9 5832.0 5832.7 5845.5 1477.6 1495.9 1497.6 1497.8 1500.7 974.7 983.8 990.7 1047.8 1063.3 5601.4 5621.4 5621.4 5625.2 5643.6 5882.5 5893.6 5908.8 5919.3 5937.0 5491.2 5578.4 5633.3 5674.9 5732.5 3174.5 3189.0 3201.8 3204.3 3210.9 5959.0 6162.9 6163.2 6173.6 6200.8 5878.4 6148.8 6159.5 6160.8 6174.2 5990.7 6055.8 6163.9 6189.6 6206.6 6005.8 6007.4 6012.2 6018.7 6037.4 5553.7 5692.3 5860.4 5961.3 5986.5 6119.3 6176.0 6203.2 6215.7 6241.8 4202.3 4272.7 4281.1 4285.3 4304.0 5951.2 5970.2 5987.5 6000.2 6000.3 5820.2 5838.3 5854.8 5884.6 5916.3 5639.7 5803.8 5818.6 5844.4 5875.4 5790.0 5791.3 5815.3 5827.2 5830.2 5555.9 5740.3 5816.1 5866.2 5869.5 5741.8 5756.8 5760.2 5763.9 5782.2 14:03:22 INFO - PROCESS | 17511 | 14:03:22 INFO - PROCESS | 17511 | [#5] yui.html Cycles:180 Average:22120.83 Median:3839.70 stddev:31160.50 (811.5%) stddev-sans-first:31206.48 14:03:22 INFO - PROCESS | 17511 | Values: 720.3 749.8 867.3 912.9 914.2 17170.2 18141.0 18151.8 18155.3 18213.8 16745.6 16913.7 16914.2 16942.7 16949.2 722.7 738.9 848.8 869.7 874.1 875.8 885.8 885.9 886.3 886.4 942.8 949.7 950.3 952.0 952.1 944.7 945.4 945.7 946.0 946.1 689.5 693.6 693.7 693.9 694.3 16253.6 16403.6 16409.4 16416.9 16417.5 16254.5 16524.4 16550.1 16960.0 17032.0 12697.4 12759.6 12861.2 13005.6 13629.7 4068.8 4076.9 4111.3 4184.7 4226.1 79691.6 80401.0 80541.0 81572.0 81787.6 12123.9 12297.4 12479.1 12561.6 12805.6 25387.2 25433.1 25441.2 25441.7 25472.1 9318.6 9327.4 9370.2 9420.3 9871.5 4894.2 5216.4 5331.0 5350.7 5382.7 3722.6 3838.6 3838.8 3839.2 3840.2 634.8 644.0 647.4 648.7 687.5 690.0 749.8 776.6 813.2 838.9 10756.5 10878.0 10982.9 11174.3 11363.4 768.2 775.7 790.7 803.6 806.6 5326.4 5436.6 5440.7 5490.5 5519.7 76662.2 107888.5 109995.0 116859.0 139777.0 90578.5 94102.1 113823.4 119594.0 119822.0 58451.4 90857.0 92832.5 93632.0 95216.0 10484.8 10640.5 10744.6 10789.6 10815.4 55226.7 57048.0 57599.7 58455.1 58644.0 75675.6 83435.6 83568.2 83728.0 84270.0 13545.9 13731.7 14042.1 14158.3 14433.9 14493.9 15054.2 15075.0 15309.5 16256.8 14091.9 14255.0 14466.3 14475.8 14660.0 12750.3 12938.3 13236.8 13541.5 14537.8 12227.3 13126.9 14587.7 14890.5 16032.0 11470.0 11850.1 12194.8 12406.4 12456.3 12647.0 12747.4 12853.7 12895.4 12930.6 14:03:22 INFO - PROCESS | 17511 | -------- Summary: end -------- 14:03:22 INFO - PROCESS | 17511 | 14:03:23 INFO - TEST-INFO | 17511: exit 0 14:03:23 INFO - TEST-OK | dromaeo_css | took 1113546ms 14:03:23 INFO - TEST-START | kraken 14:03:23 INFO - operating with platform_type : linux_ 14:03:23 INFO - Initialising browser for kraken test... 14:03:23 INFO - TEST-INFO | started process 17813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9g053Y/profile http://localhost:56820/getInfo.html) 14:03:27 INFO - PROCESS | 17813 | __metrics Screen width/height:1600/1200 14:03:27 INFO - PROCESS | 17813 | colorDepth:24 14:03:27 INFO - PROCESS | 17813 | Browser inner width/height: 1024/697 14:03:27 INFO - PROCESS | 17813 | __metrics 14:03:27 INFO - PROCESS | 17813 | 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" 14:03:27 INFO - PROCESS | 17813 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:28 INFO - PROCESS | 17813 | console.error: PushService: 14:03:28 INFO - PROCESS | 17813 | stateChangeProcessEnqueue: Error transitioning state 14:03:28 INFO - PROCESS | 17813 | UnknownError 14:03:28 INFO - TEST-INFO | 17813: exit 0 14:03:28 INFO - Browser initialized. 14:03:28 INFO - Running cycle 1/1 for kraken test... 14:03:28 INFO - TEST-INFO | started process 17909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9g053Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:40 INFO - PROCESS | 17909 | RSS: Main: 143720448 14:03:40 INFO - PROCESS | 17909 | 14:03:42 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56820/tests/kraken/driver.html?testName=audio-beat-detection) 14:03:43 INFO - PROCESS | 17909 | RSS: Main: 186855424 14:03:43 INFO - PROCESS | 17909 | 14:03:46 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56820/tests/kraken/driver.html?testName=audio-dft) 14:03:46 INFO - PROCESS | 17909 | RSS: Main: 173690880 14:03:46 INFO - PROCESS | 17909 | 14:03:49 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56820/tests/kraken/driver.html?testName=audio-fft) 14:03:50 INFO - PROCESS | 17909 | RSS: Main: 265252864 14:03:50 INFO - PROCESS | 17909 | 14:03:52 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56820/tests/kraken/driver.html?testName=audio-oscillator) 14:03:52 INFO - PROCESS | 17909 | RSS: Main: 171806720 14:03:52 INFO - PROCESS | 17909 | 14:03:55 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:55 INFO - PROCESS | 17909 | RSS: Main: 173613056 14:03:55 INFO - PROCESS | 17909 | 14:03:58 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56820/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:59 INFO - PROCESS | 17909 | RSS: Main: 209522688 14:03:59 INFO - PROCESS | 17909 | 14:04:02 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56820/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:03 INFO - PROCESS | 17909 | RSS: Main: 208211968 14:04:03 INFO - PROCESS | 17909 | 14:04:05 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56820/tests/kraken/driver.html?testName=json-parse-financial) 14:04:06 INFO - PROCESS | 17909 | RSS: Main: 208482304 14:04:06 INFO - PROCESS | 17909 | 14:04:07 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:08 INFO - PROCESS | 17909 | RSS: Main: 169803776 14:04:08 INFO - PROCESS | 17909 | 14:04:10 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:10 INFO - PROCESS | 17909 | RSS: Main: 177897472 14:04:10 INFO - PROCESS | 17909 | 14:04:12 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:13 INFO - PROCESS | 17909 | RSS: Main: 186531840 14:04:13 INFO - PROCESS | 17909 | 14:04:15 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:16 INFO - PROCESS | 17909 | RSS: Main: 196231168 14:04:16 INFO - PROCESS | 17909 | 14:04:19 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:19 INFO - PROCESS | 17909 | RSS: Main: 192380928 14:04:19 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:56820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56820/tests/kraken/driver.html?testName=ai-astar) 14:04:21 INFO - PROCESS | 17909 | RSS: Main: 243777536 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | __start_tp_report 14:04:21 INFO - PROCESS | 17909 | _x_x_mozilla_page_load 14:04:21 INFO - PROCESS | 17909 | _x_x_mozilla_page_load_details 14:04:21 INFO - PROCESS | 17909 | |i|pagename|runs| 14:04:21 INFO - PROCESS | 17909 | |0;ai-astar;110;109;109;109;111;111;110;109;110;111 14:04:21 INFO - PROCESS | 17909 | |1;audio-beat-detection;142;119;117;155;123;118;121;120;151;118 14:04:21 INFO - PROCESS | 17909 | |2;audio-dft;162;161;163;160;161;162;161;160;162;160 14:04:21 INFO - PROCESS | 17909 | |3;audio-fft;75;74;75;101;74;74;75;74;99;76 14:04:21 INFO - PROCESS | 17909 | |4;audio-oscillator;81;82;110;81;82;82;105;81;81;104 14:04:21 INFO - PROCESS | 17909 | |5;imaging-gaussian-blur;116;116;117;116;117;116;116;116;116;117 14:04:21 INFO - PROCESS | 17909 | |6;imaging-darkroom;146;145;145;145;145;145;146;146;146;148 14:04:21 INFO - PROCESS | 17909 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;94;95 14:04:21 INFO - PROCESS | 17909 | |8;json-parse-financial;49;49;48;47;48;48;49;47;48;48 14:04:21 INFO - PROCESS | 17909 | |9;json-stringify-tinderbox;58;58;59;59;58;58;58;59;59;59 14:04:21 INFO - PROCESS | 17909 | |10;stanford-crypto-aes;73;72;72;72;73;72;73;72;72;72 14:04:21 INFO - PROCESS | 17909 | |11;stanford-crypto-ccm;123;120;128;118;127;126;119;138;155;120 14:04:21 INFO - PROCESS | 17909 | |12;stanford-crypto-pbkdf2;156;152;150;150;151;151;149;149;148;150 14:04:21 INFO - PROCESS | 17909 | |13;stanford-crypto-sha256-iterative;66;61;61;62;61;61;62;60;61;61 14:04:21 INFO - PROCESS | 17909 | __end_tp_report 14:04:21 INFO - PROCESS | 17909 | __start_cc_report 14:04:21 INFO - PROCESS | 17909 | _x_x_mozilla_cycle_collect,1552 14:04:21 INFO - PROCESS | 17909 | __end_cc_report 14:04:21 INFO - PROCESS | 17909 | __startTimestamp1479420261587__endTimestamp 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | ------- Summary: start ------- 14:04:21 INFO - PROCESS | 17909 | Number of tests: 14 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 14:04:21 INFO - PROCESS | 17909 | Values: 110.0 109.0 109.0 109.0 111.0 111.0 110.0 109.0 110.0 111.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:122.00 stddev:14.88 (12.2%) stddev-sans-first:14.95 14:04:21 INFO - PROCESS | 17909 | Values: 142.0 119.0 117.0 155.0 123.0 118.0 121.0 120.0 151.0 118.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 14:04:21 INFO - PROCESS | 17909 | Values: 162.0 161.0 163.0 160.0 161.0 162.0 161.0 160.0 162.0 160.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.00 stddev:10.73 (14.3%) stddev-sans-first:11.24 14:04:21 INFO - PROCESS | 17909 | Values: 75.0 74.0 75.0 101.0 74.0 74.0 75.0 74.0 99.0 76.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:81.00 stddev:12.13 (15.0%) stddev-sans-first:12.53 14:04:21 INFO - PROCESS | 17909 | Values: 81.0 82.0 110.0 81.0 82.0 82.0 105.0 81.0 81.0 104.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:04:21 INFO - PROCESS | 17909 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 14:04:21 INFO - PROCESS | 17909 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 148.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:04:21 INFO - PROCESS | 17909 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.00 stddev:0.74 (1.5%) stddev-sans-first:0.71 14:04:21 INFO - PROCESS | 17909 | Values: 49.0 49.0 48.0 47.0 48.0 48.0 49.0 47.0 48.0 48.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 14:04:21 INFO - PROCESS | 17909 | Values: 58.0 58.0 59.0 59.0 58.0 58.0 58.0 59.0 59.0 59.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 14:04:21 INFO - PROCESS | 17909 | Values: 73.0 72.0 72.0 72.0 73.0 72.0 73.0 72.0 72.0 72.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.50 stddev:11.37 (9.0%) stddev-sans-first:11.95 14:04:21 INFO - PROCESS | 17909 | Values: 123.0 120.0 128.0 118.0 127.0 126.0 119.0 138.0 155.0 120.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:150.50 stddev:2.22 (1.5%) stddev-sans-first:1.22 14:04:21 INFO - PROCESS | 17909 | Values: 156.0 152.0 150.0 150.0 151.0 151.0 149.0 149.0 148.0 150.0 14:04:21 INFO - PROCESS | 17909 | 14:04:21 INFO - PROCESS | 17909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:0.60 14:04:21 INFO - PROCESS | 17909 | Values: 66.0 61.0 61.0 62.0 61.0 61.0 62.0 60.0 61.0 61.0 14:04:21 INFO - PROCESS | 17909 | -------- Summary: end -------- 14:04:21 INFO - PROCESS | 17909 | 14:04:22 INFO - TEST-INFO | 17909: exit 0 14:04:22 INFO - TEST-OK | kraken | took 59171ms 14:04:22 INFO - SUITE-END | took 1172s 14:04:22 INFO - Completed test suite (00:19:32) 14:04:22 INFO - javascript benchmark 14:04:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.5224716292555, 3200.039988003599, 3241.5623890774737, 3242.9189270268225, 3275.934481310374, 5737.34020587632, 5784.2480477537965, 5795.362510123889, 5801.47786699197, 5803.970980145104, 5675.063614503612, 5754.050581654022, 5759.913601295984, 5761.740721667525, 5765.625234359774, 5200.6099542534275, 5217.321748172732, 5231.346081739783, 5294.735263236842, 5298.629095963284, 5154.0, 5306.0, 5313.335833020872, 5318.840434786963, 5321.920171197435, 5112.616553758483, 5174.793008279683, 5195.116830138866, 5211.218317252405, 5224.843254702365, 5239.397469291023, 5273.288106105665, 5275.709835959021, 5341.706206158659, 5353.357597088336, 4972.328735620681, 5183.766730497136, 5263.210518422229, 5273.1035723927025, 5341.225522299244, 5490.533304669108, 5539.307586551681, 5553.16702494629, 5618.410066942953, 5684.7157642118145, 5956.612820166675, 5966.492848107916, 6041.758329666808, 6048.274207095177, 6060.515158787331, 5787.045137552299, 6088.391160883921, 6097.969510152465, 6104.908426373608, 6109.0, 5457.0, 5600.4959553640365, 5652.886942261173, 5658.773649054074, 5671.716414179275, 6287.1198032275515, 6290.968545157337, 6296.748130074838, 6297.149884765589, 6299.307076221612, 5866.7653293868625, 5973.402659734079, 5975.492083172892, 5983.730732117066, 5984.611000284967, 5951.642901425928, 5980.282366116094, 5981.0, 5983.431574000463, 6101.572889897665, 6021.458068773832, 6046.425589568984, 6061.54538409621, 6063.484603808725, 6118.479929206067, 6033.879322413527, 6086.452219300196, 6091.51267898567, 6093.482054025458, 6103.908441373383, 4553.362529245842, 4612.7462989535225, 4634.073185362941, 4637.0, 4662.347271382009, 4136.875893723133, 4166.0, 4168.270552653274, 4172.144710334374, 4197.139586384784, 5876.059830427197, 5883.61756485827, 5887.793927212527, 5891.764329426775, 5931.288245410492, 5978.103284507359, 5985.9401405986255, 6099.481544068715, 6106.816795496142, 6139.907901381483, 5780.219670344533, 5780.508656764222, 5787.94212057874, 5802.535797136219, 5812.79655212074, 5229.712365819916, 5236.24074509194, 5236.92144617831, 5238.554722848525, 5297.867553311121, 6084.969575152184, 6103.786367477117, 6133.294671112879, 6175.876482470326, 6268.028455589391, 5990.7304171311525, 5995.250593675791, 6027.427394397525, 6036.486898613667, 6067.878642427215, 6177.505799536116, 6211.751529938751, 6215.658138802229, 6224.1597384352535, 6227.750889964351, 5755.280589926259, 5774.740136693775, 5883.058710606282, 5900.7049647518315, 5988.760449581968, 6132.569672417391, 6231.906521402092, 6243.188385509855, 6248.562600617913, 6249.187605611241, 6056.273247210363, 6069.9089513656445, 6079.240094988127, 6084.960388003423, 6105.053716673922, 5813.447722466359, 5914.58597898143, 6054.061620448838, 6073.271207455134, 6080.817575472743, 5992.43071908168, 6020.096985452217, 6030.30651475086, 6078.422549857756, 6088.117223002729, 6124.356942521149, 6131.552947516549, 6138.171346868295, 6139.140520327247, 6144.969275153596, 5609.1305847593685, 5649.491545760901, 5844.415558444121, 5992.1910542078, 6015.428534289235], "value": 5620.378170759191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7476572456704, 630.1430055125032, 637.5919411576591, 659.5086660437975, 664.8504086580518, 34750.82624586877, 45769.54230457694, 46605.30092048614, 46692.29961550571, 46723.532764672425, 48001.0, 48473.51526484734, 48572.75713621436, 48618.75690621542, 48645.75677121618, 8318.70884519042, 8538.06081331053, 9371.625134994609, 9513.33406661534, 9534.427934323929, 11067.944660276688, 11359.943200284028, 11363.204575679665, 11680.0655947524, 11697.239679420853, 11377.0, 11394.71513212168, 11450.828237576443, 11474.368909709963, 11491.080713542939, 11277.774444511106, 11325.660230193107, 11331.37677427741, 11339.886601134007, 11344.319340839493, 11171.888281117248, 11211.551537938472, 11213.831792523119, 11227.494762735696, 11236.606718764886, 44995.0, 45370.77314613406, 45416.54583454156, 45439.77280113578, 45541.544584554395, 3824.285303194166, 3864.574896761354, 3997.9400308995387, 4225.492940847118, 4559.316102584606, 34744.47883281753, 34803.30393392118, 34828.0, 34905.82547087274, 34943.126421839406, 4660.464046634646, 4661.580457758784, 4683.88290292742, 4742.644301677354, 4827.758612069382, 355202.0, 356568.0, 357041.0, 357298.0, 357808.0, 60013.39986600078, 60100.39899601036, 60320.39679603236, 60392.69803651042, 60490.69754651198, 39759.60240397617, 41230.0, 41298.79350603228, 42975.56195504352, 42993.14013719708, 19271.0, 19436.125374358187, 19439.8056019438, 19452.70820937687, 19453.513662158275, 12676.0, 12908.0, 14453.566393008226, 14831.0, 15017.098974061591, 20578.485537861372, 20597.794022059887, 20851.8957405212, 21037.0, 21085.68371474429, 7596.627930744016, 7611.7269574083675, 7766.689332426753, 7780.338671212897, 7822.452428330076, 1044.7753732947301, 1126.572569800691, 1160.257435241446, 1210.515793682534, 1216.683662247822, 34726.82636586852, 34799.65200348015, 35133.121671958404, 35154.82422587871, 35352.29295414077, 1146.2893006336126, 1208.9214201076902, 1242.3788105947026, 1242.937853107341, 1306.7059911520023, 18186.36347727823, 19395.90302048509, 19500.70748938767, 19613.705794413094, 20127.698084528743, 547874.0, 551832.0, 553130.0, 553257.0, 555157.0, 64413.35586644167, 64863.35136648573, 64884.351156488774, 64894.0, 64899.67550162219, 1318.6439661291397, 1369.1169195868808, 1428.4714655577502, 1453.0772959171002, 1495.0730547060675, 33132.33735325328, 34946.602135914276, 35074.82462587671, 35370.432233264306, 35510.64489355177, 51368.0, 60089.39910600838, 61560.38439615547, 61950.38049619446, 65847.0, 505072.0, 512734.0, 513129.0, 513234.0, 514210.0, 39650.60349396584, 40218.19563608653, 44807.327890081026, 46541.30188047114, 48074.0, 51388.0, 51988.74005629947, 52047.73976130095, 52062.0, 52833.47166528286, 44464.33303500515, 44613.77693111644, 44720.32919506275, 45245.54754452545, 45503.772481137385, 44660.33009504925, 45793.0, 46441.303380449994, 46835.53164468312, 47315.76342118267, 44728.55271447244, 45525.54474455213, 46375.3043704338, 46548.53451465442, 46645.76677116593, 37887.62112378841, 39980.2003959925, 40219.3967090488, 40655.43896484668, 41217.38173927333, 29690.406191876475, 29972.250693732833, 30309.848450757607, 30686.232844179074, 30719.38561228718], "value": 22282.250546002702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.38892162051513, 438.8091180336553, 444.33793647465285, 445.7080612199011, 454.76806828517465, 19257.614847703037, 19418.12618432172, 20419.897900510514, 20592.0, 20985.37043888682, 19662.115204815782, 20286.797132028674, 20571.485712857186, 20618.072186751593, 20663.690044649342, 5876.236089308384, 6156.692165391735, 6159.0, 6160.0759886017, 6161.784337548187, 5940.61386009908, 6080.0, 6080.300765411968, 6108.786192483264, 6111.755529778803, 6060.818175454743, 6083.756649734028, 6084.452399284063, 6088.391160883898, 6088.66512341821, 5805.36141024487, 6078.513718902499, 6101.450869421729, 6106.694665266763, 6107.358727333611, 5344.198370244456, 5505.532029777473, 5510.0632892408385, 5511.063119269734, 5511.9724401378135, 15209.467668631545, 15318.540443786704, 21798.019089141028, 22373.664395034088, 24194.758052419602, 2399.8800059997106, 2507.335556077641, 2640.3663120850856, 2661.3479697474245, 3052.9619929224173, 11075.612353567667, 11581.710457238552, 11647.126465515035, 11824.290542567473, 11841.703957401047, 1928.852332861945, 1950.9902450487798, 1958.5984873101122, 1971.714101455281, 2011.688188330811, 82890.58554707248, 85914.0, 86071.13928860694, 87291.56354218251, 95881.5205923966, 11500.137489688306, 11715.121365897592, 11770.293782372913, 11802.645920622223, 12167.817482737766, 16941.745873811902, 17005.57486062858, 17029.31882724677, 17031.659366812593, 17070.743938840926, 8600.655973761104, 8708.129187081367, 8785.385023048453, 8873.0, 8896.822063558693, 8002.0, 8100.797480063045, 8126.593670316579, 8140.308073813792, 8636.136386361313, 5052.8484145475695, 5163.4062082860955, 5167.405748338989, 5236.214567814858, 5255.237990491358, 2094.2460714142894, 2109.862858914166, 2112.8098471137673, 2140.197425965263, 2241.540484200735, 973.7468258252906, 1012.3976234140822, 1076.9138468922467, 1090.0, 1102.979743737056, 20812.27157049496, 20943.8952805235, 20952.0, 21120.366389008355, 21555.67666485004, 1047.7171163785736, 1072.2976450424985, 1076.9084627806567, 1131.7736452709491, 1144.9885501144881, 11129.610463633733, 11695.415229238504, 11956.940215299042, 11977.161598688008, 11983.34091624969, 498921.0, 512178.0, 556783.0, 574375.0, 578027.0, 96443.0, 99541.0, 99647.0, 101614.49192754137, 102511.0, 989.9703008909744, 1040.942748148859, 1053.4469403563191, 1056.9312994655477, 1071.5392381276126, 17979.820201797815, 18186.181621826785, 18565.658181527455, 18721.625567488303, 18910.810891890906, 44097.77951110224, 44751.77624111858, 44951.775241124895, 45032.77483612561, 45888.0, 59313.703431482565, 60278.0, 60283.397166027775, 60797.0, 61318.69340653268, 9011.864822027806, 9039.909600903908, 9406.153446189875, 9409.34134610598, 9501.762455938657, 10732.463376831283, 13845.584632461043, 13945.721085578434, 14331.996760226684, 14714.117152970855, 11923.463444145207, 12307.507699691912, 12523.874761252271, 12794.296313702836, 13095.541656041993, 12251.142420030512, 12263.325517096646, 12473.812892806796, 12515.499380024698, 12577.119601627799, 12728.490860365482, 12828.166169199345, 12844.807327889903, 12846.329977102916, 13210.339483026002, 9257.67598134062, 9477.431354118775, 9495.38280011797, 9534.380265282734, 9841.0, 12241.143119981873, 12732.23606583608, 12758.170718903242, 12823.294718790183, 12957.093003489665], "value": 9840.475012032322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.0461569977465, 1518.2712298096912, 1521.0037425486307, 1675.1624187906048, 1805.9819401805978, 7799.220077992198, 8664.653413863445, 8938.0, 8969.327300452467, 9228.6308547658, 8976.730698079067, 9069.13843184898, 9081.682141125062, 9082.228010619088, 9084.454932704042, 2418.8548687078787, 2441.8779061046966, 2442.4870777136734, 2448.436859522311, 2453.4847681986803, 2398.6521954316613, 2427.672264244322, 2440.4386990992084, 2445.0, 2445.7065152181763, 2382.3924899150693, 2398.7481314461993, 2407.5305315463406, 2438.0247900839627, 2441.426264827764, 2388.820838437124, 2403.6875206223167, 2413.6379543068506, 2417.7944874685586, 2444.1201167579657, 2356.2577787996725, 2405.338531903723, 2413.384586930339, 2420.8668523231217, 2427.1747605814107, 8139.064007639138, 8405.327573794082, 9011.324150688724, 9051.502167380791, 9151.450912945245, 4877.609791216694, 5419.241306217094, 5606.21512988182, 5612.803551875665, 5687.857803554903, 3466.9479957800654, 3520.7291297113475, 3522.6125126236093, 3531.646835316448, 3597.2985267872778, 1179.7699448607525, 1204.1871736577775, 1210.3282678113644, 1210.7215340471653, 1214.0348423003734, 11747.177697561174, 11751.0, 11798.469068891834, 11800.40997950099, 11810.586629467927, 4747.715137091785, 4773.431352040565, 4849.563539281411, 4938.753062346868, 4962.20604703253, 9989.600415983425, 10007.14939230159, 10033.949830250947, 10055.446950417798, 10075.445850478147, 5502.2296878437055, 5526.530244929146, 5539.750711218005, 5545.805896793593, 5563.054280772279, 5065.848024559269, 5072.492750724898, 5094.847154585368, 5106.821261255838, 5128.102582048126, 4192.203481338597, 4217.52386664671, 4256.957430425656, 4291.935620965688, 4294.484661840599, 1407.9718405632034, 1418.319206780751, 1423.288355822089, 1430.249119212401, 1432.8567143285588, 1028.4806172882647, 1032.442481060219, 1039.3711804358254, 1043.9373637581768, 1056.4770438632927, 6231.875362492725, 6451.645159516272, 6453.0, 6463.192100987377, 6496.420023883151, 476.77114984807486, 479.70737849911524, 486.26331108370846, 501.05551036296845, 501.9046381187563, 4233.491980962304, 4321.546237645065, 4364.8254069837485, 4391.0, 4407.27279998803, 9891.35706179096, 10297.897021029843, 10459.424731639681, 10857.077148442313, 10857.294275872044, 11088.33469991803, 11108.111351091893, 11122.55509779616, 11124.55501779936, 11131.777364452666, 7944.165862584461, 8064.798380040428, 8069.515829050276, 8076.030876294764, 8080.515169089874, 6087.178230938766, 6104.298005729221, 6209.96895015522, 6255.31191568918, 6334.239891212899, 10031.54858031405, 10055.748606284902, 10083.546240419346, 10116.08955194036, 10132.898671013196, 10507.684769456928, 10733.463326833471, 10736.194785391282, 10787.67636970892, 10859.782804343711, 8188.385871059813, 8222.671093156207, 8239.546824924686, 8331.125231850569, 8380.95809520973, 8785.604647790993, 8830.735077947671, 8856.955715221382, 8857.911420885708, 8861.955690221508, 7888.171741967011, 7942.761717148494, 8166.877496837434, 8281.875771863306, 8351.665933362841, 7736.92263077362, 7754.651040703069, 7770.844583108194, 7819.765407037798, 7880.684772609261, 7372.59450730215, 7386.519876208029, 7465.477416581004, 7473.588952607442, 7479.70081196746, 5418.891622167455, 5616.073347897551, 5616.887662246814, 5626.212330273683, 5642.971785141048, 5371.0, 5535.114381698909, 5540.889182216414, 5595.468430499259, 5699.5725320600295], "value": 4728.218243665177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.89084329279575, 360.30101602890375, 360.8700867687632, 362.3568166504454, 363.698130551642, 5512.72436378181, 5528.7788488460465, 5556.388797232301, 5573.47052030057, 5586.636868603538, 5463.699496527689, 5481.451854814517, 5485.42185172969, 5490.890182196354, 5498.230247765316, 4233.51314598822, 4293.613574778269, 4329.913401731964, 4332.891677708067, 4354.47746270448, 4313.460817397825, 4329.783510824462, 4333.653307735373, 4336.349547567858, 4346.913061738764, 4299.978500107495, 4300.548442413548, 4303.956960430387, 4309.892252693677, 4316.633086187678, 4176.707630465853, 4303.311470164775, 4335.523092459858, 4356.237658409797, 4363.738175709467, 3851.2105018471148, 3855.3253180693546, 3863.787491687956, 3867.7679339239735, 3868.6324799144036, 5392.0, 5400.702961337125, 5424.83725488236, 5426.294581704353, 5428.864278393033, 4694.882627934295, 4941.184704523749, 4987.451380348159, 4992.251162325644, 5019.5231453012275, 5755.597108202427, 5766.682832444214, 5783.450572195635, 5785.47930686236, 5785.739641716133, 4250.298700714378, 4253.510846252659, 4254.489461264637, 4260.25445547028, 4263.147370525876, 5787.594868359217, 5999.490043346321, 6007.369226231226, 6008.098785182214, 6035.374612043775, 4352.846495678647, 4357.433533640607, 4358.6295164911335, 4359.607635312837, 4363.367311739843, 4404.7357158570585, 4414.337849322563, 4421.037904603859, 4425.291953287458, 4426.44669416323, 4815.2054910940005, 4920.975395123001, 4957.677750946177, 4972.254161875748, 4974.602031837444, 5819.214406055128, 5827.88344233113, 5831.970840145772, 5832.708364581754, 5845.532357411482, 1477.5788900163616, 1495.9027663201857, 1497.5507347795617, 1497.7528707763315, 1500.7373709600777, 974.7368210583103, 983.8278301297245, 990.7225976726528, 1047.8428235764695, 1063.2716589136467, 5601.355844077902, 5621.353544342453, 5621.381648018714, 5625.184348269478, 5643.576731745054, 5882.470577648032, 5893.5874488785375, 5908.793192238251, 5919.319278283053, 5936.970315148396, 5491.203775452537, 5578.44215578447, 5633.324001119892, 5674.914876276859, 5732.484076433141, 3174.5238214268043, 3189.0, 3201.8399080045906, 3204.276365089702, 3210.9036728898172, 5958.970205149033, 6162.907556386658, 6163.229596300463, 6173.629582225081, 6200.782972595937, 5878.412158784173, 6148.831721972811, 6159.538034647419, 6160.784372546939, 6174.228221472316, 5990.670513121733, 6055.757769689251, 6163.876722465526, 6189.566730328834, 6206.627602343783, 6005.8288633716, 6007.399260074132, 6012.218411606463, 6018.699065046642, 6037.396260373927, 5553.694546799803, 5692.260006199168, 5860.355360910211, 5961.314448838439, 5986.491148252448, 6119.296280927751, 6175.96912015455, 6203.2245969253845, 6215.720292586754, 6241.843953901189, 4202.26460369428, 4272.722273052242, 4281.122369914222, 4285.250081235834, 4303.956960430481, 5951.184888609016, 5970.194023806731, 5987.473194335416, 6000.159977603226, 6000.339962604023, 5820.206300975471, 5838.299404071538, 5854.765809367577, 5884.6469211847425, 5916.290045194604, 5639.661620302795, 5803.767849285981, 5818.592698511064, 5844.386339434468, 5875.353711091691, 5790.0, 5791.276090488689, 5815.302163740378, 5827.155062515996, 5830.2420685310635, 5555.861103472445, 5740.339860915881, 5816.098504731774, 5866.178734977021, 5869.501092407193, 5741.827745167651, 5756.769729210785, 5760.193572899713, 5763.913541296968, 5782.161586570008], "value": 4460.87553854847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.2581341218544, 749.7759633575627, 867.3364875869959, 912.8904531456225, 914.2229105260525, 17170.22733976971, 18140.99999999998, 18151.81848181518, 18155.273789048457, 18213.817861821393, 16745.581360465996, 16913.661726765487, 16914.23885925133, 16942.745858812097, 16949.152542372893, 722.6856317501877, 738.9150247721527, 848.7538613802021, 869.6999535160376, 874.0734821089634, 875.7766769473807, 885.8316919785252, 885.8848349714528, 886.2688282167205, 886.3706768194589, 942.8302905477011, 949.7435692363058, 950.3490109275134, 952.0, 952.0527075559828, 944.7354740672554, 945.394947233771, 945.7210123013728, 946.0019679238435, 946.1390134977138, 689.4932224814758, 693.5873155472536, 693.6635731670136, 693.9410150137245, 694.2606124477416, 16253.593660158473, 16403.58991025222, 16409.42567010149, 16416.917915410348, 16417.507474775775, 16254.51236462908, 16524.421645242357, 16550.089745064015, 16960.0, 17032.0, 12697.365131743376, 12759.553415630502, 12861.228326300452, 13005.60983170497, 13629.659258518517, 4068.776217308047, 4076.9184616307803, 4111.259973204822, 4184.686148538872, 4226.091390351058, 79691.6015419925, 80401.0, 80541.0, 81572.0, 81787.5910620449, 12123.878761212274, 12297.407710019985, 12479.126461147633, 12561.560345387868, 12805.551805686757, 25387.238382848544, 25433.10984115547, 25441.236762897144, 25441.74558254394, 25472.108476203244, 9318.580663870142, 9327.393719408217, 9370.156685898302, 9420.293477989178, 9871.506424678737, 4894.1679914414635, 5216.403521446033, 5331.0, 5350.732463376816, 5382.654336415896, 3722.571904230994, 3838.5777564467885, 3838.7696738195796, 3839.1745774658584, 3840.231953609289, 634.765136899341, 643.9967800161063, 647.3785166240368, 648.7178077536287, 687.4637782529635, 689.9965500172567, 749.7638243953137, 776.6194564663388, 813.2314962360513, 838.890944177253, 10756.462176891124, 10878.005449482416, 10982.945085274523, 11174.329540227613, 11363.375014374124, 768.2317682317682, 775.685847231872, 790.6995341770206, 803.6263137641025, 806.6087947345533, 5326.414094449608, 5436.565074794007, 5440.6735595864375, 5490.533304669068, 5519.69641669712, 76662.23337766662, 107888.46055769672, 109995.0, 116859.0, 139777.0, 90578.54710726404, 94102.05897941069, 113823.43088284506, 119594.0, 119822.0, 58451.4154858446, 90857.0, 92832.53583732038, 93632.0, 95216.0478395221, 10484.790304194026, 10640.52117654692, 10744.570217191225, 10789.56841726322, 10815.35107893529, 55226.72386638041, 57048.0, 57599.71200143972, 58455.12317315159, 58644.0, 75675.62162189154, 83435.5828220855, 83568.16431835604, 83728.0, 84270.0, 13545.932270338586, 13731.656708581966, 14042.087264327785, 14158.254510770063, 14433.855661443671, 14493.85506144925, 15054.172020538976, 15075.0, 15309.540713778604, 16256.756148658016, 14091.929540352232, 14255.0, 14466.349014294172, 14475.782863257271, 14660.047096938664, 12750.298733569743, 12938.288394138037, 13236.801447978096, 13541.458341666223, 14537.781933270799, 12227.266364018187, 13126.934365328112, 14587.708245835236, 14890.478833240784, 16032.038077715375, 11470.0, 11850.111241657083, 12194.756104877675, 12406.379681016093, 12456.31490268044, 12647.01923028981, 12747.362631868555, 12853.678658033625, 12895.41970611306, 12930.612081637566], "value": 8228.823472245536, "unit": "score"}], "name": "dromaeo_css", "value": 7733.456680051826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 109.0, 111.0, 111.0, 110.0, 109.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 117.0, 155.0, 123.0, 118.0, 121.0, 120.0, 151.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 160.0, 161.0, 162.0, 161.0, 160.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 101.0, 74.0, 74.0, 75.0, 74.0, 99.0, 76.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 110.0, 81.0, 82.0, 82.0, 105.0, 81.0, 81.0, 104.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 148.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 48.0, 47.0, 48.0, 48.0, 49.0, 47.0, 48.0, 48.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 73.0, 72.0, 73.0, 72.0, 72.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 128.0, 118.0, 127.0, 126.0, 119.0, 138.0, 155.0, 120.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 150.0, 150.0, 151.0, 151.0, 149.0, 149.0, 148.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1443.5999999999997, "alertThreshold": 2.0}]} 14:04:22 INFO - Return code: 0 14:04:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:04:22 INFO - # TBPL SUCCESS # 14:04:22 INFO - Running post-action listener: _resource_record_post_action 14:04:22 INFO - [mozharness: 2016-11-17 22:04:22.874588Z] Finished run-tests step (success) 14:04:22 INFO - Running post-run listener: _resource_record_post_run 14:04:22 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 332132352; Read time: 168; Write time: 182532 14:04:22 INFO - TinderboxPrint: CPU usage
12.9% 14:04:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 14:04:22 INFO - TinderboxPrint: I/O write bytes / time
332,132,352 / 182,532 14:04:22 INFO - TinderboxPrint: CPU idle
8,253.9 (87.1%) 14:04:22 INFO - TinderboxPrint: CPU user
1,179.7 (12.4%) 14:04:22 INFO - TinderboxPrint: Swap in / out
0 / 0 14:04:22 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100323328; Read time: 0; Write time: 76900 14:04:22 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 220418048; Read time: 168; Write time: 103368 14:04:23 INFO - Running post-run listener: _upload_blobber_files 14:04:23 INFO - Blob upload gear active. 14:04:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:04:23 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 14:04:23 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:04:23 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:04:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:04:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:04:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:04:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:25 INFO - (blobuploader) - INFO - Done attempting. 14:04:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:04:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:04:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:26 INFO - (blobuploader) - INFO - Done attempting. 14:04:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:04:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:04:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:29 INFO - (blobuploader) - INFO - Done attempting. 14:04:29 INFO - (blobuploader) - INFO - Iteration through files over. 14:04:29 INFO - Return code: 0 14:04:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:04:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:04:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5e01fe070fa1af319f31e1ddcb9b504c89688acad63dd2316df3779ad473de15750001e5d3e6aefedaab88bfe494087fe1f01589533df8504e6dc3d800d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9da96273bf7e71297148cf15b69933d558eeaf91c4834b610fe81b0c9d2bf331a7bdbaaac4da965213286411d699187e2d982dbef04065963f1f2dc4fef3fd86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d4e350899dcd7c8e2801dfb587ccff2a7e3b0847f1f1d5fdd500097724cb94d4527339d6ec546bee981e72a8da71c802385bc593bc0219357ae9ae8318f820b"} 14:04:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:04:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:04:29 INFO - Contents: 14:04:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5e01fe070fa1af319f31e1ddcb9b504c89688acad63dd2316df3779ad473de15750001e5d3e6aefedaab88bfe494087fe1f01589533df8504e6dc3d800d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9da96273bf7e71297148cf15b69933d558eeaf91c4834b610fe81b0c9d2bf331a7bdbaaac4da965213286411d699187e2d982dbef04065963f1f2dc4fef3fd86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d4e350899dcd7c8e2801dfb587ccff2a7e3b0847f1f1d5fdd500097724cb94d4527339d6ec546bee981e72a8da71c802385bc593bc0219357ae9ae8318f820b"} 14:04:29 INFO - Running post-run listener: copy_logs_to_upload_dir 14:04:29 INFO - Copying logs to upload dir... 14:04:29 INFO - mkdir: /builds/slave/test/build/upload/logs 14:04:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.231385 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-17 14:04:29.164431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 14:04:29.168098) ========= 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=bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403 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-Beta/sha512/a4b5e01fe070fa1af319f31e1ddcb9b504c89688acad63dd2316df3779ad473de15750001e5d3e6aefedaab88bfe494087fe1f01589533df8504e6dc3d800d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9da96273bf7e71297148cf15b69933d558eeaf91c4834b610fe81b0c9d2bf331a7bdbaaac4da965213286411d699187e2d982dbef04065963f1f2dc4fef3fd86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d4e350899dcd7c8e2801dfb587ccff2a7e3b0847f1f1d5fdd500097724cb94d4527339d6ec546bee981e72a8da71c802385bc593bc0219357ae9ae8318f820b"} build_url:https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/fzbPNiG1Ql2XsHQgDly3hg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b5e01fe070fa1af319f31e1ddcb9b504c89688acad63dd2316df3779ad473de15750001e5d3e6aefedaab88bfe494087fe1f01589533df8504e6dc3d800d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9da96273bf7e71297148cf15b69933d558eeaf91c4834b610fe81b0c9d2bf331a7bdbaaac4da965213286411d699187e2d982dbef04065963f1f2dc4fef3fd86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d4e350899dcd7c8e2801dfb587ccff2a7e3b0847f1f1d5fdd500097724cb94d4527339d6ec546bee981e72a8da71c802385bc593bc0219357ae9ae8318f820b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 14:04:29.193786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 14:04:29.194125) ========= 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=bb9b54edd4a927dc735d112f000001d9-1479418785.83951-1789811403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 14:04:29.277645) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 14:04:29.277977) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 14:04:29.278324) ========= ========= Total master_lag: 0.17 =========