builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1477671884.05 results: success (0) buildid: 20161028061559 builduid: 6da8f89c337240a7a2acc73fa7784dbf revision: 72c902038f80a707b5a492b306c635d8271a1bef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.048129) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.048634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.048916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.065386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.065808) ========= 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=0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 09:24:44-- 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% 32.5M=0s 2016-10-28 09:24:44 (32.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147521 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.227746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.228120) ========= 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=0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:44.277487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 09:24:44.277869) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 72c902038f80a707b5a492b306c635d8271a1bef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 72c902038f80a707b5a492b306c635d8271a1bef --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=0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 09:24:44,420 truncating revision to first 12 chars 2016-10-28 09:24:44,420 Setting DEBUG logging. 2016-10-28 09:24:44,420 attempt 1/10 2016-10-28 09:24:44,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/72c902038f80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 09:24:45,225 unpacking tar archive at: mozilla-aurora-72c902038f80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 09:24:45.470250) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:45.470602) ========= script_repo_revision: 72c902038f80a707b5a492b306c635d8271a1bef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:45.470984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:45.471245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:24:45.481381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-10-28 09:24:45.481746) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:24:45 INFO - MultiFileLogger online at 20161028 09:24:45 in /builds/slave/test 09:24:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:24:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:45 INFO - {'append_to_log': False, 09:24:45 INFO - 'base_work_dir': '/builds/slave/test', 09:24:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:24:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:45 INFO - 'branch': 'Mozilla-Aurora', 09:24:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:45 INFO - 'config_files': ('talos/linux_config.py',), 09:24:45 INFO - 'default_actions': ('clobber', 09:24:45 INFO - 'read-buildbot-config', 09:24:45 INFO - 'download-and-extract', 09:24:45 INFO - 'populate-webroot', 09:24:45 INFO - 'create-virtualenv', 09:24:45 INFO - 'install', 09:24:45 INFO - 'run-tests'), 09:24:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:45 INFO - 'download_minidump_stackwalk': True, 09:24:45 INFO - 'download_symbols': 'ondemand', 09:24:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:45 INFO - 'installer_path': 'installer.exe', 09:24:45 INFO - 'log_level': 'info', 09:24:45 INFO - 'log_name': 'talos', 09:24:45 INFO - 'log_to_console': True, 09:24:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:24:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:24:45 INFO - 'opt_config_files': (), 09:24:45 INFO - 'pip_index': False, 09:24:45 INFO - 'sps_profile': False, 09:24:45 INFO - 'sps_profile_interval': 0, 09:24:45 INFO - 'suite': 'dromaeojs', 09:24:45 INFO - 'system_bits': '32', 09:24:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:45 INFO - 'title': 'talos-linux64-ix-017', 09:24:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:45 INFO - 'use_talos_json': True, 09:24:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:45 INFO - 'work_dir': 'build'} 09:24:45 INFO - [mozharness: 2016-10-28 16:24:45.720323Z] Running clobber step. 09:24:45 INFO - Running pre-action listener: _resource_record_pre_action 09:24:45 INFO - Running main action method: clobber 09:24:45 INFO - rmtree: /builds/slave/test/build 09:24:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:46 INFO - Running post-action listener: _resource_record_post_action 09:24:46 INFO - [mozharness: 2016-10-28 16:24:46.681065Z] Finished clobber step (success) 09:24:46 INFO - [mozharness: 2016-10-28 16:24:46.681164Z] Running read-buildbot-config step. 09:24:46 INFO - Running pre-action listener: _resource_record_pre_action 09:24:46 INFO - Running main action method: read_buildbot_config 09:24:46 INFO - Using buildbot properties: 09:24:46 INFO - { 09:24:46 INFO - "project": "", 09:24:46 INFO - "product": "firefox", 09:24:46 INFO - "script_repo_revision": "production", 09:24:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:24:46 INFO - "repository": "", 09:24:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:24:46 INFO - "buildid": "20161028061559", 09:24:46 INFO - "pgo_build": "True", 09:24:46 INFO - "basedir": "/builds/slave/test", 09:24:46 INFO - "buildnumber": 839, 09:24:46 INFO - "slavename": "talos-linux64-ix-017", 09:24:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:24:46 INFO - "platform": "ubuntu64_hw", 09:24:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:24:46 INFO - "branch": "mozilla-aurora", 09:24:46 INFO - "repo_path": "releases/mozilla-aurora", 09:24:46 INFO - "revision": "72c902038f80a707b5a492b306c635d8271a1bef", 09:24:46 INFO - "stage_platform": "linux64-pgo", 09:24:46 INFO - "builduid": "6da8f89c337240a7a2acc73fa7784dbf", 09:24:46 INFO - "slavebuilddir": "test" 09:24:46 INFO - } 09:24:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 09:24:46 INFO - Running post-action listener: _resource_record_post_action 09:24:46 INFO - [mozharness: 2016-10-28 16:24:46.683598Z] Finished read-buildbot-config step (success) 09:24:46 INFO - [mozharness: 2016-10-28 16:24:46.683687Z] Running download-and-extract step. 09:24:46 INFO - Running pre-action listener: _resource_record_pre_action 09:24:46 INFO - Running main action method: download_and_extract 09:24:46 INFO - mkdir: /builds/slave/test/build/tests 09:24:46 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')]} 09:24:46 INFO - trying https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:24:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:24:47 INFO - Downloaded 1361 bytes. 09:24:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 09:24:47 INFO - Using the following test package requirements: 09:24:47 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:24:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:24:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:24:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'jsshell-linux-x86_64.zip'], 09:24:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:24:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 09:24:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:24:47 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:24:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:24:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 09:24:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:24:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:24:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:24:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:24:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:24:47 INFO - Expected file size: 21894229 09:24:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:24:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 09:24:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:24:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:24:52 INFO - Expected file size: 21894229 09:24:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 09:24:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:24:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:24:58 INFO - Expected file size: 14414081 09:24: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')]} 09:24:58 INFO - trying https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:24:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:24:59 INFO - Downloaded 63975094 bytes. 09:24:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:24:59 INFO - mkdir: /builds/slave/test/properties 09:24:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:59 INFO - Contents: 09:24:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 09:25:00 INFO - Running post-action listener: _resource_record_post_action 09:25:00 INFO - Running post-action listener: set_extra_try_arguments 09:25:00 INFO - [mozharness: 2016-10-28 16:25:00.381456Z] Finished download-and-extract step (success) 09:25:00 INFO - [mozharness: 2016-10-28 16:25:00.381685Z] Running populate-webroot step. 09:25:00 INFO - Running pre-action listener: _resource_record_pre_action 09:25:00 INFO - Running main action method: populate_webroot 09:25:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:00 INFO - '--tppagecycles', 09:25:00 INFO - '7'], 09:25:00 INFO - 'tests': ['tsvgm']}}, 09:25:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:25:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:25:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:25:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['damp', 'tps']}, 09:25:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'tests': ['damp', 'tps']}, 09:25:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['dromaeo_dom']}, 09:25:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['basic_compositor_video']}, 09:25:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:25:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['a11yr', 09:25:00 INFO - 'ts_paint', 09:25:00 INFO - 'tpaint', 09:25:00 INFO - 'sessionrestore', 09:25:00 INFO - 'sessionrestore_no_auto_restore', 09:25:00 INFO - 'tabpaint']}, 09:25:00 INFO - 'other-e10s': {'tests': ['a11yr', 09:25:00 INFO - 'ts_paint', 09:25:00 INFO - 'tpaint', 09:25:00 INFO - 'sessionrestore', 09:25:00 INFO - 'sessionrestore_no_auto_restore', 09:25:00 INFO - 'tabpaint']}, 09:25:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:25:00 INFO - 'ts_paint', 09:25:00 INFO - 'tpaint', 09:25:00 INFO - 'sessionrestore', 09:25:00 INFO - 'sessionrestore_no_auto_restore', 09:25:00 INFO - 'tabpaint']}, 09:25:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:25:00 INFO - 'ts_paint', 09:25:00 INFO - 'tpaint', 09:25:00 INFO - 'sessionrestore', 09:25:00 INFO - 'sessionrestore_no_auto_restore', 09:25:00 INFO - 'tabpaint']}, 09:25:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['a11yr', 09:25:00 INFO - 'ts_paint', 09:25:00 INFO - 'tpaint', 09:25:00 INFO - 'sessionrestore', 09:25:00 INFO - 'sessionrestore_no_auto_restore', 09:25:00 INFO - 'tabpaint']}, 09:25:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['a11yr', 09:25:00 INFO - 'ts_paint', 09:25:00 INFO - 'tpaint', 09:25:00 INFO - 'sessionrestore', 09:25:00 INFO - 'sessionrestore_no_auto_restore', 09:25:00 INFO - 'tabpaint']}, 09:25:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['tsvgx', 09:25:00 INFO - 'tsvgr_opacity', 09:25:00 INFO - 'tart', 09:25:00 INFO - 'tscrollx', 09:25:00 INFO - 'cart']}, 09:25:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:25:00 INFO - 'tsvgr_opacity', 09:25:00 INFO - 'tart', 09:25:00 INFO - 'tscrollx', 09:25:00 INFO - 'cart']}, 09:25:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'talos_options': ['--disable-e10s'], 09:25:00 INFO - 'tests': ['tp5o']}, 09:25:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'tests': ['tp5o']}, 09:25:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'talos_options': ['--disable-e10s', 09:25:00 INFO - '--xperf_path', 09:25:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:00 INFO - 'tests': ['tp5n']}, 09:25:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:00 INFO - 'talos_options': ['--xperf_path', 09:25:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:00 INFO - 'tests': ['tp5n']}}, 09:25:00 INFO - 'talos.zip': {'path': '', 09:25:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:00 INFO - Running post-action listener: _resource_record_post_action 09:25:00 INFO - [mozharness: 2016-10-28 16:25:00.402873Z] Finished populate-webroot step (success) 09:25:00 INFO - [mozharness: 2016-10-28 16:25:00.402961Z] Running create-virtualenv step. 09:25:00 INFO - Running pre-action listener: _resource_record_pre_action 09:25:00 INFO - Running main action method: create_virtualenv 09:25:00 INFO - Creating virtualenv /builds/slave/test/build/venv 09:25:00 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 09:25:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:25:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:00 INFO - Using real prefix '/usr' 09:25:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:25:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:02 INFO - Installing pip.................done. 09:25:02 INFO - Return code: 0 09:25:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25:02 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')]} 09:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 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')]} 09:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:02 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 09:25:02 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 09:25:02 INFO - Using env: {'DISPLAY': ':0', 09:25:02 INFO - 'HOME': '/home/cltbld', 09:25:02 INFO - 'LANG': 'en_US.UTF-8', 09:25:02 INFO - 'LANGUAGE': 'en_US:en', 09:25:02 INFO - 'LOGNAME': 'cltbld', 09:25:02 INFO - 'MAIL': '/var/mail/cltbld', 09:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:02 INFO - 'MOZ_NO_REMOTE': '1', 09:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:02 INFO - 'NO_EM_RESTART': '1', 09:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:02 INFO - 'PWD': '/builds/slave/test', 09:25:02 INFO - 'SHELL': '/bin/bash', 09:25:02 INFO - 'SHLVL': '1', 09:25:02 INFO - 'TERM': 'linux', 09:25:02 INFO - 'TMOUT': '86400', 09:25:02 INFO - 'USER': 'cltbld', 09:25:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:02 INFO - '_': '/tools/buildbot/bin/python'} 09:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:03 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 09:25:03 INFO - Cleaning up... 09:25:03 INFO - Return code: 0 09:25:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:25:03 INFO - Using env: {'DISPLAY': ':0', 09:25:03 INFO - 'HOME': '/home/cltbld', 09:25:03 INFO - 'LANG': 'en_US.UTF-8', 09:25:03 INFO - 'LANGUAGE': 'en_US:en', 09:25:03 INFO - 'LOGNAME': 'cltbld', 09:25:03 INFO - 'MAIL': '/var/mail/cltbld', 09:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:03 INFO - 'MOZ_NO_REMOTE': '1', 09:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:03 INFO - 'NO_EM_RESTART': '1', 09:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:03 INFO - 'PWD': '/builds/slave/test', 09:25:03 INFO - 'SHELL': '/bin/bash', 09:25:03 INFO - 'SHLVL': '1', 09:25:03 INFO - 'TERM': 'linux', 09:25:03 INFO - 'TMOUT': '86400', 09:25:03 INFO - 'USER': 'cltbld', 09:25:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:03 INFO - '_': '/tools/buildbot/bin/python'} 09:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:03 INFO - Downloading/unpacking psutil>=3.1.1 09:25:03 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 09:25:03 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 09:25:03 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 09:25:03 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 09:25:03 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 09:25:03 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 09:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:05 INFO - Installing collected packages: psutil 09:25:05 INFO - Running setup.py install for psutil 09:25:05 INFO - building 'psutil._psutil_linux' extension 09:25:05 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 09:25:05 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 09:25:05 INFO - building 'psutil._psutil_posix' extension 09:25:05 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 09:25:05 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 09:25:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:05 INFO - Successfully installed psutil 09:25:05 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:25:06 INFO - Using env: {'DISPLAY': ':0', 09:25:06 INFO - 'HOME': '/home/cltbld', 09:25:06 INFO - 'LANG': 'en_US.UTF-8', 09:25:06 INFO - 'LANGUAGE': 'en_US:en', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MAIL': '/var/mail/cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SHLVL': '1', 09:25:06 INFO - 'TERM': 'linux', 09:25:06 INFO - 'TMOUT': '86400', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - '_': '/tools/buildbot/bin/python'} 09:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:25:08 INFO - Installing collected packages: mozsystemmonitor 09:25:08 INFO - Running setup.py install for mozsystemmonitor 09:25:08 INFO - Successfully installed mozsystemmonitor 09:25:08 INFO - Cleaning up... 09:25:08 INFO - Return code: 0 09:25:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:25:08 INFO - Using env: {'DISPLAY': ':0', 09:25:08 INFO - 'HOME': '/home/cltbld', 09:25:08 INFO - 'LANG': 'en_US.UTF-8', 09:25:08 INFO - 'LANGUAGE': 'en_US:en', 09:25:08 INFO - 'LOGNAME': 'cltbld', 09:25:08 INFO - 'MAIL': '/var/mail/cltbld', 09:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:08 INFO - 'MOZ_NO_REMOTE': '1', 09:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:08 INFO - 'NO_EM_RESTART': '1', 09:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:08 INFO - 'PWD': '/builds/slave/test', 09:25:08 INFO - 'SHELL': '/bin/bash', 09:25:08 INFO - 'SHLVL': '1', 09:25:08 INFO - 'TERM': 'linux', 09:25:08 INFO - 'TMOUT': '86400', 09:25:08 INFO - 'USER': 'cltbld', 09:25:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:08 INFO - '_': '/tools/buildbot/bin/python'} 09:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:08 INFO - Downloading/unpacking jsonschema==2.5.1 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:25:10 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 09:25:10 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 09:25:10 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 09:25:10 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 09:25:10 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 09:25:10 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 09:25:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:10 INFO - warning: no files found matching '*.txt' 09:25:10 INFO - no previously-included directories found matching 'build' 09:25:10 INFO - no previously-included directories found matching 'dist' 09:25:10 INFO - no previously-included directories found matching '.git*' 09:25:10 INFO - Installing collected packages: jsonschema, functools32 09:25:10 INFO - Running setup.py install for functools32 09:25:10 INFO - warning: no files found matching '*.txt' 09:25:10 INFO - no previously-included directories found matching 'build' 09:25:10 INFO - no previously-included directories found matching 'dist' 09:25:10 INFO - no previously-included directories found matching '.git*' 09:25:10 INFO - Successfully installed jsonschema functools32 09:25:10 INFO - Cleaning up... 09:25:11 INFO - Return code: 0 09:25:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:25:11 INFO - Using env: {'DISPLAY': ':0', 09:25:11 INFO - 'HOME': '/home/cltbld', 09:25:11 INFO - 'LANG': 'en_US.UTF-8', 09:25:11 INFO - 'LANGUAGE': 'en_US:en', 09:25:11 INFO - 'LOGNAME': 'cltbld', 09:25:11 INFO - 'MAIL': '/var/mail/cltbld', 09:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:11 INFO - 'MOZ_NO_REMOTE': '1', 09:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:11 INFO - 'NO_EM_RESTART': '1', 09:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:11 INFO - 'PWD': '/builds/slave/test', 09:25:11 INFO - 'SHELL': '/bin/bash', 09:25:11 INFO - 'SHLVL': '1', 09:25:11 INFO - 'TERM': 'linux', 09:25:11 INFO - 'TMOUT': '86400', 09:25:11 INFO - 'USER': 'cltbld', 09:25:11 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:11 INFO - '_': '/tools/buildbot/bin/python'} 09:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:25:11 INFO - Cleaning up... 09:25:11 INFO - Return code: 0 09:25:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:25:11 INFO - Using env: {'DISPLAY': ':0', 09:25:11 INFO - 'HOME': '/home/cltbld', 09:25:11 INFO - 'LANG': 'en_US.UTF-8', 09:25:11 INFO - 'LANGUAGE': 'en_US:en', 09:25:11 INFO - 'LOGNAME': 'cltbld', 09:25:11 INFO - 'MAIL': '/var/mail/cltbld', 09:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:11 INFO - 'MOZ_NO_REMOTE': '1', 09:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:11 INFO - 'NO_EM_RESTART': '1', 09:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:11 INFO - 'PWD': '/builds/slave/test', 09:25:11 INFO - 'SHELL': '/bin/bash', 09:25:11 INFO - 'SHLVL': '1', 09:25:11 INFO - 'TERM': 'linux', 09:25:11 INFO - 'TMOUT': '86400', 09:25:11 INFO - 'USER': 'cltbld', 09:25:11 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:11 INFO - '_': '/tools/buildbot/bin/python'} 09:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 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 09:25:13 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 09:25:14 INFO - Downloading docopt-0.6.1.tar.gz 09:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:14 INFO - Running setup.py install for blobuploader 09:25:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:14 INFO - Running setup.py install for requests 09:25:14 INFO - Running setup.py install for docopt 09:25:14 INFO - Successfully installed blobuploader requests docopt 09:25:14 INFO - Cleaning up... 09:25:14 INFO - Return code: 0 09:25:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:14 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')]} 09:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:14 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')]} 09:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:14 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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:14 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 09:25:14 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 09:25:14 INFO - Using env: {'DISPLAY': ':0', 09:25:14 INFO - 'HOME': '/home/cltbld', 09:25:14 INFO - 'LANG': 'en_US.UTF-8', 09:25:14 INFO - 'LANGUAGE': 'en_US:en', 09:25:14 INFO - 'LOGNAME': 'cltbld', 09:25:14 INFO - 'MAIL': '/var/mail/cltbld', 09:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:14 INFO - 'MOZ_NO_REMOTE': '1', 09:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:14 INFO - 'NO_EM_RESTART': '1', 09:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:14 INFO - 'PWD': '/builds/slave/test', 09:25:14 INFO - 'SHELL': '/bin/bash', 09:25:14 INFO - 'SHLVL': '1', 09:25:14 INFO - 'TERM': 'linux', 09:25:14 INFO - 'TMOUT': '86400', 09:25:14 INFO - 'USER': 'cltbld', 09:25:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:14 INFO - '_': '/tools/buildbot/bin/python'} 09:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:15 INFO - Running setup.py (path:/tmp/pip-qiowkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:15 INFO - Running setup.py (path:/tmp/pip-UW_TjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:15 INFO - Running setup.py (path:/tmp/pip-MWVg04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:15 INFO - Running setup.py (path:/tmp/pip-qfRYj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:15 INFO - Running setup.py (path:/tmp/pip-aDEmoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:15 INFO - Running setup.py (path:/tmp/pip-mzPtHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:15 INFO - Running setup.py (path:/tmp/pip-2Fp27b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:15 INFO - Running setup.py (path:/tmp/pip-MdAbBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:15 INFO - Running setup.py (path:/tmp/pip-Nxl9em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:15 INFO - Running setup.py (path:/tmp/pip-sIMELx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:15 INFO - Running setup.py (path:/tmp/pip-t7aMuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:15 INFO - Running setup.py (path:/tmp/pip-t8YKYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:15 INFO - Running setup.py (path:/tmp/pip-dqAKj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:15 INFO - Running setup.py (path:/tmp/pip-F1PuZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:16 INFO - Running setup.py (path:/tmp/pip-UKDr_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:16 INFO - Running setup.py (path:/tmp/pip-W_hT12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:16 INFO - Running setup.py (path:/tmp/pip-Xksn7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:16 INFO - Running setup.py install for manifestparser 09:25:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:16 INFO - Running setup.py install for mozcrash 09:25:16 INFO - Running setup.py install for mozdebug 09:25:16 INFO - Running setup.py install for mozdevice 09:25:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:16 INFO - Running setup.py install for mozfile 09:25:16 INFO - Running setup.py install for mozhttpd 09:25:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:16 INFO - Running setup.py install for mozinfo 09:25:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:16 INFO - Running setup.py install for mozInstall 09:25:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Running setup.py install for mozleak 09:25:17 INFO - Running setup.py install for mozlog 09:25:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Running setup.py install for moznetwork 09:25:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Running setup.py install for mozprocess 09:25:17 INFO - Running setup.py install for mozprofile 09:25:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Running setup.py install for mozrunner 09:25:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Running setup.py install for mozscreenshot 09:25:17 INFO - Running setup.py install for moztest 09:25:17 INFO - Running setup.py install for mozversion 09:25:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:17 INFO - Cleaning up... 09:25:18 INFO - Return code: 0 09:25:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:18 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')]} 09:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:18 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')]} 09:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:18 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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:18 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 09:25:18 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 09:25:18 INFO - Using env: {'DISPLAY': ':0', 09:25:18 INFO - 'HOME': '/home/cltbld', 09:25:18 INFO - 'LANG': 'en_US.UTF-8', 09:25:18 INFO - 'LANGUAGE': 'en_US:en', 09:25:18 INFO - 'LOGNAME': 'cltbld', 09:25:18 INFO - 'MAIL': '/var/mail/cltbld', 09:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:18 INFO - 'MOZ_NO_REMOTE': '1', 09:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:18 INFO - 'NO_EM_RESTART': '1', 09:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:18 INFO - 'PWD': '/builds/slave/test', 09:25:18 INFO - 'SHELL': '/bin/bash', 09:25:18 INFO - 'SHLVL': '1', 09:25:18 INFO - 'TERM': 'linux', 09:25:18 INFO - 'TMOUT': '86400', 09:25:18 INFO - 'USER': 'cltbld', 09:25:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:18 INFO - '_': '/tools/buildbot/bin/python'} 09:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:18 INFO - Running setup.py (path:/tmp/pip-bIny9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:18 INFO - Running setup.py (path:/tmp/pip-bICiOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:18 INFO - Running setup.py (path:/tmp/pip-Mds3AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:18 INFO - Running setup.py (path:/tmp/pip-y6WU66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:18 INFO - Running setup.py (path:/tmp/pip-TDTqNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:18 INFO - Running setup.py (path:/tmp/pip-cTxLdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:18 INFO - Running setup.py (path:/tmp/pip-F0oCNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:18 INFO - Running setup.py (path:/tmp/pip-W8JCsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:18 INFO - Running setup.py (path:/tmp/pip-ct2ESt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:18 INFO - Running setup.py (path:/tmp/pip-8SHvyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:18 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)) 09:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:19 INFO - Running setup.py (path:/tmp/pip-8u1Fis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:19 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)) 09:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:19 INFO - Running setup.py (path:/tmp/pip-yT3Cqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:19 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)) 09:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:19 INFO - Running setup.py (path:/tmp/pip-OFQ1ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:19 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)) 09:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:19 INFO - Running setup.py (path:/tmp/pip-Sr38Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:19 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)) 09:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:19 INFO - Running setup.py (path:/tmp/pip-zkN8jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:19 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)) 09:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:19 INFO - Running setup.py (path:/tmp/pip-qGKOHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:19 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)) 09:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:19 INFO - Running setup.py (path:/tmp/pip-UNaPMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 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)) 09:25:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:21 INFO - Downloading blessings-1.6.tar.gz 09:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:21 INFO - Installing collected packages: blessings 09:25:21 INFO - Running setup.py install for blessings 09:25:21 INFO - Successfully installed blessings 09:25:21 INFO - Cleaning up... 09:25:21 INFO - Return code: 0 09:25:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:21 INFO - Reading from file tmpfile_stdout 09:25:21 INFO - Current package versions: 09:25:21 INFO - argparse == 1.2.1 09:25:21 INFO - blessings == 1.6 09:25:21 INFO - blobuploader == 1.2.4 09:25:21 INFO - docopt == 0.6.1 09:25:21 INFO - functools32 == 3.2.3-2 09:25:21 INFO - jsonschema == 2.5.1 09:25:21 INFO - manifestparser == 1.1 09:25:21 INFO - mozInstall == 1.12 09:25:21 INFO - mozcrash == 0.17 09:25:21 INFO - mozdebug == 0.1 09:25:21 INFO - mozdevice == 0.48 09:25:21 INFO - mozfile == 1.2 09:25:21 INFO - mozhttpd == 0.7 09:25:21 INFO - mozinfo == 0.9 09:25:21 INFO - mozleak == 0.1 09:25:21 INFO - mozlog == 3.4 09:25:21 INFO - moznetwork == 0.27 09:25:21 INFO - mozprocess == 0.23 09:25:21 INFO - mozprofile == 0.28 09:25:21 INFO - mozrunner == 6.12 09:25:21 INFO - mozscreenshot == 0.1 09:25:21 INFO - mozsystemmonitor == 0.3 09:25:21 INFO - moztest == 0.7 09:25:21 INFO - mozversion == 1.4 09:25:21 INFO - psutil == 3.1.1 09:25:21 INFO - requests == 1.2.3 09:25:21 INFO - wsgiref == 0.1.2 09:25:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:21 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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:21 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 09:25:21 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 09:25:21 INFO - Using env: {'DISPLAY': ':0', 09:25:21 INFO - 'HOME': '/home/cltbld', 09:25:21 INFO - 'LANG': 'en_US.UTF-8', 09:25:21 INFO - 'LANGUAGE': 'en_US:en', 09:25:21 INFO - 'LOGNAME': 'cltbld', 09:25:21 INFO - 'MAIL': '/var/mail/cltbld', 09:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:21 INFO - 'MOZ_NO_REMOTE': '1', 09:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:21 INFO - 'NO_EM_RESTART': '1', 09:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:21 INFO - 'PWD': '/builds/slave/test', 09:25:21 INFO - 'SHELL': '/bin/bash', 09:25:21 INFO - 'SHLVL': '1', 09:25:21 INFO - 'TERM': 'linux', 09:25:21 INFO - 'TMOUT': '86400', 09:25:21 INFO - 'USER': 'cltbld', 09:25:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:21 INFO - '_': '/tools/buildbot/bin/python'} 09:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 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)) 09:25:22 INFO - Cleaning up... 09:25:22 INFO - Return code: 0 09:25:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:22 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')]} 09:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:22 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')]} 09:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:22 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 0x7f2f00e40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, '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': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', '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 09:25:22 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 09:25:22 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 09:25:22 INFO - Using env: {'DISPLAY': ':0', 09:25:22 INFO - 'HOME': '/home/cltbld', 09:25:22 INFO - 'LANG': 'en_US.UTF-8', 09:25:22 INFO - 'LANGUAGE': 'en_US:en', 09:25:22 INFO - 'LOGNAME': 'cltbld', 09:25:22 INFO - 'MAIL': '/var/mail/cltbld', 09:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:22 INFO - 'MOZ_NO_REMOTE': '1', 09:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:22 INFO - 'NO_EM_RESTART': '1', 09:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:22 INFO - 'PWD': '/builds/slave/test', 09:25:22 INFO - 'SHELL': '/bin/bash', 09:25:22 INFO - 'SHLVL': '1', 09:25:22 INFO - 'TERM': 'linux', 09:25:22 INFO - 'TMOUT': '86400', 09:25:22 INFO - 'USER': 'cltbld', 09:25:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:22 INFO - '_': '/tools/buildbot/bin/python'} 09:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:22 INFO - Cleaning up... 09:25:22 INFO - Return code: 0 09:25:22 INFO - Running post-action listener: _resource_record_post_action 09:25:22 INFO - Running post-action listener: _start_resource_monitoring 09:25:22 INFO - Starting resource monitoring. 09:25:22 INFO - [mozharness: 2016-10-28 16:25:22.393823Z] Finished create-virtualenv step (success) 09:25:22 INFO - [mozharness: 2016-10-28 16:25:22.394369Z] Running install step. 09:25:22 INFO - Running pre-action listener: _resource_record_pre_action 09:25:22 INFO - Running main action method: install 09:25:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:22 INFO - Reading from file tmpfile_stdout 09:25:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:22 INFO - Reading from file tmpfile_stdout 09:25:22 INFO - Output received: 09:25:22 INFO - Usage: mozinstall [options] installer 09:25:22 INFO - Options: 09:25:22 INFO - -h, --help show this help message and exit 09:25:22 INFO - -d DEST, --destination=DEST 09:25:22 INFO - Directory to install application into. [default: 09:25:22 INFO - "/builds/slave/test"] 09:25:22 INFO - --app=APP Application being installed. [default: firefox] 09:25:22 INFO - mkdir: /builds/slave/test/build/application 09:25:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:25:38 INFO - Reading from file tmpfile_stdout 09:25:38 INFO - Output received: 09:25:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:25:38 INFO - Running post-action listener: _resource_record_post_action 09:25:38 INFO - [mozharness: 2016-10-28 16:25:38.676548Z] Finished install step (success) 09:25:38 INFO - [mozharness: 2016-10-28 16:25:38.676791Z] Running run-tests step. 09:25:38 INFO - Running pre-action listener: _resource_record_pre_action 09:25:38 INFO - Running main action method: run_tests 09:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:38 INFO - Python 2.7.3 09:25:38 INFO - Return code: 0 09:25:38 INFO - grabbing minidump binary from tooltool 09:25:38 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')]} 09:25:38 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 0x1dd0f60>, '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 0x1dd1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:38 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 09:25:38 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 09:25:38 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 09:25:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:38 INFO - Return code: 0 09:25:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:25:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:25:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 09:25:38 INFO - Using env: {'DISPLAY': ':0', 09:25:38 INFO - 'HOME': '/home/cltbld', 09:25:38 INFO - 'LANG': 'en_US.UTF-8', 09:25:38 INFO - 'LANGUAGE': 'en_US:en', 09:25:38 INFO - 'LOGNAME': 'cltbld', 09:25:38 INFO - 'MAIL': '/var/mail/cltbld', 09:25:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:38 INFO - 'MOZ_NO_REMOTE': '1', 09:25:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:38 INFO - 'NO_EM_RESTART': '1', 09:25:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:38 INFO - 'PWD': '/builds/slave/test', 09:25:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:38 INFO - 'SHELL': '/bin/bash', 09:25:38 INFO - 'SHLVL': '1', 09:25:38 INFO - 'TERM': 'linux', 09:25:38 INFO - 'TMOUT': '86400', 09:25:38 INFO - 'USER': 'cltbld', 09:25:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743', 09:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:38 INFO - '_': '/tools/buildbot/bin/python'} 09:25:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:25:38 INFO - mozversion application_buildid: 20161028061559 09:25:38 INFO - mozversion application_changeset: 72c902038f80a707b5a492b306c635d8271a1bef 09:25:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:25:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:38 INFO - mozversion application_name: Firefox 09:25:38 INFO - mozversion application_remotingname: firefox-dev 09:25:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:25:38 INFO - mozversion application_vendor: Mozilla 09:25:38 INFO - mozversion application_version: 51.0a2 09:25:38 INFO - mozversion platform_buildid: 20161028061559 09:25:38 INFO - mozversion platform_changeset: 72c902038f80a707b5a492b306c635d8271a1bef 09:25:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:25:38 INFO - mozversion platform_version: 51.0a2 09:25:38 INFO - using testdate: 1477671938 09:25:38 INFO - actual date: 1477671938 09:25:38 INFO - starting webserver on 'localhost:60885' 09:25:38 INFO - SUITE-START | Running 2 tests 09:25:38 INFO - TEST-START | dromaeo_css 09:25:38 INFO - operating with platform_type : linux_ 09:25:38 INFO - Initialising browser for dromaeo_css test... 09:25:39 INFO - TEST-INFO | started process 12634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_gRus/profile http://localhost:60885/getInfo.html) 09:25:42 INFO - PROCESS | 12634 | __metrics Screen width/height:1600/1200 09:25:42 INFO - PROCESS | 12634 | colorDepth:24 09:25:42 INFO - PROCESS | 12634 | Browser inner width/height: 1024/697 09:25:42 INFO - PROCESS | 12634 | __metrics 09:25:43 INFO - PROCESS | 12634 | 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" 09:25:43 INFO - PROCESS | 12634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:43 INFO - PROCESS | 12634 | console.error: PushService: 09:25:43 INFO - PROCESS | 12634 | stateChangeProcessEnqueue: Error transitioning state 09:25:43 INFO - PROCESS | 12634 | UnknownError 09:25:43 INFO - TEST-INFO | 12634: exit 0 09:25:43 INFO - Browser initialized. 09:25:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:43 INFO - TEST-INFO | started process 12727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_gRus/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:55 INFO - PROCESS | 12727 | RSS: Main: 144781312 09:25:55 INFO - PROCESS | 12727 | 09:26:47 INFO - PROCESS | 12727 | 1477672007012 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] 09:28:56 INFO - PROCESS | 12727 | Cycle 1(1): loaded http://localhost:60885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60885/tests/dromaeo/cssquery-ext.html) 09:28:57 INFO - PROCESS | 12727 | RSS: Main: 238706688 09:28:57 INFO - PROCESS | 12727 | 09:31:59 INFO - PROCESS | 12727 | Cycle 1(1): loaded http://localhost:60885/tests/dromaeo/cssquery-ext.html (next: http://localhost:60885/tests/dromaeo/cssquery-jquery.html) 09:32:00 INFO - PROCESS | 12727 | RSS: Main: 233414656 09:32:00 INFO - PROCESS | 12727 | 09:35:02 INFO - PROCESS | 12727 | Cycle 1(1): loaded http://localhost:60885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60885/tests/dromaeo/cssquery-mootools.html) 09:35:02 INFO - PROCESS | 12727 | RSS: Main: 232644608 09:35:02 INFO - PROCESS | 12727 | 09:38:04 INFO - PROCESS | 12727 | Cycle 1(1): loaded http://localhost:60885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60885/tests/dromaeo/cssquery-prototype.html) 09:38:05 INFO - PROCESS | 12727 | RSS: Main: 217378816 09:38:05 INFO - PROCESS | 12727 | 09:41:07 INFO - PROCESS | 12727 | Cycle 1(1): loaded http://localhost:60885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60885/tests/dromaeo/cssquery-yui.html) 09:41:08 INFO - PROCESS | 12727 | RSS: Main: 177254400 09:41:08 INFO - PROCESS | 12727 | 09:44:10 INFO - PROCESS | 12727 | Cycle 1(1): loaded http://localhost:60885/tests/dromaeo/cssquery-yui.html (next: http://localhost:60885/tests/dromaeo/cssquery-dojo.html) 09:44:11 INFO - PROCESS | 12727 | RSS: Main: 260911104 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | __start_tp_report 09:44:11 INFO - PROCESS | 12727 | _x_x_mozilla_page_load 09:44:11 INFO - PROCESS | 12727 | _x_x_mozilla_page_load_details 09:44:11 INFO - PROCESS | 12727 | |i|pagename|runs| 09:44:11 INFO - PROCESS | 12727 | |0;dojo.html;3156.51074083517;3188.681131886811;3195.456772348702;3223.306988997365;3237.9838100809507;5595.132754423066;5686.260786097807;5704.1443783432405;5711.171880077386;5715.599908006441;5667.149927510865;5717.828465146042;5722.055860782966;5723.399043100477;5770.567207459437;5142.845714628558;5161.303224064741;5174.715390653512;5202.531772140506;5243.947560524384;5114.667546609458;5133.3326667533165;5256.8160114396005;5260.079486089938;5295.947040529584;5074.264231686403;5140.511651393112;5154.252633368159;5160.948390516103;5185.118529849935;5148.3564554430695;5172.741362931838;5176.7929282828645;5241.633085684004;5252.159654455307;5095.108356037678;5141.228815677641;5209.374875015023;5223.555997740159;5244.5279924806955;5477.835664930059;5488.91766623501;5515.310586176728;5526.917096243559;5530.364008139075;5997.610155339932;6004.189434426384;6021.729022194012;6095.9695201524155;6096.207493025879;6097.756089756404;6108.694565271719;6108.877822443526;6111.572189946705;6113.44978951892;5490.56075513958;5541.5289700375515;5586.692731899784;5616.438356164351;5657.094864821609;6191.628502289877;6219.689015549205;6224.315325314212;6225.315215326311;6260.467860231931;5965.433283838029;5988.670623115683;5992.880142397127;5996.730147143389;5999.100134979788;5902.114682797529;5948.2862056553495;5953.107033944856;5969.04495280753;6003.339632640406;6019.6990150493175;6023.156758053876;6028.457438830526;6032.849178770478;6051.878962420727;5964.791232306935;6030.03519436888;6030.155778191057;6039.939600604026;6051.546134039964;4552.135094332067;4597.057603191338;4611.423572053493;4656.883577910512;4660.39414876064;4157.355609880473;4159.313713237342;4177.415161877339;4177.456930599003;4196.076863090116;5780.5953583248765;5817.7091145442555;5826.4464875837575;5828.504577110908;5832.1834943108;5946.85132871673;6005.099235114768;6018.15745795589;6157.291911430243;6159.969200153971;5737.3975732548315;5800.680962547016;5801.622894511843;5835.766569337179;5844.357120716718;5254.264402983586;5257.710825904535;5267.26258323835;5267.394249661338;5273.2617433559335;5997.730102145327;6176.35148309421;6251.062340648939;6290.276618188876;6296.433321001132;5933.317668468181;6042.697865106639;6102.389761023862;6110.7555697771595;6152.630842149485;6291.402316779899;6291.496680265659;6294.3076261612105;6302.432781049728;6303.306636269915;5975.55183361241;6013.248343957005;6023.277206735044;6030.939690603038;6031.819045428644;5873.353931067493;5995.880082398415;6041.395860413923;6065.60573562717;6083.908741368971;6019.097135429721;6020.548458865515;6022.427869352405;6026.306974697965;6035.064564992434;6009.819705408845;6010.429009244115;6012.1582978382185;6016.398360163948;6017.849553761191;5735.971320143372;5846.181534585076;5875.089361149029;5935.792247271324;5976.820695379146;6036.939630603813;6041.2750469943885;6041.486473649789;6047.395260473917;6076.361981992004;5670.773169073191;5832.679202643895;5889.94110058894;5892.499137573354;5894.145348924296 09:44:11 INFO - PROCESS | 12727 | |1;ext.html;591.9615225010374;614.8339948213983;627.4603840697;649.779075114461;665.1818263535848;35992;39671;48766.293179738714;49670;49786;51445.74277128609;51881.740591297086;51887.740561297236;51933.74033129839;51974.22038669423;8612.267957223643;9371.250299976002;9518;9528.047195280451;9534.04659534048;8521.14788521146;11191;11439.084873210164;11454.396384506175;11876.762464750744;11665.708357291092;11709.94145029278;11722;11725.530978760882;11728.7654246915;11431.714207144805;11481.942590287079;11502.654920352361;11505.309681419058;11508.884911150864;11241.381724005176;11299.03958163557;11303.474031005873;11304.773904521946;11313.886861131366;47545;47800.7609961948;47854.521454785354;47928.52071479276;47986.76006619979;3895.9220815583813;3933.1936952924866;4578.404807375054;4677.064587082563;4707.8587642370785;35723.4641480378;36033.81983090094;36078.09804754876;36175.27649447023;37900.81049594734;4157.48031496063;4182.435371224907;4182.686298527623;4196.160767846412;4206.113537117904;392271;393040;395409;396657.9999999971;397250;40593;41377;67802.3219767796;68295;68430.65784671044;43010.56989430128;43431.56568434338;43464.348034779505;43470;43502.34746478805;16697.415590454275;16834.158292085347;16859.57851053709;16859.83140168607;16881.493555193363;12520.68698282532;12780.61658150257;12797.424115914806;14037.438502459992;14106.576802695936;9481.383710058824;9736.513174341255;9784.119429251401;9802.264830137769;9829.705108846745;3649.50731651229;3687.11509237781;3727.2172843703124;3733.0667333166707;3757.248550289953;1099.3623698254994;1126.8843844593794;1176.517627772609;1204.265398107154;1248.051480874542;36092.375843087124;36754;36816.26367472635;36993.63006369956;37024;1165.3998190931677;1186.5609724402027;1194.0686264713538;1253.5048655780915;1322.9098025120286;18398.724019139725;19335.709964350546;19518;19664.508387290145;19682.114304856317;637268;638007;640634;642073;644398;68528;69194.30805691879;69210.65394672994;69270.65364673144;69452.652736736;1331.9866801332057;1384.4738999180247;1413.7808639661075;1439.1077531930061;1449.1956963884934;32497;37038;37228.25543489061;37640.43539346967;37661.435078473296;57161;57964.710176450535;58046.83906321765;58071;58126.41873581379;452297;453492;453906;454588;455891;32120.839395802872;32263.193420164684;32403.837980809945;34792;35011;54725.179122313995;54928;55204.723976379864;55221.44778552163;55469.722651388096;45228.77385613051;46977.76511117422;47328;47500.52499474961;48542;45028;45669;47480.2877956824;47577;48438.03123937572;46146;46505.53494465012;46589.76705116453;47066.76466617645;47329.76335118302;39138.60861391349;40934.1813163741;41120.79439602783;41233.38149927693;42117;30262.54606180865;30731.539026914168;30813.691863081083;31013.379732404774;31131.68868311288 09:44:11 INFO - PROCESS | 12727 | |2;jquery.html;395.6458969222548;424.9043965107849;426.6970450979804;434.5806296923468;444.1982222089128;16200.270987805548;19615.901920490396;21846.781532184672;22097.889510552464;22286.442838929033;19591.118399672014;20149.899250503764;20202.89898550509;20959.161633534677;21048.26331078409;5420.512153906147;5446.428125046863;5635.042042852725;5635.239242702244;5636.633618814784;5439.755211015494;5540.556755459574;5548.306461692288;5548.334199896018;5559.388467268597;5565.30433695788;5566.165075238727;5566.916496252559;5568.1647752837;5899.911501327483;6094.268687757475;6280.968595157041;6281.120643109968;6285.717142728588;6290.3709629037185;5945.286565612111;6099.420555047308;6120.265568131808;6155.199824022849;6162.938370616282;15337.846621533754;15572.844271557253;15774.276379549865;24965.375865603324;25273.115440959664;2489.4772097859473;2623.147477069941;2847.686754457008;3184.8885289014775;3249.788763730374;11069.667909962714;11094.500747466383;11340.206185567014;11454.312741235553;11887;1969.6257711035;2050.5693804301113;2063.484128967758;2097.4336929029228;2103.4741314671332;89727.55136224277;90419.54790226006;92143;93473;94567;9837.655682051238;10526.368417894797;10597.894021059845;10772.461376931122;11018.834717479243;16248.187590620659;16266.18669066542;16870;16875.57811054709;17778.199981000886;8632.741017769476;8832.470051796912;8987.730368088967;9017.819643607223;9027.909720902708;8443.57782110892;8489.660413583388;8490.745277641681;8666.56667166639;8736.737897863075;5044.369453818273;5202.401723801736;5245;5267.947320526822;5407.594430417735;2144;2165;2176.238316589213;2183.9563208735735;2188.081005977493;926.1849572376266;983.2822039910905;987.4470296633908;994.4933425859828;1020.9081182693593;20971;21032.158713651283;21305.467363316042;21429.892850535958;21488.78511214899;1057.582255009267;1062.8565143705655;1072.286929192094;1086.8261078227604;1116.7152376144031;10948.34309941406;11653.009494192918;11708.590199342982;11738;11942.164048516694;483506;485228;493182;509136;511392;100054.4997275009;100344;102336;102723.48638256761;104662.43006354911;998.5406712912142;1030.8659874216303;1041.8437234414898;1043.1498328861953;1050.726811029138;18472.630547389246;18518.44444666662;18872.811271887105;19215.90392048031;19318.03409829531;43577.78211108924;44534.55465445304;45595.31607025831;45601.77199114116;46687;62371.376286236555;63358.366416335244;63375;63977;64545.67727161334;9358;9361.344705870524;9432.575534101119;9479.146876781122;9591.040895910353;9594.42433453995;12935.741285174432;14312.284385780878;14335.56993290203;14358.138511689333;11933.82099268529;11999.220050696676;12192.75614487723;12541.93729031349;12728.645200637911;12608.495660173858;12782.68043298925;12894.742105158031;12941.935290323489;12978.675533111747;12042.939785301018;12541.372931353579;12741.617751467471;12857.164284321489;13086;9448.244140468883;9547.570359333708;9650.131488166098;9885.258605604753;9929.950350248491;12156.939215303866;12175.573854915036;12566.748665026831;12881.742365152457;13024.218546887218 09:44:11 INFO - PROCESS | 12727 | |3;mootools.html;1437.3388241408952;1521.155758554002;1586.5478338673477;1728.3000384844142;1865.0954287170712;8637.956810215948;9290.21033212177;9305.720828375159;9756;9779.217662586994;9788.755281117976;9850.310478266525;9859.802803943916;9863.408195508275;9868.802623947517;2565.923022309329;2586.301698541393;2590.922272331833;2597.091018143644;2606.752358525937;2465.211132437612;2570.485902819434;2573.6396904433395;2579.5227882841737;2580.006697421497;2517.3832411059225;2548.6559314492492;2583.186296316654;2583.186296316654;2583.354161459635;2524.9747502524924;2532.556802559554;2536.251805717318;2544.465662210938;2556.437583731576;2492.470661543259;2514.7485251474704;2517.735637758027;2519.3323769201174;2523.772860442569;9753.609855605839;9753.756156096084;9829.164521015722;9830.311878168532;9832.065953734384;5619.550435965113;5785.045467497858;5801.129830525413;5874.706264686749;5877.647341159502;3689.7786132832116;3713.1459764254105;3746.119661879456;3755.6244375562223;3764.3036038333;1144.822552504363;1170.2627344772739;1172.7725776128784;1186.3356520348545;1199.4602428907026;13396.79904801419;13410.12834165776;13434.596962091153;13452.125611835101;13452.461901523928;4846.5153484651955;4903.730294833818;4972.453030166679;5027.371578552681;5040.54635082837;10536.789264214825;10619.787604247871;10621.150307975344;10658.89341106579;10663.520141593646;5689.743961521742;5699.658020518782;5713.800016999385;5720.084786434234;5731.770729170787;4541.0016129511405;4828.903421931542;4915.827946021872;4931.334269873521;5360.303160589098;4104.91790164195;4171;4257.40396344512;4264.658827293809;4284.357346398066;1240.057556257233;1240.3116270469795;1244.4524409259898;1249.9437525311382;1251.7809383357876;1009.6314845081639;1017.2878984710732;1040.458961340114;1044.1698849414734;1045.2004216774174;6152.107944348134;6468.708908099053;6514.5114116441455;6611.702473388709;6679.599224046573;490.6884128578307;499.0692358750903;502.18645793814255;506.73902939985936;518.5669965578784;4278.935815962701;4409.0520538084465;4418.028033832552;4453.576910193527;4466.9106617867465;11876.821847672292;12218.144729868824;12323.322217277957;12360.938195308965;12364.876351236373;11750.177487575787;12196.51213951432;12231.449584768707;12263.811409033715;12272.693182670504;9098.954505227432;9286.535673216313;9302;9306.208972237435;9314.48770317639;6566.967165164335;6693.933060669331;6749.831254218684;6807.183138023469;6871.14110736158;10846.566137354417;11132.610358637408;11417.029552488131;11447.313161210353;11557.075433965094;10001.699949001542;10224.437655928697;11569.363684997406;11575.652730418102;11703.414829258674;8311.95844020776;8579.828403431771;8644.82710345777;8651.6106775194;8654.740357789276;9264.861027084464;9295.86056209171;9324.020977797234;9335.159835614828;9348.1119293667;8591.957040214758;8691;8699.13008699125;8783.385163038525;8847.380683352103;8371.330293576377;8408.36937229698;8422.284105850826;8447.8732819009;8543.871841922251;7676.6161691916295;7728.8454230916195;7838.686452542062;7892.1318654949055;7924.881126783218;5547.916781248366;5554.416786237387;5664;5695.743691533974;5843.474087331991;5535.612507124462;5660.349059858005;5676.347220069745;5722.141678748221;5768.365479797135 09:44:11 INFO - PROCESS | 12727 | |4;prototype.html;352.66144501278774;356.4297124600639;362.7406404420839;369.93341198584244;371.3482837619975;5480.945190548098;5508.862278443041;5537.335519737632;5541.833744987657;5542.722863856801;5148.279240906267;5295.735213239342;5299;5301.7084060376765;5463.426340234268;4160.479940007499;4204.852830150945;4218.692205416315;4283.764392958386;4327.588879056485;4284.357346398034;4297.205017071836;4297.462817147856;4303.677224208197;4305.569443055685;4135.73117747347;4285.485741710999;4288.721233119837;4296.2385421977;4319.719218250803;4278.101598664284;4286.699931004831;4291.678124140702;4291.871243862689;4299.871003869889;3821.464994900716;3833.8274777635074;3834.2714884172196;3839;3845.8653947111716;5162.380514338303;5195.621843620397;5279.472052794728;5294.285271488377;5307.681539107666;4895.730734809584;4908.803647854082;4918.409790825088;4922.360093187898;4923.18767403378;5637.46444087811;5644.717764111819;5670.801521946753;5675.716214189274;5677.687727175004;4096.631303182728;4163.937540936889;4191.371294305848;4200.537940826506;4205.285101532747;5887.911681324784;5896.616719913192;5905.616134951214;5905.675187864623;5911.733971971272;4309.396684464177;4309.461317335333;4309.827606895689;4316.266234740102;4327.805248763813;4303.311470164758;4359.869203923888;4379.627731642782;4414.80133393998;4418.138462999685;4917.680350777188;4920.704757714549;4929.457759646436;4940.752962351868;4941.407031156213;5713.942860571424;5716.28546431696;5723.341815691166;5726.685032323179;5742.28221472316;1457.5554455890842;1501.924903754808;1504.353128154904;1511.1084460168554;1522.1856306875768;972.9464879431699;977.9340518834363;991.8413053911339;997.6159178716247;1001.2140469731372;4854;4874.731889746098;4877.219644856806;4885.7312847793;4903.656744027955;5156.484351564888;5161.922571161435;5167.509086636764;5189.221616757516;5192.402873669501;4882.414110306786;4894.423713827583;4908.263760435963;4918.975405122951;5166.793328266903;3077.86149623263;3087.274490494732;3092.567040614316;3095.4892442746695;3119.937601248008;5981.222441082718;6008.3390827009;6025.487833534111;6040.697965101727;6092.715231788079;5689.118186681071;5930.733117009745;6028.909566356509;6029.8191054268445;6034.969825150846;6064.4541991221;6068.939310606837;6080.48315893154;6081.665508397081;6128;5617.466340697627;5878.588498805043;5922.170896074639;5925.348211696623;5932.228810254639;5839.883202336015;5846.707664616837;5851.795187168429;5855.795047173328;5859.388668116302;6060.666663333559;6082.787102451393;6084.14821924922;6091;6100.267967843887;4035.616616421435;4083.6733061354425;4261.424707664426;4287.920358626002;4292.7424354538825;5728.2242504823635;5743.712814359349;5892.381299963614;5900.173975643327;5906.228131560601;5748.074395077529;5769.769209231584;5780.479756821906;5780.624259423124;5800.970995144998;5598.468145526169;5635.690037048002;5693.089105743227;5707.828765137053;5795.565332600157;5722.655176033712;5734.168545560954;5736.4550367715;5756.568257380797;5765.019946609003;5602.7139238483405;5784.248047753765;5792.594518383841;5796.464156864394;5803.970980145073;5615.719214039364;5654.236678048575;5664.405237450173;5666.433356664301;5668.546516278605 09:44:11 INFO - PROCESS | 12727 | |5;yui.html;821.4660470694048;824.8493351774273;826.3182874128842;831.3183189784379;902.6028547439122;15520.379184832607;17759.733603995934;17964.55088622785;17968.820311796877;17970.37103701371;16197.676046479064;16255.51233462995;16272.83727162728;16391.34434622614;16406.933549319318;731.689032161332;743.434989408051;850.1753299299685;860.492309537376;882.298572634757;880.1638443478721;883.7172104926426;884.2218847414266;884.703624285865;885.1812073831712;753.6872198037807;932.7201839448172;933.0762545080355;933.761890717866;934.1965909317981;755.448522578518;874.1739056591524;897.8742975983367;901.4230892228978;905.3662436294554;663.9535232533725;663.9634820084893;664.3058004385429;664.5381459885382;665.1021121485956;16222.756658650129;16241.59396015109;16255.431059912964;16285.185740712917;16293.91853040739;14682;14688.485902993343;14888.255587220703;14945.17801520916;15091.547253582301;13942.93028534861;14147.929260353632;14163.15021098727;14283.285835708173;14485.637859053502;4655.441347038377;4670.766461676936;4704.717716936994;4916.139675556799;4937.1606826839525;87949.56025219896;88960;89169;92806;92852.53573732155;11778.293302401884;11980.760384792255;12032.75934481323;12069.396530173632;12115.878841211652;22311.553768924856;22538.436539086328;22610.98250578728;22620.886895565745;22628.434289142904;8937.374383793072;9027;9101.772455688528;9129.95435022834;9208.677696280598;5093.363329583802;5206.55744261742;5246.160614301693;5263.526282634504;5279.604029697788;3934.626210509997;4086.6117718816663;4117.91764164715;4121.91756164875;4122.464079669624;682.7269092362995;683.6137582266003;686.0292685849467;693.7883945396702;697.5779653309776;695.4262733244992;698.2877464985686;772.3126417488439;779.2363483785808;788.6529926832176;9464.47945362998;9673.322867399214;9834.508274586386;9992;10157;727.9344858962719;728.5956294256632;817.5666896544841;817.791463176898;839.1734141870253;4845.41854977405;4976.477469865685;5013.573846223039;5028.220625803006;5050.898982020412;126794;127632;129125;133643;134521.32739336242;87799;92172.53913730389;114068.42965785119;117999.41000294943;118209.40895295469;89388.5530572356;92103.53948230216;95807.9999999986;96990.51504742431;98231;9623.903760962301;9641;9887.209023277977;9925.801483970135;10051.798964020825;50896.23655645242;51380.22929655983;52444.47555524396;53889.73055134699;53901.19148212858;71948;73342;83033.16966830497;83952;85359;12720.236785792882;12831.652676468837;12917.483300667867;13101.934490327487;13423.463061477432;14246.430142794587;14523.128612283297;14748.705025899208;14823.851761482678;15473.922630386776;13900.860991389956;14200.857991419953;14854.628634284229;15127;15161.62095947566;14368.425262989782;14369.353379098175;14401.711965760416;14769.92615036918;14779.704405911607;13393.531226407029;13704;13997.091643221955;14074.718505630035;14672.633184170481;11531.425258169995;11668.501492655858;11915.582954596548;12098.818517722066;12230.938845305716;10404.791904162026;11662.53349865996;12341.197822141532;12546.435410406371;12970.416331265304 09:44:11 INFO - PROCESS | 12727 | __end_tp_report 09:44:11 INFO - PROCESS | 12727 | __start_cc_report 09:44:11 INFO - PROCESS | 12727 | _x_x_mozilla_cycle_collect,849 09:44:11 INFO - PROCESS | 12727 | __end_cc_report 09:44:11 INFO - PROCESS | 12727 | __startTimestamp1477673051221__endTimestamp 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | ------- Summary: start ------- 09:44:11 INFO - PROCESS | 12727 | Number of tests: 6 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | [#0] dojo.html Cycles:165 Average:5639.61 Median:5892.50 stddev:645.63 (11.0%) stddev-sans-first:617.53 09:44:11 INFO - PROCESS | 12727 | Values: 3156.5 3188.7 3195.5 3223.3 3238.0 5595.1 5686.3 5704.1 5711.2 5715.6 5667.1 5717.8 5722.1 5723.4 5770.6 5142.8 5161.3 5174.7 5202.5 5243.9 5114.7 5133.3 5256.8 5260.1 5295.9 5074.3 5140.5 5154.3 5160.9 5185.1 5148.4 5172.7 5176.8 5241.6 5252.2 5095.1 5141.2 5209.4 5223.6 5244.5 5477.8 5488.9 5515.3 5526.9 5530.4 5997.6 6004.2 6021.7 6096.0 6096.2 6097.8 6108.7 6108.9 6111.6 6113.4 5490.6 5541.5 5586.7 5616.4 5657.1 6191.6 6219.7 6224.3 6225.3 6260.5 5965.4 5988.7 5992.9 5996.7 5999.1 5902.1 5948.3 5953.1 5969.0 6003.3 6019.7 6023.2 6028.5 6032.8 6051.9 5964.8 6030.0 6030.2 6039.9 6051.5 4552.1 4597.1 4611.4 4656.9 4660.4 4157.4 4159.3 4177.4 4177.5 4196.1 5780.6 5817.7 5826.4 5828.5 5832.2 5946.9 6005.1 6018.2 6157.3 6160.0 5737.4 5800.7 5801.6 5835.8 5844.4 5254.3 5257.7 5267.3 5267.4 5273.3 5997.7 6176.4 6251.1 6290.3 6296.4 5933.3 6042.7 6102.4 6110.8 6152.6 6291.4 6291.5 6294.3 6302.4 6303.3 5975.6 6013.2 6023.3 6030.9 6031.8 5873.4 5995.9 6041.4 6065.6 6083.9 6019.1 6020.5 6022.4 6026.3 6035.1 6009.8 6010.4 6012.2 6016.4 6017.8 5736.0 5846.2 5875.1 5935.8 5976.8 6036.9 6041.3 6041.5 6047.4 6076.4 5670.8 5832.7 5889.9 5892.5 5894.1 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | [#1] ext.html Cycles:180 Average:66732.92 Median:41027.49 stddev:134897.21 (328.8%) stddev-sans-first:135184.23 09:44:11 INFO - PROCESS | 12727 | Values: 592.0 614.8 627.5 649.8 665.2 35992.0 39671.0 48766.3 49670.0 49786.0 51445.7 51881.7 51887.7 51933.7 51974.2 8612.3 9371.3 9518.0 9528.0 9534.0 8521.1 11191.0 11439.1 11454.4 11876.8 11665.7 11709.9 11722.0 11725.5 11728.8 11431.7 11481.9 11502.7 11505.3 11508.9 11241.4 11299.0 11303.5 11304.8 11313.9 47545.0 47800.8 47854.5 47928.5 47986.8 3895.9 3933.2 4578.4 4677.1 4707.9 35723.5 36033.8 36078.1 36175.3 37900.8 4157.5 4182.4 4182.7 4196.2 4206.1 392271.0 393040.0 395409.0 396658.0 397250.0 40593.0 41377.0 67802.3 68295.0 68430.7 43010.6 43431.6 43464.3 43470.0 43502.3 16697.4 16834.2 16859.6 16859.8 16881.5 12520.7 12780.6 12797.4 14037.4 14106.6 9481.4 9736.5 9784.1 9802.3 9829.7 3649.5 3687.1 3727.2 3733.1 3757.2 1099.4 1126.9 1176.5 1204.3 1248.1 36092.4 36754.0 36816.3 36993.6 37024.0 1165.4 1186.6 1194.1 1253.5 1322.9 18398.7 19335.7 19518.0 19664.5 19682.1 637268.0 638007.0 640634.0 642073.0 644398.0 68528.0 69194.3 69210.7 69270.7 69452.7 1332.0 1384.5 1413.8 1439.1 1449.2 32497.0 37038.0 37228.3 37640.4 37661.4 57161.0 57964.7 58046.8 58071.0 58126.4 452297.0 453492.0 453906.0 454588.0 455891.0 32120.8 32263.2 32403.8 34792.0 35011.0 54725.2 54928.0 55204.7 55221.4 55469.7 45228.8 46977.8 47328.0 47500.5 48542.0 45028.0 45669.0 47480.3 47577.0 48438.0 46146.0 46505.5 46589.8 47066.8 47329.8 39138.6 40934.2 41120.8 41233.4 42117.0 30262.5 30731.5 30813.7 31013.4 31131.7 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | [#2] jquery.html Cycles:180 Average:30413.95 Median:12387.96 stddev:82281.38 (664.2%) stddev-sans-first:82481.33 09:44:11 INFO - PROCESS | 12727 | Values: 395.6 424.9 426.7 434.6 444.2 16200.3 19615.9 21846.8 22097.9 22286.4 19591.1 20149.9 20202.9 20959.2 21048.3 5420.5 5446.4 5635.0 5635.2 5636.6 5439.8 5540.6 5548.3 5548.3 5559.4 5565.3 5566.2 5566.9 5568.2 5899.9 6094.3 6281.0 6281.1 6285.7 6290.4 5945.3 6099.4 6120.3 6155.2 6162.9 15337.8 15572.8 15774.3 24965.4 25273.1 2489.5 2623.1 2847.7 3184.9 3249.8 11069.7 11094.5 11340.2 11454.3 11887.0 1969.6 2050.6 2063.5 2097.4 2103.5 89727.6 90419.5 92143.0 93473.0 94567.0 9837.7 10526.4 10597.9 10772.5 11018.8 16248.2 16266.2 16870.0 16875.6 17778.2 8632.7 8832.5 8987.7 9017.8 9027.9 8443.6 8489.7 8490.7 8666.6 8736.7 5044.4 5202.4 5245.0 5267.9 5407.6 2144.0 2165.0 2176.2 2184.0 2188.1 926.2 983.3 987.4 994.5 1020.9 20971.0 21032.2 21305.5 21429.9 21488.8 1057.6 1062.9 1072.3 1086.8 1116.7 10948.3 11653.0 11708.6 11738.0 11942.2 483506.0 485228.0 493182.0 509136.0 511392.0 100054.5 100344.0 102336.0 102723.5 104662.4 998.5 1030.9 1041.8 1043.1 1050.7 18472.6 18518.4 18872.8 19215.9 19318.0 43577.8 44534.6 45595.3 45601.8 46687.0 62371.4 63358.4 63375.0 63977.0 64545.7 9358.0 9361.3 9432.6 9479.1 9591.0 9594.4 12935.7 14312.3 14335.6 14358.1 11933.8 11999.2 12192.8 12541.9 12728.6 12608.5 12782.7 12894.7 12941.9 12978.7 12042.9 12541.4 12741.6 12857.2 13086.0 9448.2 9547.6 9650.1 9885.3 9930.0 12156.9 12175.6 12566.7 12881.7 13024.2 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | [#3] mootools.html Cycles:180 Average:6346.20 Median:4684.95 stddev:3668.65 (78.3%) stddev-sans-first:3660.39 09:44:11 INFO - PROCESS | 12727 | Values: 1437.3 1521.2 1586.5 1728.3 1865.1 8638.0 9290.2 9305.7 9756.0 9779.2 9788.8 9850.3 9859.8 9863.4 9868.8 2565.9 2586.3 2590.9 2597.1 2606.8 2465.2 2570.5 2573.6 2579.5 2580.0 2517.4 2548.7 2583.2 2583.2 2583.4 2525.0 2532.6 2536.3 2544.5 2556.4 2492.5 2514.7 2517.7 2519.3 2523.8 9753.6 9753.8 9829.2 9830.3 9832.1 5619.6 5785.0 5801.1 5874.7 5877.6 3689.8 3713.1 3746.1 3755.6 3764.3 1144.8 1170.3 1172.8 1186.3 1199.5 13396.8 13410.1 13434.6 13452.1 13452.5 4846.5 4903.7 4972.5 5027.4 5040.5 10536.8 10619.8 10621.2 10658.9 10663.5 5689.7 5699.7 5713.8 5720.1 5731.8 4541.0 4828.9 4915.8 4931.3 5360.3 4104.9 4171.0 4257.4 4264.7 4284.4 1240.1 1240.3 1244.5 1249.9 1251.8 1009.6 1017.3 1040.5 1044.2 1045.2 6152.1 6468.7 6514.5 6611.7 6679.6 490.7 499.1 502.2 506.7 518.6 4278.9 4409.1 4418.0 4453.6 4466.9 11876.8 12218.1 12323.3 12360.9 12364.9 11750.2 12196.5 12231.4 12263.8 12272.7 9099.0 9286.5 9302.0 9306.2 9314.5 6567.0 6693.9 6749.8 6807.2 6871.1 10846.6 11132.6 11417.0 11447.3 11557.1 10001.7 10224.4 11569.4 11575.7 11703.4 8312.0 8579.8 8644.8 8651.6 8654.7 9264.9 9295.9 9324.0 9335.2 9348.1 8592.0 8691.0 8699.1 8783.4 8847.4 8371.3 8408.4 8422.3 8447.9 8543.9 7676.6 7728.8 7838.7 7892.1 7924.9 5547.9 5554.4 5664.0 5695.7 5843.5 5535.6 5660.3 5676.3 5722.1 5768.4 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | [#4] prototype.html Cycles:180 Average:4789.73 Median:5295.01 stddev:1388.32 (26.2%) stddev-sans-first:1351.68 09:44:11 INFO - PROCESS | 12727 | Values: 352.7 356.4 362.7 369.9 371.3 5480.9 5508.9 5537.3 5541.8 5542.7 5148.3 5295.7 5299.0 5301.7 5463.4 4160.5 4204.9 4218.7 4283.8 4327.6 4284.4 4297.2 4297.5 4303.7 4305.6 4135.7 4285.5 4288.7 4296.2 4319.7 4278.1 4286.7 4291.7 4291.9 4299.9 3821.5 3833.8 3834.3 3839.0 3845.9 5162.4 5195.6 5279.5 5294.3 5307.7 4895.7 4908.8 4918.4 4922.4 4923.2 5637.5 5644.7 5670.8 5675.7 5677.7 4096.6 4163.9 4191.4 4200.5 4205.3 5887.9 5896.6 5905.6 5905.7 5911.7 4309.4 4309.5 4309.8 4316.3 4327.8 4303.3 4359.9 4379.6 4414.8 4418.1 4917.7 4920.7 4929.5 4940.8 4941.4 5713.9 5716.3 5723.3 5726.7 5742.3 1457.6 1501.9 1504.4 1511.1 1522.2 972.9 977.9 991.8 997.6 1001.2 4854.0 4874.7 4877.2 4885.7 4903.7 5156.5 5161.9 5167.5 5189.2 5192.4 4882.4 4894.4 4908.3 4919.0 5166.8 3077.9 3087.3 3092.6 3095.5 3119.9 5981.2 6008.3 6025.5 6040.7 6092.7 5689.1 5930.7 6028.9 6029.8 6035.0 6064.5 6068.9 6080.5 6081.7 6128.0 5617.5 5878.6 5922.2 5925.3 5932.2 5839.9 5846.7 5851.8 5855.8 5859.4 6060.7 6082.8 6084.1 6091.0 6100.3 4035.6 4083.7 4261.4 4287.9 4292.7 5728.2 5743.7 5892.4 5900.2 5906.2 5748.1 5769.8 5780.5 5780.6 5801.0 5598.5 5635.7 5693.1 5707.8 5795.6 5722.7 5734.2 5736.5 5756.6 5765.0 5602.7 5784.2 5792.6 5796.5 5804.0 5615.7 5654.2 5664.4 5666.4 5668.5 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - PROCESS | 12727 | [#5] yui.html Cycles:180 Average:22684.51 Median:4956.82 stddev:33299.82 (671.8%) stddev-sans-first:33352.77 09:44:11 INFO - PROCESS | 12727 | Values: 821.5 824.8 826.3 831.3 902.6 15520.4 17759.7 17964.6 17968.8 17970.4 16197.7 16255.5 16272.8 16391.3 16406.9 731.7 743.4 850.2 860.5 882.3 880.2 883.7 884.2 884.7 885.2 753.7 932.7 933.1 933.8 934.2 755.4 874.2 897.9 901.4 905.4 664.0 664.0 664.3 664.5 665.1 16222.8 16241.6 16255.4 16285.2 16293.9 14682.0 14688.5 14888.3 14945.2 15091.5 13942.9 14147.9 14163.2 14283.3 14485.6 4655.4 4670.8 4704.7 4916.1 4937.2 87949.6 88960.0 89169.0 92806.0 92852.5 11778.3 11980.8 12032.8 12069.4 12115.9 22311.6 22538.4 22611.0 22620.9 22628.4 8937.4 9027.0 9101.8 9130.0 9208.7 5093.4 5206.6 5246.2 5263.5 5279.6 3934.6 4086.6 4117.9 4121.9 4122.5 682.7 683.6 686.0 693.8 697.6 695.4 698.3 772.3 779.2 788.7 9464.5 9673.3 9834.5 9992.0 10157.0 727.9 728.6 817.6 817.8 839.2 4845.4 4976.5 5013.6 5028.2 5050.9 126794.0 127632.0 129125.0 133643.0 134521.3 87799.0 92172.5 114068.4 117999.4 118209.4 89388.6 92103.5 95808.0 96990.5 98231.0 9623.9 9641.0 9887.2 9925.8 10051.8 50896.2 51380.2 52444.5 53889.7 53901.2 71948.0 73342.0 83033.2 83952.0 85359.0 12720.2 12831.7 12917.5 13101.9 13423.5 14246.4 14523.1 14748.7 14823.9 15473.9 13900.9 14200.9 14854.6 15127.0 15161.6 14368.4 14369.4 14401.7 14769.9 14779.7 13393.5 13704.0 13997.1 14074.7 14672.6 11531.4 11668.5 11915.6 12098.8 12230.9 10404.8 11662.5 12341.2 12546.4 12970.4 09:44:11 INFO - PROCESS | 12727 | -------- Summary: end -------- 09:44:11 INFO - PROCESS | 12727 | 09:44:11 INFO - TEST-INFO | 12727: exit 0 09:44:11 INFO - TEST-OK | dromaeo_css | took 1112946ms 09:44:11 INFO - TEST-START | kraken 09:44:11 INFO - operating with platform_type : linux_ 09:44:11 INFO - Initialising browser for kraken test... 09:44:11 INFO - TEST-INFO | started process 13051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKijMWD/profile http://localhost:60885/getInfo.html) 09:44:15 INFO - PROCESS | 13051 | __metrics Screen width/height:1600/1200 09:44:15 INFO - PROCESS | 13051 | colorDepth:24 09:44:15 INFO - PROCESS | 13051 | Browser inner width/height: 1024/697 09:44:15 INFO - PROCESS | 13051 | __metrics 09:44:16 INFO - PROCESS | 13051 | 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" 09:44:16 INFO - PROCESS | 13051 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:16 INFO - PROCESS | 13051 | console.error: PushService: 09:44:16 INFO - PROCESS | 13051 | stateChangeProcessEnqueue: Error transitioning state 09:44:16 INFO - PROCESS | 13051 | UnknownError 09:44:17 INFO - TEST-INFO | 13051: exit 0 09:44:17 INFO - Browser initialized. 09:44:17 INFO - Running cycle 1/1 for kraken test... 09:44:17 INFO - TEST-INFO | started process 13145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKijMWD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:28 INFO - PROCESS | 13145 | RSS: Main: 144273408 09:44:28 INFO - PROCESS | 13145 | 09:44:31 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60885/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:32 INFO - PROCESS | 13145 | RSS: Main: 187138048 09:44:32 INFO - PROCESS | 13145 | 09:44:34 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60885/tests/kraken/driver.html?testName=audio-dft) 09:44:35 INFO - PROCESS | 13145 | RSS: Main: 176263168 09:44:35 INFO - PROCESS | 13145 | 09:44:38 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60885/tests/kraken/driver.html?testName=audio-fft) 09:44:38 INFO - PROCESS | 13145 | RSS: Main: 267362304 09:44:38 INFO - PROCESS | 13145 | 09:44:40 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60885/tests/kraken/driver.html?testName=audio-oscillator) 09:44:41 INFO - PROCESS | 13145 | RSS: Main: 173182976 09:44:41 INFO - PROCESS | 13145 | 09:44:43 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:44 INFO - PROCESS | 13145 | RSS: Main: 175239168 09:44:44 INFO - PROCESS | 13145 | 09:44:47 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60885/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:47 INFO - PROCESS | 13145 | RSS: Main: 211222528 09:44:47 INFO - PROCESS | 13145 | 09:44:50 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60885/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:51 INFO - PROCESS | 13145 | RSS: Main: 210247680 09:44:51 INFO - PROCESS | 13145 | 09:44:54 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60885/tests/kraken/driver.html?testName=json-parse-financial) 09:44:54 INFO - PROCESS | 13145 | RSS: Main: 210337792 09:44:54 INFO - PROCESS | 13145 | 09:44:56 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:57 INFO - PROCESS | 13145 | RSS: Main: 171646976 09:44:57 INFO - PROCESS | 13145 | 09:44:58 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:59 INFO - PROCESS | 13145 | RSS: Main: 179392512 09:44:59 INFO - PROCESS | 13145 | 09:45:01 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:01 INFO - PROCESS | 13145 | RSS: Main: 189046784 09:45:01 INFO - PROCESS | 13145 | 09:45:04 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:05 INFO - PROCESS | 13145 | RSS: Main: 197496832 09:45:05 INFO - PROCESS | 13145 | 09:45:07 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:08 INFO - PROCESS | 13145 | RSS: Main: 193159168 09:45:08 INFO - PROCESS | 13145 | 09:45:09 INFO - PROCESS | 13145 | Cycle 1(1): loaded http://localhost:60885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60885/tests/kraken/driver.html?testName=ai-astar) 09:45:10 INFO - PROCESS | 13145 | RSS: Main: 244998144 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | __start_tp_report 09:45:10 INFO - PROCESS | 13145 | _x_x_mozilla_page_load 09:45:10 INFO - PROCESS | 13145 | _x_x_mozilla_page_load_details 09:45:10 INFO - PROCESS | 13145 | |i|pagename|runs| 09:45:10 INFO - PROCESS | 13145 | |0;ai-astar;107;109;110;109;111;110;110;113;111;111 09:45:10 INFO - PROCESS | 13145 | |1;audio-beat-detection;146;121;119;153;123;119;118;115;149;115 09:45:10 INFO - PROCESS | 13145 | |2;audio-dft;160;160;160;160;160;162;161;159;160;160 09:45:10 INFO - PROCESS | 13145 | |3;audio-fft;74;75;75;114;76;76;78;76;110;75 09:45:10 INFO - PROCESS | 13145 | |4;audio-oscillator;81;81;114;82;83;83;101;81;81;107 09:45:10 INFO - PROCESS | 13145 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;116 09:45:10 INFO - PROCESS | 13145 | |6;imaging-darkroom;146;146;147;146;146;145;146;146;146;150 09:45:10 INFO - PROCESS | 13145 | |7;imaging-desaturate;94;94;94;95;95;94;94;94;95;95 09:45:10 INFO - PROCESS | 13145 | |8;json-parse-financial;49;49;50;50;51;52;49;50;49;50 09:45:10 INFO - PROCESS | 13145 | |9;json-stringify-tinderbox;59;60;59;58;59;58;59;59;58;59 09:45:10 INFO - PROCESS | 13145 | |10;stanford-crypto-aes;73;81;76;74;74;73;73;72;72;73 09:45:10 INFO - PROCESS | 13145 | |11;stanford-crypto-ccm;121;124;124;126;130;121;117;119;157;131 09:45:10 INFO - PROCESS | 13145 | |12;stanford-crypto-pbkdf2;168;160;158;153;154;159;154;154;155;153 09:45:10 INFO - PROCESS | 13145 | |13;stanford-crypto-sha256-iterative;62;62;62;62;65;62;63;61;60;60 09:45:10 INFO - PROCESS | 13145 | __end_tp_report 09:45:10 INFO - PROCESS | 13145 | __start_cc_report 09:45:10 INFO - PROCESS | 13145 | _x_x_mozilla_cycle_collect,1591 09:45:10 INFO - PROCESS | 13145 | __end_cc_report 09:45:10 INFO - PROCESS | 13145 | __startTimestamp1477673110209__endTimestamp 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | ------- Summary: start ------- 09:45:10 INFO - PROCESS | 13145 | Number of tests: 14 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.60 (1.4%) stddev-sans-first:1.24 09:45:10 INFO - PROCESS | 13145 | Values: 107.0 109.0 110.0 109.0 111.0 110.0 110.0 113.0 111.0 111.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:122.00 stddev:15.14 (12.4%) stddev-sans-first:14.56 09:45:10 INFO - PROCESS | 13145 | Values: 146.0 121.0 119.0 153.0 123.0 119.0 118.0 115.0 149.0 115.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:45:10 INFO - PROCESS | 13145 | Values: 160.0 160.0 160.0 160.0 160.0 162.0 161.0 159.0 160.0 160.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:15.40 (20.4%) stddev-sans-first:16.00 09:45:10 INFO - PROCESS | 13145 | Values: 74.0 75.0 75.0 114.0 76.0 76.0 78.0 76.0 110.0 75.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:81.00 stddev:12.77 (15.8%) stddev-sans-first:13.18 09:45:10 INFO - PROCESS | 13145 | Values: 81.0 81.0 114.0 82.0 83.0 83.0 101.0 81.0 81.0 107.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:45:10 INFO - PROCESS | 13145 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 09:45:10 INFO - PROCESS | 13145 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 150.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:45:10 INFO - PROCESS | 13145 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.99 (2.0%) stddev-sans-first:1.00 09:45:10 INFO - PROCESS | 13145 | Values: 49.0 49.0 50.0 50.0 51.0 52.0 49.0 50.0 49.0 50.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 09:45:10 INFO - PROCESS | 13145 | Values: 59.0 60.0 59.0 58.0 59.0 58.0 59.0 59.0 58.0 59.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:73.50 stddev:2.69 (3.7%) stddev-sans-first:2.82 09:45:10 INFO - PROCESS | 13145 | Values: 73.0 81.0 76.0 74.0 74.0 73.0 73.0 72.0 72.0 73.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:125.00 stddev:11.45 (9.2%) stddev-sans-first:11.94 09:45:10 INFO - PROCESS | 13145 | Values: 121.0 124.0 124.0 126.0 130.0 121.0 117.0 119.0 157.0 131.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:156.50 stddev:4.69 (3.0%) stddev-sans-first:2.70 09:45:10 INFO - PROCESS | 13145 | Values: 168.0 160.0 158.0 153.0 154.0 159.0 154.0 154.0 155.0 153.0 09:45:10 INFO - PROCESS | 13145 | 09:45:10 INFO - PROCESS | 13145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.54 09:45:10 INFO - PROCESS | 13145 | Values: 62.0 62.0 62.0 62.0 65.0 62.0 63.0 61.0 60.0 60.0 09:45:10 INFO - PROCESS | 13145 | -------- Summary: end -------- 09:45:10 INFO - PROCESS | 13145 | 09:45:11 INFO - TEST-INFO | 13145: exit 0 09:45:11 INFO - TEST-OK | kraken | took 59288ms 09:45:11 INFO - SUITE-END | took 1172s 09:45:11 INFO - Completed test suite (00:19:32) 09:45:11 INFO - javascript benchmark 09:45:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.51074083517, 3188.681131886811, 3195.456772348702, 3223.306988997365, 3237.9838100809507, 5595.132754423066, 5686.260786097807, 5704.1443783432405, 5711.171880077386, 5715.599908006441, 5667.149927510865, 5717.828465146042, 5722.055860782966, 5723.399043100477, 5770.567207459437, 5142.845714628558, 5161.303224064741, 5174.715390653512, 5202.531772140506, 5243.947560524384, 5114.667546609458, 5133.3326667533165, 5256.8160114396005, 5260.079486089938, 5295.947040529584, 5074.264231686403, 5140.511651393112, 5154.252633368159, 5160.948390516103, 5185.118529849935, 5148.3564554430695, 5172.741362931838, 5176.7929282828645, 5241.633085684004, 5252.159654455307, 5095.108356037678, 5141.228815677641, 5209.374875015023, 5223.555997740159, 5244.5279924806955, 5477.835664930059, 5488.91766623501, 5515.310586176728, 5526.917096243559, 5530.364008139075, 5997.610155339932, 6004.189434426384, 6021.729022194012, 6095.9695201524155, 6096.207493025879, 6097.756089756404, 6108.694565271719, 6108.877822443526, 6111.572189946705, 6113.44978951892, 5490.56075513958, 5541.5289700375515, 5586.692731899784, 5616.438356164351, 5657.094864821609, 6191.628502289877, 6219.689015549205, 6224.315325314212, 6225.315215326311, 6260.467860231931, 5965.433283838029, 5988.670623115683, 5992.880142397127, 5996.730147143389, 5999.100134979788, 5902.114682797529, 5948.2862056553495, 5953.107033944856, 5969.04495280753, 6003.339632640406, 6019.6990150493175, 6023.156758053876, 6028.457438830526, 6032.849178770478, 6051.878962420727, 5964.791232306935, 6030.03519436888, 6030.155778191057, 6039.939600604026, 6051.546134039964, 4552.135094332067, 4597.057603191338, 4611.423572053493, 4656.883577910512, 4660.39414876064, 4157.355609880473, 4159.313713237342, 4177.415161877339, 4177.456930599003, 4196.076863090116, 5780.5953583248765, 5817.7091145442555, 5826.4464875837575, 5828.504577110908, 5832.1834943108, 5946.85132871673, 6005.099235114768, 6018.15745795589, 6157.291911430243, 6159.969200153971, 5737.3975732548315, 5800.680962547016, 5801.622894511843, 5835.766569337179, 5844.357120716718, 5254.264402983586, 5257.710825904535, 5267.26258323835, 5267.394249661338, 5273.2617433559335, 5997.730102145327, 6176.35148309421, 6251.062340648939, 6290.276618188876, 6296.433321001132, 5933.317668468181, 6042.697865106639, 6102.389761023862, 6110.7555697771595, 6152.630842149485, 6291.402316779899, 6291.496680265659, 6294.3076261612105, 6302.432781049728, 6303.306636269915, 5975.55183361241, 6013.248343957005, 6023.277206735044, 6030.939690603038, 6031.819045428644, 5873.353931067493, 5995.880082398415, 6041.395860413923, 6065.60573562717, 6083.908741368971, 6019.097135429721, 6020.548458865515, 6022.427869352405, 6026.306974697965, 6035.064564992434, 6009.819705408845, 6010.429009244115, 6012.1582978382185, 6016.398360163948, 6017.849553761191, 5735.971320143372, 5846.181534585076, 5875.089361149029, 5935.792247271324, 5976.820695379146, 6036.939630603813, 6041.2750469943885, 6041.486473649789, 6047.395260473917, 6076.361981992004, 5670.773169073191, 5832.679202643895, 5889.94110058894, 5892.499137573354, 5894.145348924296], "value": 5594.965722409416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9615225010374, 614.8339948213983, 627.4603840697, 649.779075114461, 665.1818263535848, 35992.0, 39671.0, 48766.293179738714, 49670.0, 49786.0, 51445.74277128609, 51881.740591297086, 51887.740561297236, 51933.74033129839, 51974.22038669423, 8612.267957223643, 9371.250299976002, 9518.0, 9528.047195280451, 9534.04659534048, 8521.14788521146, 11191.0, 11439.084873210164, 11454.396384506175, 11876.762464750744, 11665.708357291092, 11709.94145029278, 11722.0, 11725.530978760882, 11728.7654246915, 11431.714207144805, 11481.942590287079, 11502.654920352361, 11505.309681419058, 11508.884911150864, 11241.381724005176, 11299.03958163557, 11303.474031005873, 11304.773904521946, 11313.886861131366, 47545.0, 47800.7609961948, 47854.521454785354, 47928.52071479276, 47986.76006619979, 3895.9220815583813, 3933.1936952924866, 4578.404807375054, 4677.064587082563, 4707.8587642370785, 35723.4641480378, 36033.81983090094, 36078.09804754876, 36175.27649447023, 37900.81049594734, 4157.48031496063, 4182.435371224907, 4182.686298527623, 4196.160767846412, 4206.113537117904, 392271.0, 393040.0, 395409.0, 396657.9999999971, 397250.0, 40593.0, 41377.0, 67802.3219767796, 68295.0, 68430.65784671044, 43010.56989430128, 43431.56568434338, 43464.348034779505, 43470.0, 43502.34746478805, 16697.415590454275, 16834.158292085347, 16859.57851053709, 16859.83140168607, 16881.493555193363, 12520.68698282532, 12780.61658150257, 12797.424115914806, 14037.438502459992, 14106.576802695936, 9481.383710058824, 9736.513174341255, 9784.119429251401, 9802.264830137769, 9829.705108846745, 3649.50731651229, 3687.11509237781, 3727.2172843703124, 3733.0667333166707, 3757.248550289953, 1099.3623698254994, 1126.8843844593794, 1176.517627772609, 1204.265398107154, 1248.051480874542, 36092.375843087124, 36754.0, 36816.26367472635, 36993.63006369956, 37024.0, 1165.3998190931677, 1186.5609724402027, 1194.0686264713538, 1253.5048655780915, 1322.9098025120286, 18398.724019139725, 19335.709964350546, 19518.0, 19664.508387290145, 19682.114304856317, 637268.0, 638007.0, 640634.0, 642073.0, 644398.0, 68528.0, 69194.30805691879, 69210.65394672994, 69270.65364673144, 69452.652736736, 1331.9866801332057, 1384.4738999180247, 1413.7808639661075, 1439.1077531930061, 1449.1956963884934, 32497.0, 37038.0, 37228.25543489061, 37640.43539346967, 37661.435078473296, 57161.0, 57964.710176450535, 58046.83906321765, 58071.0, 58126.41873581379, 452297.0, 453492.0, 453906.0, 454588.0, 455891.0, 32120.839395802872, 32263.193420164684, 32403.837980809945, 34792.0, 35011.0, 54725.179122313995, 54928.0, 55204.723976379864, 55221.44778552163, 55469.722651388096, 45228.77385613051, 46977.76511117422, 47328.0, 47500.52499474961, 48542.0, 45028.0, 45669.0, 47480.2877956824, 47577.0, 48438.03123937572, 46146.0, 46505.53494465012, 46589.76705116453, 47066.76466617645, 47329.76335118302, 39138.60861391349, 40934.1813163741, 41120.79439602783, 41233.38149927693, 42117.0, 30262.54606180865, 30731.539026914168, 30813.691863081083, 31013.379732404774, 31131.68868311288], "value": 21424.77508652571, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.6458969222548, 424.9043965107849, 426.6970450979804, 434.5806296923468, 444.1982222089128, 16200.270987805548, 19615.901920490396, 21846.781532184672, 22097.889510552464, 22286.442838929033, 19591.118399672014, 20149.899250503764, 20202.89898550509, 20959.161633534677, 21048.26331078409, 5420.512153906147, 5446.428125046863, 5635.042042852725, 5635.239242702244, 5636.633618814784, 5439.755211015494, 5540.556755459574, 5548.306461692288, 5548.334199896018, 5559.388467268597, 5565.30433695788, 5566.165075238727, 5566.916496252559, 5568.1647752837, 5899.911501327483, 6094.268687757475, 6280.968595157041, 6281.120643109968, 6285.717142728588, 6290.3709629037185, 5945.286565612111, 6099.420555047308, 6120.265568131808, 6155.199824022849, 6162.938370616282, 15337.846621533754, 15572.844271557253, 15774.276379549865, 24965.375865603324, 25273.115440959664, 2489.4772097859473, 2623.147477069941, 2847.686754457008, 3184.8885289014775, 3249.788763730374, 11069.667909962714, 11094.500747466383, 11340.206185567014, 11454.312741235553, 11887.0, 1969.6257711035, 2050.5693804301113, 2063.484128967758, 2097.4336929029228, 2103.4741314671332, 89727.55136224277, 90419.54790226006, 92143.0, 93473.0, 94567.0, 9837.655682051238, 10526.368417894797, 10597.894021059845, 10772.461376931122, 11018.834717479243, 16248.187590620659, 16266.18669066542, 16870.0, 16875.57811054709, 17778.199981000886, 8632.741017769476, 8832.470051796912, 8987.730368088967, 9017.819643607223, 9027.909720902708, 8443.57782110892, 8489.660413583388, 8490.745277641681, 8666.56667166639, 8736.737897863075, 5044.369453818273, 5202.401723801736, 5245.0, 5267.947320526822, 5407.594430417735, 2144.0, 2165.0, 2176.238316589213, 2183.9563208735735, 2188.081005977493, 926.1849572376266, 983.2822039910905, 987.4470296633908, 994.4933425859828, 1020.9081182693593, 20971.0, 21032.158713651283, 21305.467363316042, 21429.892850535958, 21488.78511214899, 1057.582255009267, 1062.8565143705655, 1072.286929192094, 1086.8261078227604, 1116.7152376144031, 10948.34309941406, 11653.009494192918, 11708.590199342982, 11738.0, 11942.164048516694, 483506.0, 485228.0, 493182.0, 509136.0, 511392.0, 100054.4997275009, 100344.0, 102336.0, 102723.48638256761, 104662.43006354911, 998.5406712912142, 1030.8659874216303, 1041.8437234414898, 1043.1498328861953, 1050.726811029138, 18472.630547389246, 18518.44444666662, 18872.811271887105, 19215.90392048031, 19318.03409829531, 43577.78211108924, 44534.55465445304, 45595.31607025831, 45601.77199114116, 46687.0, 62371.376286236555, 63358.366416335244, 63375.0, 63977.0, 64545.67727161334, 9358.0, 9361.344705870524, 9432.575534101119, 9479.146876781122, 9591.040895910353, 9594.42433453995, 12935.741285174432, 14312.284385780878, 14335.56993290203, 14358.138511689333, 11933.82099268529, 11999.220050696676, 12192.75614487723, 12541.93729031349, 12728.645200637911, 12608.495660173858, 12782.68043298925, 12894.742105158031, 12941.935290323489, 12978.675533111747, 12042.939785301018, 12541.372931353579, 12741.617751467471, 12857.164284321489, 13086.0, 9448.244140468883, 9547.570359333708, 9650.131488166098, 9885.258605604753, 9929.950350248491, 12156.939215303866, 12175.573854915036, 12566.748665026831, 12881.742365152457, 13024.218546887218], "value": 9799.339786828146, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.3388241408952, 1521.155758554002, 1586.5478338673477, 1728.3000384844142, 1865.0954287170712, 8637.956810215948, 9290.21033212177, 9305.720828375159, 9756.0, 9779.217662586994, 9788.755281117976, 9850.310478266525, 9859.802803943916, 9863.408195508275, 9868.802623947517, 2565.923022309329, 2586.301698541393, 2590.922272331833, 2597.091018143644, 2606.752358525937, 2465.211132437612, 2570.485902819434, 2573.6396904433395, 2579.5227882841737, 2580.006697421497, 2517.3832411059225, 2548.6559314492492, 2583.186296316654, 2583.186296316654, 2583.354161459635, 2524.9747502524924, 2532.556802559554, 2536.251805717318, 2544.465662210938, 2556.437583731576, 2492.470661543259, 2514.7485251474704, 2517.735637758027, 2519.3323769201174, 2523.772860442569, 9753.609855605839, 9753.756156096084, 9829.164521015722, 9830.311878168532, 9832.065953734384, 5619.550435965113, 5785.045467497858, 5801.129830525413, 5874.706264686749, 5877.647341159502, 3689.7786132832116, 3713.1459764254105, 3746.119661879456, 3755.6244375562223, 3764.3036038333, 1144.822552504363, 1170.2627344772739, 1172.7725776128784, 1186.3356520348545, 1199.4602428907026, 13396.79904801419, 13410.12834165776, 13434.596962091153, 13452.125611835101, 13452.461901523928, 4846.5153484651955, 4903.730294833818, 4972.453030166679, 5027.371578552681, 5040.54635082837, 10536.789264214825, 10619.787604247871, 10621.150307975344, 10658.89341106579, 10663.520141593646, 5689.743961521742, 5699.658020518782, 5713.800016999385, 5720.084786434234, 5731.770729170787, 4541.0016129511405, 4828.903421931542, 4915.827946021872, 4931.334269873521, 5360.303160589098, 4104.91790164195, 4171.0, 4257.40396344512, 4264.658827293809, 4284.357346398066, 1240.057556257233, 1240.3116270469795, 1244.4524409259898, 1249.9437525311382, 1251.7809383357876, 1009.6314845081639, 1017.2878984710732, 1040.458961340114, 1044.1698849414734, 1045.2004216774174, 6152.107944348134, 6468.708908099053, 6514.5114116441455, 6611.702473388709, 6679.599224046573, 490.6884128578307, 499.0692358750903, 502.18645793814255, 506.73902939985936, 518.5669965578784, 4278.935815962701, 4409.0520538084465, 4418.028033832552, 4453.576910193527, 4466.9106617867465, 11876.821847672292, 12218.144729868824, 12323.322217277957, 12360.938195308965, 12364.876351236373, 11750.177487575787, 12196.51213951432, 12231.449584768707, 12263.811409033715, 12272.693182670504, 9098.954505227432, 9286.535673216313, 9302.0, 9306.208972237435, 9314.48770317639, 6566.967165164335, 6693.933060669331, 6749.831254218684, 6807.183138023469, 6871.14110736158, 10846.566137354417, 11132.610358637408, 11417.029552488131, 11447.313161210353, 11557.075433965094, 10001.699949001542, 10224.437655928697, 11569.363684997406, 11575.652730418102, 11703.414829258674, 8311.95844020776, 8579.828403431771, 8644.82710345777, 8651.6106775194, 8654.740357789276, 9264.861027084464, 9295.86056209171, 9324.020977797234, 9335.159835614828, 9348.1119293667, 8591.957040214758, 8691.0, 8699.13008699125, 8783.385163038525, 8847.380683352103, 8371.330293576377, 8408.36937229698, 8422.284105850826, 8447.8732819009, 8543.871841922251, 7676.6161691916295, 7728.8454230916195, 7838.686452542062, 7892.1318654949055, 7924.881126783218, 5547.916781248366, 5554.416786237387, 5664.0, 5695.743691533974, 5843.474087331991, 5535.612507124462, 5660.349059858005, 5676.347220069745, 5722.141678748221, 5768.365479797135], "value": 4956.554418349117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.66144501278774, 356.4297124600639, 362.7406404420839, 369.93341198584244, 371.3482837619975, 5480.945190548098, 5508.862278443041, 5537.335519737632, 5541.833744987657, 5542.722863856801, 5148.279240906267, 5295.735213239342, 5299.0, 5301.7084060376765, 5463.426340234268, 4160.479940007499, 4204.852830150945, 4218.692205416315, 4283.764392958386, 4327.588879056485, 4284.357346398034, 4297.205017071836, 4297.462817147856, 4303.677224208197, 4305.569443055685, 4135.73117747347, 4285.485741710999, 4288.721233119837, 4296.2385421977, 4319.719218250803, 4278.101598664284, 4286.699931004831, 4291.678124140702, 4291.871243862689, 4299.871003869889, 3821.464994900716, 3833.8274777635074, 3834.2714884172196, 3839.0, 3845.8653947111716, 5162.380514338303, 5195.621843620397, 5279.472052794728, 5294.285271488377, 5307.681539107666, 4895.730734809584, 4908.803647854082, 4918.409790825088, 4922.360093187898, 4923.18767403378, 5637.46444087811, 5644.717764111819, 5670.801521946753, 5675.716214189274, 5677.687727175004, 4096.631303182728, 4163.937540936889, 4191.371294305848, 4200.537940826506, 4205.285101532747, 5887.911681324784, 5896.616719913192, 5905.616134951214, 5905.675187864623, 5911.733971971272, 4309.396684464177, 4309.461317335333, 4309.827606895689, 4316.266234740102, 4327.805248763813, 4303.311470164758, 4359.869203923888, 4379.627731642782, 4414.80133393998, 4418.138462999685, 4917.680350777188, 4920.704757714549, 4929.457759646436, 4940.752962351868, 4941.407031156213, 5713.942860571424, 5716.28546431696, 5723.341815691166, 5726.685032323179, 5742.28221472316, 1457.5554455890842, 1501.924903754808, 1504.353128154904, 1511.1084460168554, 1522.1856306875768, 972.9464879431699, 977.9340518834363, 991.8413053911339, 997.6159178716247, 1001.2140469731372, 4854.0, 4874.731889746098, 4877.219644856806, 4885.7312847793, 4903.656744027955, 5156.484351564888, 5161.922571161435, 5167.509086636764, 5189.221616757516, 5192.402873669501, 4882.414110306786, 4894.423713827583, 4908.263760435963, 4918.975405122951, 5166.793328266903, 3077.86149623263, 3087.274490494732, 3092.567040614316, 3095.4892442746695, 3119.937601248008, 5981.222441082718, 6008.3390827009, 6025.487833534111, 6040.697965101727, 6092.715231788079, 5689.118186681071, 5930.733117009745, 6028.909566356509, 6029.8191054268445, 6034.969825150846, 6064.4541991221, 6068.939310606837, 6080.48315893154, 6081.665508397081, 6128.0, 5617.466340697627, 5878.588498805043, 5922.170896074639, 5925.348211696623, 5932.228810254639, 5839.883202336015, 5846.707664616837, 5851.795187168429, 5855.795047173328, 5859.388668116302, 6060.666663333559, 6082.787102451393, 6084.14821924922, 6091.0, 6100.267967843887, 4035.616616421435, 4083.6733061354425, 4261.424707664426, 4287.920358626002, 4292.7424354538825, 5728.2242504823635, 5743.712814359349, 5892.381299963614, 5900.173975643327, 5906.228131560601, 5748.074395077529, 5769.769209231584, 5780.479756821906, 5780.624259423124, 5800.970995144998, 5598.468145526169, 5635.690037048002, 5693.089105743227, 5707.828765137053, 5795.565332600157, 5722.655176033712, 5734.168545560954, 5736.4550367715, 5756.568257380797, 5765.019946609003, 5602.7139238483405, 5784.248047753765, 5792.594518383841, 5796.464156864394, 5803.970980145073, 5615.719214039364, 5654.236678048575, 5664.405237450173, 5666.433356664301, 5668.546516278605], "value": 4356.321251239782, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.4660470694048, 824.8493351774273, 826.3182874128842, 831.3183189784379, 902.6028547439122, 15520.379184832607, 17759.733603995934, 17964.55088622785, 17968.820311796877, 17970.37103701371, 16197.676046479064, 16255.51233462995, 16272.83727162728, 16391.34434622614, 16406.933549319318, 731.689032161332, 743.434989408051, 850.1753299299685, 860.492309537376, 882.298572634757, 880.1638443478721, 883.7172104926426, 884.2218847414266, 884.703624285865, 885.1812073831712, 753.6872198037807, 932.7201839448172, 933.0762545080355, 933.761890717866, 934.1965909317981, 755.448522578518, 874.1739056591524, 897.8742975983367, 901.4230892228978, 905.3662436294554, 663.9535232533725, 663.9634820084893, 664.3058004385429, 664.5381459885382, 665.1021121485956, 16222.756658650129, 16241.59396015109, 16255.431059912964, 16285.185740712917, 16293.91853040739, 14682.0, 14688.485902993343, 14888.255587220703, 14945.17801520916, 15091.547253582301, 13942.93028534861, 14147.929260353632, 14163.15021098727, 14283.285835708173, 14485.637859053502, 4655.441347038377, 4670.766461676936, 4704.717716936994, 4916.139675556799, 4937.1606826839525, 87949.56025219896, 88960.0, 89169.0, 92806.0, 92852.53573732155, 11778.293302401884, 11980.760384792255, 12032.75934481323, 12069.396530173632, 12115.878841211652, 22311.553768924856, 22538.436539086328, 22610.98250578728, 22620.886895565745, 22628.434289142904, 8937.374383793072, 9027.0, 9101.772455688528, 9129.95435022834, 9208.677696280598, 5093.363329583802, 5206.55744261742, 5246.160614301693, 5263.526282634504, 5279.604029697788, 3934.626210509997, 4086.6117718816663, 4117.91764164715, 4121.91756164875, 4122.464079669624, 682.7269092362995, 683.6137582266003, 686.0292685849467, 693.7883945396702, 697.5779653309776, 695.4262733244992, 698.2877464985686, 772.3126417488439, 779.2363483785808, 788.6529926832176, 9464.47945362998, 9673.322867399214, 9834.508274586386, 9992.0, 10157.0, 727.9344858962719, 728.5956294256632, 817.5666896544841, 817.791463176898, 839.1734141870253, 4845.41854977405, 4976.477469865685, 5013.573846223039, 5028.220625803006, 5050.898982020412, 126794.0, 127632.0, 129125.0, 133643.0, 134521.32739336242, 87799.0, 92172.53913730389, 114068.42965785119, 117999.41000294943, 118209.40895295469, 89388.5530572356, 92103.53948230216, 95807.9999999986, 96990.51504742431, 98231.0, 9623.903760962301, 9641.0, 9887.209023277977, 9925.801483970135, 10051.798964020825, 50896.23655645242, 51380.22929655983, 52444.47555524396, 53889.73055134699, 53901.19148212858, 71948.0, 73342.0, 83033.16966830497, 83952.0, 85359.0, 12720.236785792882, 12831.652676468837, 12917.483300667867, 13101.934490327487, 13423.463061477432, 14246.430142794587, 14523.128612283297, 14748.705025899208, 14823.851761482678, 15473.922630386776, 13900.860991389956, 14200.857991419953, 14854.628634284229, 15127.0, 15161.62095947566, 14368.425262989782, 14369.353379098175, 14401.711965760416, 14769.92615036918, 14779.704405911607, 13393.531226407029, 13704.0, 13997.091643221955, 14074.718505630035, 14672.633184170481, 11531.425258169995, 11668.501492655858, 11915.582954596548, 12098.818517722066, 12230.938845305716, 10404.791904162026, 11662.53349865996, 12341.197822141532, 12546.435410406371, 12970.416331265304], "value": 8137.32291788998, "unit": "score"}], "name": "dromaeo_css", "value": 7687.573755276624, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0, 113.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 119.0, 153.0, 123.0, 119.0, 118.0, 115.0, 149.0, 115.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 159.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 114.0, 76.0, 76.0, 78.0, 76.0, 110.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 82.0, 83.0, 83.0, 101.0, 81.0, 81.0, 107.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 150.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 50.0, 51.0, 52.0, 49.0, 50.0, 49.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 76.0, 74.0, 74.0, 73.0, 73.0, 72.0, 72.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 124.0, 126.0, 130.0, 121.0, 117.0, 119.0, 157.0, 131.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 160.0, 158.0, 153.0, 154.0, 159.0, 154.0, 154.0, 155.0, 153.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 65.0, 62.0, 63.0, 61.0, 60.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1456.3999999999999, "alertThreshold": 2.0}]} 09:45:11 INFO - Return code: 0 09:45:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:11 INFO - # TBPL SUCCESS # 09:45:11 INFO - Running post-action listener: _resource_record_post_action 09:45:11 INFO - [mozharness: 2016-10-28 16:45:11.523333Z] Finished run-tests step (success) 09:45:11 INFO - Running post-run listener: _resource_record_post_run 09:45:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2002944; Write bytes: 376156160; Read time: 92; Write time: 226412 09:45:11 INFO - TinderboxPrint: CPU usage
12.9% 09:45:11 INFO - TinderboxPrint: I/O read bytes / time
2,002,944 / 92 09:45:11 INFO - TinderboxPrint: I/O write bytes / time
376,156,160 / 226,412 09:45:11 INFO - TinderboxPrint: CPU idle
8,262.3 (87.1%) 09:45:11 INFO - TinderboxPrint: CPU user
1,184.7 (12.5%) 09:45:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:45:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 123904000; Read time: 0; Write time: 72748 09:45:11 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251092992; Read time: 28; Write time: 153632 09:45:12 INFO - Running post-run listener: _upload_blobber_files 09:45:12 INFO - Blob upload gear active. 09:45:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:12 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 09:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:13 INFO - (blobuploader) - INFO - Done attempting. 09:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:14 INFO - (blobuploader) - INFO - Done attempting. 09:45:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:17 INFO - (blobuploader) - INFO - Done attempting. 09:45:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:17 INFO - Return code: 0 09:45:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e4676fe5c8ec0a96767a7a6dca486c6a59fa414e4614a13a7464ce8f81e5295449cadc05297113388d193238d8466d5c9bacfbfdedf8a60a579ebe7b745437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff8ebb1e85e8a8dfb7feccd8a99bb2c58e0d37b1010108ac19a98796a26547b8d1fbc625bec0fdbae3e7eb6b6d3b649715fc4a3d4c4ef6fdc48f1444b007d0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad9a08cf327a11bd03a461a9005067e49e84b7fa46a24853e23a58b9b5e44aa5a086c2af54e204cd98e7694830535adfb4f991cbd06b747ebabcb263b81853d"} 09:45:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:17 INFO - Contents: 09:45:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e4676fe5c8ec0a96767a7a6dca486c6a59fa414e4614a13a7464ce8f81e5295449cadc05297113388d193238d8466d5c9bacfbfdedf8a60a579ebe7b745437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff8ebb1e85e8a8dfb7feccd8a99bb2c58e0d37b1010108ac19a98796a26547b8d1fbc625bec0fdbae3e7eb6b6d3b649715fc4a3d4c4ef6fdc48f1444b007d0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad9a08cf327a11bd03a461a9005067e49e84b7fa46a24853e23a58b9b5e44aa5a086c2af54e204cd98e7694830535adfb4f991cbd06b747ebabcb263b81853d"} 09:45:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:17 INFO - Copying logs to upload dir... 09:45:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.820758 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-10-28 09:45:17.314898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 09:45:17.318786) ========= 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=0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e4676fe5c8ec0a96767a7a6dca486c6a59fa414e4614a13a7464ce8f81e5295449cadc05297113388d193238d8466d5c9bacfbfdedf8a60a579ebe7b745437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff8ebb1e85e8a8dfb7feccd8a99bb2c58e0d37b1010108ac19a98796a26547b8d1fbc625bec0fdbae3e7eb6b6d3b649715fc4a3d4c4ef6fdc48f1444b007d0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad9a08cf327a11bd03a461a9005067e49e84b7fa46a24853e23a58b9b5e44aa5a086c2af54e204cd98e7694830535adfb4f991cbd06b747ebabcb263b81853d"} build_url:https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/Ck7z8BGgSAKqrv6Y-DxUHA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e4676fe5c8ec0a96767a7a6dca486c6a59fa414e4614a13a7464ce8f81e5295449cadc05297113388d193238d8466d5c9bacfbfdedf8a60a579ebe7b745437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff8ebb1e85e8a8dfb7feccd8a99bb2c58e0d37b1010108ac19a98796a26547b8d1fbc625bec0fdbae3e7eb6b6d3b649715fc4a3d4c4ef6fdc48f1444b007d0cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad9a08cf327a11bd03a461a9005067e49e84b7fa46a24853e23a58b9b5e44aa5a086c2af54e204cd98e7694830535adfb4f991cbd06b747ebabcb263b81853d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 09:45:17.344249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:45:17.344580) ========= 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=0333a256a5e4f052382dd180000001b1-1477666551.368858-1781740743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:45:17.429377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 09:45:17.429691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 09:45:17.429979) ========= ========= Total master_lag: 0.16 =========