builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1482161884.77 results: success (0) buildid: 20161219062538 builduid: 84fe2c81c46b4e549e51840496f0f74f revision: c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.770732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.771317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.771741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.788400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.788964) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-19 07:38:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-12-19 07:38:07 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.924791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.925102) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017351 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.978105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:04.978677) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e --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=05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-19 07:38:07,558 truncating revision to first 12 chars 2016-12-19 07:38:07,558 Setting DEBUG logging. 2016-12-19 07:38:07,558 attempt 1/10 2016-12-19 07:38:07,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c23aa18ca567?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 07:38:07,905 unpacking tar archive at: mozilla-central-c23aa18ca567/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:05.669579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:05.670026) ========= script_repo_revision: c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:05.670480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:05.670784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 07:38:05.680961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-19 07:38:05.681361) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:08 INFO - MultiFileLogger online at 20161219 07:38:08 in /builds/slave/test 07:38:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:38:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:08 INFO - {'append_to_log': False, 07:38:08 INFO - 'base_work_dir': '/builds/slave/test', 07:38:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:38:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:08 INFO - 'branch': 'Firefox-Non-PGO', 07:38:08 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:08 INFO - 'config_files': ('talos/linux_config.py',), 07:38:08 INFO - 'default_actions': ('clobber', 07:38:08 INFO - 'read-buildbot-config', 07:38:08 INFO - 'download-and-extract', 07:38:08 INFO - 'populate-webroot', 07:38:08 INFO - 'create-virtualenv', 07:38:08 INFO - 'install', 07:38:08 INFO - 'run-tests'), 07:38:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:08 INFO - 'download_minidump_stackwalk': True, 07:38:08 INFO - 'download_symbols': 'ondemand', 07:38:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:08 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:08 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:08 INFO - 'installer_path': 'installer.exe', 07:38:08 INFO - 'log_level': 'info', 07:38:08 INFO - 'log_name': 'talos', 07:38:08 INFO - 'log_to_console': True, 07:38:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:08 INFO - 'opt_config_files': (), 07:38:08 INFO - 'pip_index': False, 07:38:08 INFO - 'sps_profile': False, 07:38:08 INFO - 'sps_profile_interval': 0, 07:38:08 INFO - 'suite': 'dromaeojs', 07:38:08 INFO - 'system_bits': '32', 07:38:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:08 INFO - 'title': 'talos-linux64-ix-069', 07:38:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:08 INFO - 'use_talos_json': True, 07:38:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:08 INFO - 'work_dir': 'build'} 07:38:08 INFO - [mozharness: 2016-12-19 15:38:08.364632Z] Running clobber step. 07:38:08 INFO - Running pre-action listener: _resource_record_pre_action 07:38:08 INFO - Running main action method: clobber 07:38:08 INFO - rmtree: /builds/slave/test/build 07:38:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:09 INFO - Running post-action listener: _resource_record_post_action 07:38:09 INFO - [mozharness: 2016-12-19 15:38:09.338952Z] Finished clobber step (success) 07:38:09 INFO - [mozharness: 2016-12-19 15:38:09.339051Z] Running read-buildbot-config step. 07:38:09 INFO - Running pre-action listener: _resource_record_pre_action 07:38:09 INFO - Running main action method: read_buildbot_config 07:38:09 INFO - Using buildbot properties: 07:38:09 INFO - { 07:38:09 INFO - "project": "", 07:38:09 INFO - "product": "firefox", 07:38:09 INFO - "script_repo_revision": "production", 07:38:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:38:09 INFO - "repository": "", 07:38:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:38:09 INFO - "buildid": "20161219062538", 07:38:09 INFO - "pgo_build": "False", 07:38:09 INFO - "basedir": "/builds/slave/test", 07:38:09 INFO - "buildnumber": 747, 07:38:09 INFO - "slavename": "talos-linux64-ix-069", 07:38:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:38:09 INFO - "platform": "ubuntu64_hw", 07:38:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:38:09 INFO - "branch": "mozilla-central", 07:38:09 INFO - "repo_path": "mozilla-central", 07:38:09 INFO - "revision": "c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e", 07:38:09 INFO - "stage_platform": "linux64", 07:38:09 INFO - "builduid": "84fe2c81c46b4e549e51840496f0f74f", 07:38:09 INFO - "slavebuilddir": "test" 07:38:09 INFO - } 07:38:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:38:09 INFO - Running post-action listener: _resource_record_post_action 07:38:09 INFO - [mozharness: 2016-12-19 15:38:09.341484Z] Finished read-buildbot-config step (success) 07:38:09 INFO - [mozharness: 2016-12-19 15:38:09.341574Z] Running download-and-extract step. 07:38:09 INFO - Running pre-action listener: _resource_record_pre_action 07:38:09 INFO - Running main action method: download_and_extract 07:38:09 INFO - mkdir: /builds/slave/test/build/tests 07:38:09 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')]} 07:38:09 INFO - trying https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:38:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:38:09 INFO - Downloaded 1361 bytes. 07:38:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:38:09 INFO - Using the following test package requirements: 07:38:09 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:09 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:38:09 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:38:09 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'jsshell-linux-x86_64.zip'], 07:38:09 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:38:09 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:09 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:38:09 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:38:09 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:38:09 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:38:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:38:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:38:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:38:10 INFO - Expected file size: 20258245 07:38:10 INFO - Obtained file size: 20258245 07:38:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:38:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:38:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:14 INFO - Fetch https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:38:15 INFO - Expected file size: 20258245 07:38:15 INFO - Obtained file size: 20258245 07:38:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:38:20 INFO - Fetch https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:38:20 INFO - Expected file size: 14409734 07:38:20 INFO - Obtained file size: 14409734 07:38: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')]} 07:38:21 INFO - trying https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:21 INFO - Downloading https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:38:22 INFO - Downloaded 55619921 bytes. 07:38:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:22 INFO - mkdir: /builds/slave/test/properties 07:38:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:22 INFO - Contents: 07:38:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:38:22 INFO - Running post-action listener: _resource_record_post_action 07:38:22 INFO - Running post-action listener: set_extra_try_arguments 07:38:22 INFO - [mozharness: 2016-12-19 15:38:22.793801Z] Finished download-and-extract step (success) 07:38:22 INFO - [mozharness: 2016-12-19 15:38:22.794008Z] Running populate-webroot step. 07:38:22 INFO - Running pre-action listener: _resource_record_pre_action 07:38:22 INFO - Running main action method: populate_webroot 07:38:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:22 INFO - '--tppagecycles', 07:38:22 INFO - '7'], 07:38:22 INFO - 'tests': ['tsvgm']}}, 07:38:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['damp', 'tps']}, 07:38:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'tests': ['damp', 'tps']}, 07:38:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['dromaeo_dom']}, 07:38:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['basic_compositor_video']}, 07:38:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:38:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['a11yr', 07:38:22 INFO - 'ts_paint', 07:38:22 INFO - 'tpaint', 07:38:22 INFO - 'sessionrestore', 07:38:22 INFO - 'sessionrestore_no_auto_restore', 07:38:22 INFO - 'tabpaint']}, 07:38:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:22 INFO - 'ts_paint', 07:38:22 INFO - 'tpaint', 07:38:22 INFO - 'sessionrestore', 07:38:22 INFO - 'sessionrestore_no_auto_restore', 07:38:22 INFO - 'tabpaint']}, 07:38:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:22 INFO - 'ts_paint', 07:38:22 INFO - 'tpaint', 07:38:22 INFO - 'sessionrestore', 07:38:22 INFO - 'sessionrestore_no_auto_restore', 07:38:22 INFO - 'tabpaint']}, 07:38:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:22 INFO - 'ts_paint', 07:38:22 INFO - 'tpaint', 07:38:22 INFO - 'sessionrestore', 07:38:22 INFO - 'sessionrestore_no_auto_restore', 07:38:22 INFO - 'tabpaint']}, 07:38:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['a11yr', 07:38:22 INFO - 'ts_paint', 07:38:22 INFO - 'tpaint', 07:38:22 INFO - 'sessionrestore', 07:38:22 INFO - 'sessionrestore_no_auto_restore', 07:38:22 INFO - 'tabpaint']}, 07:38:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['a11yr', 07:38:22 INFO - 'ts_paint', 07:38:22 INFO - 'tpaint', 07:38:22 INFO - 'sessionrestore', 07:38:22 INFO - 'sessionrestore_no_auto_restore', 07:38:22 INFO - 'tabpaint']}, 07:38:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['tsvgx', 07:38:22 INFO - 'tsvgr_opacity', 07:38:22 INFO - 'tart', 07:38:22 INFO - 'tscrollx', 07:38:22 INFO - 'cart', 07:38:22 INFO - 'tsvg_static']}, 07:38:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:22 INFO - 'tsvgr_opacity', 07:38:22 INFO - 'tart', 07:38:22 INFO - 'tscrollx', 07:38:22 INFO - 'cart', 07:38:22 INFO - 'tsvg_static']}, 07:38:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'talos_options': ['--disable-e10s'], 07:38:22 INFO - 'tests': ['tp5o']}, 07:38:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:38:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'talos_options': ['--disable-e10s', 07:38:22 INFO - '--xperf_path', 07:38:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:22 INFO - 'tests': ['tp5n']}, 07:38:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:38:22 INFO - 'talos_options': ['--xperf_path', 07:38:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:22 INFO - 'tests': ['tp5n']}}, 07:38:22 INFO - 'talos.zip': {'path': '', 07:38:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:22 INFO - Running post-action listener: _resource_record_post_action 07:38:22 INFO - [mozharness: 2016-12-19 15:38:22.808694Z] Finished populate-webroot step (success) 07:38:22 INFO - [mozharness: 2016-12-19 15:38:22.808782Z] Running create-virtualenv step. 07:38:22 INFO - Running pre-action listener: _resource_record_pre_action 07:38:22 INFO - Running main action method: create_virtualenv 07:38:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:22 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 07:38:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:22 INFO - Using real prefix '/usr' 07:38:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:25 INFO - Installing pip.................done. 07:38:25 INFO - Return code: 0 07:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:25 INFO - Reading from file tmpfile_stdout 07:38:25 INFO - Output received: 07:38:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:38:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:25 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')]} 07:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:25 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')]} 07:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:25 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:25 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 07:38:25 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 07:38:25 INFO - Using env: {'DISPLAY': ':0', 07:38:25 INFO - 'HOME': '/home/cltbld', 07:38:25 INFO - 'LANG': 'en_US.UTF-8', 07:38:25 INFO - 'LANGUAGE': 'en_US:en', 07:38:25 INFO - 'LOGNAME': 'cltbld', 07:38:25 INFO - 'MAIL': '/var/mail/cltbld', 07:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:25 INFO - 'MOZ_NO_REMOTE': '1', 07:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:25 INFO - 'NO_EM_RESTART': '1', 07:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:25 INFO - 'PWD': '/builds/slave/test', 07:38:25 INFO - 'SHELL': '/bin/bash', 07:38:25 INFO - 'SHLVL': '1', 07:38:25 INFO - 'TERM': 'linux', 07:38:25 INFO - 'TMOUT': '86400', 07:38:25 INFO - 'USER': 'cltbld', 07:38:25 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:25 INFO - '_': '/tools/buildbot/bin/python'} 07:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:25 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 07:38:25 INFO - Cleaning up... 07:38:25 INFO - Return code: 0 07:38:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:25 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')]} 07:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:25 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')]} 07:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:25 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:25 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 07:38:25 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 07:38:25 INFO - Using env: {'DISPLAY': ':0', 07:38:25 INFO - 'HOME': '/home/cltbld', 07:38:25 INFO - 'LANG': 'en_US.UTF-8', 07:38:25 INFO - 'LANGUAGE': 'en_US:en', 07:38:25 INFO - 'LOGNAME': 'cltbld', 07:38:25 INFO - 'MAIL': '/var/mail/cltbld', 07:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:25 INFO - 'MOZ_NO_REMOTE': '1', 07:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:25 INFO - 'NO_EM_RESTART': '1', 07:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:25 INFO - 'PWD': '/builds/slave/test', 07:38:25 INFO - 'SHELL': '/bin/bash', 07:38:25 INFO - 'SHLVL': '1', 07:38:25 INFO - 'TERM': 'linux', 07:38:25 INFO - 'TMOUT': '86400', 07:38:25 INFO - 'USER': 'cltbld', 07:38:25 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:25 INFO - '_': '/tools/buildbot/bin/python'} 07:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:26 INFO - Downloading/unpacking psutil>=3.1.1 07:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:28 INFO - Installing collected packages: psutil 07:38:28 INFO - Running setup.py install for psutil 07:38:28 INFO - building 'psutil._psutil_linux' extension 07:38:28 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 07:38:28 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 07:38:28 INFO - building 'psutil._psutil_posix' extension 07:38:28 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 07:38:28 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 07:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:28 INFO - Successfully installed psutil 07:38:28 INFO - Cleaning up... 07:38:28 INFO - Return code: 0 07:38:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:28 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:28 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 07:38:28 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 07:38:28 INFO - Using env: {'DISPLAY': ':0', 07:38:28 INFO - 'HOME': '/home/cltbld', 07:38:28 INFO - 'LANG': 'en_US.UTF-8', 07:38:28 INFO - 'LANGUAGE': 'en_US:en', 07:38:28 INFO - 'LOGNAME': 'cltbld', 07:38:28 INFO - 'MAIL': '/var/mail/cltbld', 07:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:28 INFO - 'MOZ_NO_REMOTE': '1', 07:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:28 INFO - 'NO_EM_RESTART': '1', 07:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:28 INFO - 'PWD': '/builds/slave/test', 07:38:28 INFO - 'SHELL': '/bin/bash', 07:38:28 INFO - 'SHLVL': '1', 07:38:28 INFO - 'TERM': 'linux', 07:38:28 INFO - 'TMOUT': '86400', 07:38:28 INFO - 'USER': 'cltbld', 07:38:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:28 INFO - '_': '/tools/buildbot/bin/python'} 07:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 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 07:38:28 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 07:38:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:30 INFO - Installing collected packages: mozsystemmonitor 07:38:30 INFO - Running setup.py install for mozsystemmonitor 07:38:31 INFO - Successfully installed mozsystemmonitor 07:38:31 INFO - Cleaning up... 07:38:31 INFO - Return code: 0 07:38:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:31 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:31 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 07:38:31 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 07:38:31 INFO - Using env: {'DISPLAY': ':0', 07:38:31 INFO - 'HOME': '/home/cltbld', 07:38:31 INFO - 'LANG': 'en_US.UTF-8', 07:38:31 INFO - 'LANGUAGE': 'en_US:en', 07:38:31 INFO - 'LOGNAME': 'cltbld', 07:38:31 INFO - 'MAIL': '/var/mail/cltbld', 07:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:31 INFO - 'MOZ_NO_REMOTE': '1', 07:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:31 INFO - 'NO_EM_RESTART': '1', 07:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:31 INFO - 'PWD': '/builds/slave/test', 07:38:31 INFO - 'SHELL': '/bin/bash', 07:38:31 INFO - 'SHLVL': '1', 07:38:31 INFO - 'TERM': 'linux', 07:38:31 INFO - 'TMOUT': '86400', 07:38:31 INFO - 'USER': 'cltbld', 07:38:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:31 INFO - '_': '/tools/buildbot/bin/python'} 07:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:33 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 07:38:33 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 07:38:33 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 07:38:33 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 07:38:33 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 07:38:33 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 07:38:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:33 INFO - warning: no files found matching '*.txt' 07:38:33 INFO - no previously-included directories found matching 'build' 07:38:33 INFO - no previously-included directories found matching 'dist' 07:38:33 INFO - no previously-included directories found matching '.git*' 07:38:33 INFO - Installing collected packages: jsonschema, functools32 07:38:33 INFO - Running setup.py install for functools32 07:38:33 INFO - warning: no files found matching '*.txt' 07:38:33 INFO - no previously-included directories found matching 'build' 07:38:33 INFO - no previously-included directories found matching 'dist' 07:38:33 INFO - no previously-included directories found matching '.git*' 07:38:33 INFO - Successfully installed jsonschema functools32 07:38:33 INFO - Cleaning up... 07:38:33 INFO - Return code: 0 07:38:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:33 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')]} 07:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:33 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')]} 07:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:33 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:33 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 07:38:33 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 07:38:33 INFO - Using env: {'DISPLAY': ':0', 07:38:33 INFO - 'HOME': '/home/cltbld', 07:38:33 INFO - 'LANG': 'en_US.UTF-8', 07:38:33 INFO - 'LANGUAGE': 'en_US:en', 07:38:33 INFO - 'LOGNAME': 'cltbld', 07:38:33 INFO - 'MAIL': '/var/mail/cltbld', 07:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:33 INFO - 'MOZ_NO_REMOTE': '1', 07:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:33 INFO - 'NO_EM_RESTART': '1', 07:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:33 INFO - 'PWD': '/builds/slave/test', 07:38:33 INFO - 'SHELL': '/bin/bash', 07:38:33 INFO - 'SHLVL': '1', 07:38:33 INFO - 'TERM': 'linux', 07:38:33 INFO - 'TMOUT': '86400', 07:38:33 INFO - 'USER': 'cltbld', 07:38:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:33 INFO - '_': '/tools/buildbot/bin/python'} 07:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:33 INFO - Cleaning up... 07:38:34 INFO - Return code: 0 07:38:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:34 INFO - Using env: {'DISPLAY': ':0', 07:38:34 INFO - 'HOME': '/home/cltbld', 07:38:34 INFO - 'LANG': 'en_US.UTF-8', 07:38:34 INFO - 'LANGUAGE': 'en_US:en', 07:38:34 INFO - 'LOGNAME': 'cltbld', 07:38:34 INFO - 'MAIL': '/var/mail/cltbld', 07:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:34 INFO - 'MOZ_NO_REMOTE': '1', 07:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:34 INFO - 'NO_EM_RESTART': '1', 07:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:34 INFO - 'PWD': '/builds/slave/test', 07:38:34 INFO - 'SHELL': '/bin/bash', 07:38:34 INFO - 'SHLVL': '1', 07:38:34 INFO - 'TERM': 'linux', 07:38:34 INFO - 'TMOUT': '86400', 07:38:34 INFO - 'USER': 'cltbld', 07:38:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:34 INFO - '_': '/tools/buildbot/bin/python'} 07:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:34 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 07:38:34 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 07:38:34 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 07:38:34 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 07:38:34 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 07:38:34 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 07:38:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 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 07:38:36 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 07:38:37 INFO - Downloading docopt-0.6.1.tar.gz 07:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:37 INFO - Running setup.py install for blobuploader 07:38:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:37 INFO - Running setup.py install for requests 07:38:37 INFO - Running setup.py install for docopt 07:38:37 INFO - Successfully installed blobuploader requests docopt 07:38:37 INFO - Cleaning up... 07:38:37 INFO - Return code: 0 07:38:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:37 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 07:38:37 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 07:38:37 INFO - Using env: {'DISPLAY': ':0', 07:38:37 INFO - 'HOME': '/home/cltbld', 07:38:37 INFO - 'LANG': 'en_US.UTF-8', 07:38:37 INFO - 'LANGUAGE': 'en_US:en', 07:38:37 INFO - 'LOGNAME': 'cltbld', 07:38:37 INFO - 'MAIL': '/var/mail/cltbld', 07:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:37 INFO - 'MOZ_NO_REMOTE': '1', 07:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:37 INFO - 'NO_EM_RESTART': '1', 07:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:37 INFO - 'PWD': '/builds/slave/test', 07:38:37 INFO - 'SHELL': '/bin/bash', 07:38:37 INFO - 'SHLVL': '1', 07:38:37 INFO - 'TERM': 'linux', 07:38:37 INFO - 'TMOUT': '86400', 07:38:37 INFO - 'USER': 'cltbld', 07:38:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:37 INFO - '_': '/tools/buildbot/bin/python'} 07:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:37 INFO - Running setup.py (path:/tmp/pip-8CSL40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:38 INFO - Running setup.py (path:/tmp/pip-j38QjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:38 INFO - Running setup.py (path:/tmp/pip-wGo7K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:38 INFO - Running setup.py (path:/tmp/pip-gIJqgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:38 INFO - Running setup.py (path:/tmp/pip-GaqOh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:38 INFO - Running setup.py (path:/tmp/pip-6tFIZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:38 INFO - Running setup.py (path:/tmp/pip-uSd2i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:38 INFO - Running setup.py (path:/tmp/pip-Hg9Sm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:38 INFO - Running setup.py (path:/tmp/pip-oxv1er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:38 INFO - Running setup.py (path:/tmp/pip-8NupXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:38 INFO - Running setup.py (path:/tmp/pip-6bMJxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:38 INFO - Running setup.py (path:/tmp/pip-wLAdwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:38 INFO - Running setup.py (path:/tmp/pip-VZSmWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:38 INFO - Running setup.py (path:/tmp/pip-HoKK1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:38 INFO - Running setup.py (path:/tmp/pip-TUqsHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:39 INFO - Running setup.py (path:/tmp/pip-VoEWKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:39 INFO - Running setup.py (path:/tmp/pip-3gSLrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:39 INFO - Running setup.py install for manifestparser 07:38:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Running setup.py install for mozcrash 07:38:39 INFO - Running setup.py install for mozdebug 07:38:39 INFO - Running setup.py install for mozdevice 07:38:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Running setup.py install for mozfile 07:38:39 INFO - Running setup.py install for mozhttpd 07:38:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Running setup.py install for mozinfo 07:38:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Running setup.py install for mozInstall 07:38:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:39 INFO - Running setup.py install for mozleak 07:38:40 INFO - Running setup.py install for mozlog 07:38:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Running setup.py install for moznetwork 07:38:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Running setup.py install for mozprocess 07:38:40 INFO - Running setup.py install for mozprofile 07:38:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Running setup.py install for mozrunner 07:38:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Running setup.py install for mozscreenshot 07:38:40 INFO - Running setup.py install for moztest 07:38:40 INFO - Running setup.py install for mozversion 07:38:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:40 INFO - Cleaning up... 07:38:40 INFO - Return code: 0 07:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:40 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')]} 07:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:40 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')]} 07:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:40 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:40 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 07:38:40 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 07:38:41 INFO - Using env: {'DISPLAY': ':0', 07:38:41 INFO - 'HOME': '/home/cltbld', 07:38:41 INFO - 'LANG': 'en_US.UTF-8', 07:38:41 INFO - 'LANGUAGE': 'en_US:en', 07:38:41 INFO - 'LOGNAME': 'cltbld', 07:38:41 INFO - 'MAIL': '/var/mail/cltbld', 07:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:41 INFO - 'MOZ_NO_REMOTE': '1', 07:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:41 INFO - 'NO_EM_RESTART': '1', 07:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:41 INFO - 'PWD': '/builds/slave/test', 07:38:41 INFO - 'SHELL': '/bin/bash', 07:38:41 INFO - 'SHLVL': '1', 07:38:41 INFO - 'TERM': 'linux', 07:38:41 INFO - 'TMOUT': '86400', 07:38:41 INFO - 'USER': 'cltbld', 07:38:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:41 INFO - '_': '/tools/buildbot/bin/python'} 07:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:41 INFO - Running setup.py (path:/tmp/pip-F7ut7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:41 INFO - Running setup.py (path:/tmp/pip-QQmvHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:41 INFO - Running setup.py (path:/tmp/pip-NXy24K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:41 INFO - Running setup.py (path:/tmp/pip-d7CW8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:41 INFO - Running setup.py (path:/tmp/pip-YNEfrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:41 INFO - Running setup.py (path:/tmp/pip-exB1Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:41 INFO - Running setup.py (path:/tmp/pip-4iFY0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:41 INFO - Running setup.py (path:/tmp/pip-x3hr5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:41 INFO - Running setup.py (path:/tmp/pip-kjBgxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:41 INFO - Running setup.py (path:/tmp/pip-v4OzzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:41 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)) 07:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:41 INFO - Running setup.py (path:/tmp/pip-y7BhsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:42 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)) 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:42 INFO - Running setup.py (path:/tmp/pip-IEjE_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:42 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)) 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:42 INFO - Running setup.py (path:/tmp/pip-zAcsbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:42 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)) 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:42 INFO - Running setup.py (path:/tmp/pip-wnpbsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:42 INFO - Running setup.py (path:/tmp/pip-jqh2QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:42 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)) 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:42 INFO - Running setup.py (path:/tmp/pip-JvbtGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:42 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)) 07:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:42 INFO - Running setup.py (path:/tmp/pip-7Lsi6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:42 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)) 07:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:42 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)) 07:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:42 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 07:38:42 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 07:38:42 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 07:38:42 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 07:38:42 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 07:38:42 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 07:38:44 INFO - Downloading blessings-1.6.tar.gz 07:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:44 INFO - Installing collected packages: blessings 07:38:44 INFO - Running setup.py install for blessings 07:38:44 INFO - Successfully installed blessings 07:38:44 INFO - Cleaning up... 07:38:44 INFO - Return code: 0 07:38:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:44 INFO - Reading from file tmpfile_stdout 07:38:44 INFO - Current package versions: 07:38:44 INFO - argparse == 1.2.1 07:38:44 INFO - blessings == 1.6 07:38:44 INFO - blobuploader == 1.2.4 07:38:44 INFO - docopt == 0.6.1 07:38:44 INFO - functools32 == 3.2.3-2 07:38:44 INFO - jsonschema == 2.5.1 07:38:44 INFO - manifestparser == 1.1 07:38:44 INFO - mozInstall == 1.12 07:38:44 INFO - mozcrash == 1.0 07:38:44 INFO - mozdebug == 0.1 07:38:44 INFO - mozdevice == 0.49 07:38:44 INFO - mozfile == 1.2 07:38:44 INFO - mozhttpd == 0.7 07:38:44 INFO - mozinfo == 0.9 07:38:44 INFO - mozleak == 0.1 07:38:44 INFO - mozlog == 3.4 07:38:44 INFO - moznetwork == 0.27 07:38:44 INFO - mozprocess == 0.23 07:38:44 INFO - mozprofile == 0.28 07:38:44 INFO - mozrunner == 6.13 07:38:44 INFO - mozscreenshot == 0.1 07:38:44 INFO - mozsystemmonitor == 0.3 07:38:44 INFO - moztest == 0.7 07:38:44 INFO - mozversion == 1.4 07:38:44 INFO - psutil == 3.1.1 07:38:44 INFO - requests == 1.2.3 07:38:44 INFO - wsgiref == 0.1.2 07:38:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:44 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 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:44 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 07:38:44 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 07:38:44 INFO - Using env: {'DISPLAY': ':0', 07:38:44 INFO - 'HOME': '/home/cltbld', 07:38:44 INFO - 'LANG': 'en_US.UTF-8', 07:38:44 INFO - 'LANGUAGE': 'en_US:en', 07:38:44 INFO - 'LOGNAME': 'cltbld', 07:38:44 INFO - 'MAIL': '/var/mail/cltbld', 07:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:44 INFO - 'MOZ_NO_REMOTE': '1', 07:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:44 INFO - 'NO_EM_RESTART': '1', 07:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:44 INFO - 'PWD': '/builds/slave/test', 07:38:44 INFO - 'SHELL': '/bin/bash', 07:38:44 INFO - 'SHLVL': '1', 07:38:44 INFO - 'TERM': 'linux', 07:38:44 INFO - 'TMOUT': '86400', 07:38:44 INFO - 'USER': 'cltbld', 07:38:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:44 INFO - '_': '/tools/buildbot/bin/python'} 07:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 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)) 07:38:45 INFO - Cleaning up... 07:38:45 INFO - Return code: 0 07:38:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:45 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')]} 07:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:45 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')]} 07:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', '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 07:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:38:45 INFO - Using env: {'DISPLAY': ':0', 07:38:45 INFO - 'HOME': '/home/cltbld', 07:38:45 INFO - 'LANG': 'en_US.UTF-8', 07:38:45 INFO - 'LANGUAGE': 'en_US:en', 07:38:45 INFO - 'LOGNAME': 'cltbld', 07:38:45 INFO - 'MAIL': '/var/mail/cltbld', 07:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:45 INFO - 'MOZ_NO_REMOTE': '1', 07:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:45 INFO - 'NO_EM_RESTART': '1', 07:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:45 INFO - 'PWD': '/builds/slave/test', 07:38:45 INFO - 'SHELL': '/bin/bash', 07:38:45 INFO - 'SHLVL': '1', 07:38:45 INFO - 'TERM': 'linux', 07:38:45 INFO - 'TMOUT': '86400', 07:38:45 INFO - 'USER': 'cltbld', 07:38:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:45 INFO - '_': '/tools/buildbot/bin/python'} 07:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:45 INFO - Cleaning up... 07:38:45 INFO - Return code: 0 07:38:45 INFO - Running post-action listener: _resource_record_post_action 07:38:45 INFO - Running post-action listener: _start_resource_monitoring 07:38:45 INFO - Starting resource monitoring. 07:38:45 INFO - [mozharness: 2016-12-19 15:38:45.432966Z] Finished create-virtualenv step (success) 07:38:45 INFO - [mozharness: 2016-12-19 15:38:45.433450Z] Running install step. 07:38:45 INFO - Running pre-action listener: _resource_record_pre_action 07:38:45 INFO - Running main action method: install 07:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:45 INFO - Reading from file tmpfile_stdout 07:38:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:45 INFO - Reading from file tmpfile_stdout 07:38:45 INFO - Output received: 07:38:45 INFO - Usage: mozinstall [options] installer 07:38:45 INFO - Options: 07:38:45 INFO - -h, --help show this help message and exit 07:38:45 INFO - -d DEST, --destination=DEST 07:38:45 INFO - Directory to install application into. [default: 07:38:45 INFO - "/builds/slave/test"] 07:38:45 INFO - --app=APP Application being installed. [default: firefox] 07:38:45 INFO - mkdir: /builds/slave/test/build/application 07:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:39:01 INFO - Reading from file tmpfile_stdout 07:39:01 INFO - Output received: 07:39:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:39:01 INFO - Running post-action listener: _resource_record_post_action 07:39:01 INFO - [mozharness: 2016-12-19 15:39:01.764631Z] Finished install step (success) 07:39:01 INFO - [mozharness: 2016-12-19 15:39:01.764941Z] Running run-tests step. 07:39:01 INFO - Running pre-action listener: _resource_record_pre_action 07:39:01 INFO - Running main action method: run_tests 07:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:01 INFO - Python 2.7.3 07:39:01 INFO - Return code: 0 07:39:01 INFO - grabbing minidump binary from tooltool 07:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:39:01 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 0x1fba850>, '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 0x1f2f6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:01 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 07:39:01 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 07:39:01 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 07:39:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:01 INFO - Return code: 0 07:39:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:39:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:39:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 07:39:01 INFO - Using env: {'DISPLAY': ':0', 07:39:01 INFO - 'HOME': '/home/cltbld', 07:39:01 INFO - 'LANG': 'en_US.UTF-8', 07:39:01 INFO - 'LANGUAGE': 'en_US:en', 07:39:01 INFO - 'LOGNAME': 'cltbld', 07:39:01 INFO - 'MAIL': '/var/mail/cltbld', 07:39:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:01 INFO - 'MOZ_NO_REMOTE': '1', 07:39:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:01 INFO - 'NO_EM_RESTART': '1', 07:39:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:01 INFO - 'PWD': '/builds/slave/test', 07:39:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:01 INFO - 'SHELL': '/bin/bash', 07:39:01 INFO - 'SHLVL': '1', 07:39:01 INFO - 'TERM': 'linux', 07:39:01 INFO - 'TMOUT': '86400', 07:39:01 INFO - 'USER': 'cltbld', 07:39:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125', 07:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:01 INFO - '_': '/tools/buildbot/bin/python'} 07:39:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:39:02 INFO - mozversion application_buildid: 20161219062538 07:39:02 INFO - mozversion application_changeset: c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e 07:39:02 INFO - mozversion application_display_name: Nightly 07:39:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:02 INFO - mozversion application_name: Firefox 07:39:02 INFO - mozversion application_remotingname: firefox 07:39:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:39:02 INFO - mozversion application_vendor: Mozilla 07:39:02 INFO - mozversion application_version: 53.0a1 07:39:02 INFO - mozversion platform_buildid: 20161219062538 07:39:02 INFO - mozversion platform_changeset: c23aa18ca56720d1fa630e30b1121a2e5d3d8d1e 07:39:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:39:02 INFO - mozversion platform_version: 53.0a1 07:39:02 INFO - using testdate: 1482161942 07:39:02 INFO - actual date: 1482161942 07:39:02 INFO - starting webserver on 'localhost:40485' 07:39:02 INFO - SUITE-START | Running 2 tests 07:39:02 INFO - TEST-START | dromaeo_css 07:39:02 INFO - operating with platform_type : linux_ 07:39:02 INFO - Initialising browser for dromaeo_css test... 07:39:02 INFO - TEST-INFO | started process 6088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT11x61/profile http://localhost:40485/getInfo.html) 07:39:06 INFO - PROCESS | 6088 | __metrics Screen width/height:1600/1200 07:39:06 INFO - PROCESS | 6088 | colorDepth:24 07:39:06 INFO - PROCESS | 6088 | Browser inner width/height: 1024/697 07:39:06 INFO - PROCESS | 6088 | __metrics 07:39:06 INFO - PROCESS | 6088 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:39:06 INFO - PROCESS | 6088 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:39:07 INFO - PROCESS | 6088 | console.error: PushService: 07:39:07 INFO - PROCESS | 6088 | stateChangeProcessEnqueue: Error transitioning state 07:39:07 INFO - PROCESS | 6088 | UnknownError 07:39:08 INFO - TEST-INFO | 6088: exit 0 07:39:08 INFO - Browser initialized. 07:39:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:08 INFO - TEST-INFO | started process 6170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT11x61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:20 INFO - PROCESS | 6170 | RSS: Main: 155283456 07:39:20 INFO - PROCESS | 6170 | 07:40:11 INFO - PROCESS | 6170 | 1482162011084 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] 07:42:25 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:40485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40485/tests/dromaeo/cssquery-ext.html) 07:42:27 INFO - PROCESS | 6170 | RSS: Main: 277643264 07:42:27 INFO - PROCESS | 6170 | 07:45:29 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:40485/tests/dromaeo/cssquery-ext.html (next: http://localhost:40485/tests/dromaeo/cssquery-jquery.html) 07:45:30 INFO - PROCESS | 6170 | RSS: Main: 253288448 07:45:30 INFO - PROCESS | 6170 | 07:48:33 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:40485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40485/tests/dromaeo/cssquery-mootools.html) 07:48:33 INFO - PROCESS | 6170 | RSS: Main: 223928320 07:48:33 INFO - PROCESS | 6170 | 07:51:35 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:40485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40485/tests/dromaeo/cssquery-prototype.html) 07:51:36 INFO - PROCESS | 6170 | RSS: Main: 190160896 07:51:36 INFO - PROCESS | 6170 | 07:54:39 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:40485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40485/tests/dromaeo/cssquery-yui.html) 07:54:40 INFO - PROCESS | 6170 | RSS: Main: 190767104 07:54:40 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | Cycle 1(1): loaded http://localhost:40485/tests/dromaeo/cssquery-yui.html (next: http://localhost:40485/tests/dromaeo/cssquery-dojo.html) 07:57:43 INFO - PROCESS | 6170 | RSS: Main: 282222592 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | __start_tp_report 07:57:43 INFO - PROCESS | 6170 | _x_x_mozilla_page_load 07:57:43 INFO - PROCESS | 6170 | _x_x_mozilla_page_load_details 07:57:43 INFO - PROCESS | 6170 | |i|pagename|runs| 07:57:43 INFO - PROCESS | 6170 | |0;dojo.html;2614.4117573545955;2646.8279561828467;2674.5720684690446;2691.3675286307716;2694.232143839005;4681.719096854191;4694.671373003891;4740.9762951185285;4758.428988521382;4792.329073929648;4714.245720684691;4715.646326525516;4769.260764581487;4769.546893045163;4828.879278018051;4325.545817689144;4332.740035597859;4368.366586844905;4414.4923333816705;4439.644828413735;4062.9121281688163;4390;4490.528494508078;4516.435445569304;4573.062522182944;4308.310670292738;4348.304271316574;4455.710378825366;4473.977630111861;4511.210538155826;4387.62705170061;4387.934180987288;4399.912001759979;4407.647388208936;4408.4709834819705;4365.563443655641;4375.7374557526655;4378.868633940955;4390.692651514395;4391.604755572014;4753.524647535253;4767.976160119212;4770.045990801854;4774.379330687023;4783.4499032611;5055.342805435306;5144.0740666679985;5180.4042535108565;5186.273921650972;5201.973990130063;5150.047241260341;5154.175331946871;5158.097332966716;5160.329157209576;5206.453322401169;4638.2115040443205;4751.121042607128;4806.327114204014;4810.542998415215;4811.879703007453;5090.618203634742;5178.715170665574;5207.843764687065;5245.449227831099;5256.92114618281;5046.369203849519;5056.317397151338;5056.747162641853;5060.924086138711;5069.138246498104;5159.561437277798;5160.896782064413;5161.974190129025;5165.793368265227;5208.244804503326;4948.604111671058;4984.975075124674;4987.900241995139;5085.059264036166;5120.231965205175;5103.770330335144;5162.328897243335;5215.191645294985;5216.504432078947;5218.243354713545;4446.777661116931;4457.3091170868565;4457.398251236106;4463.263561512379;4500.819967201341;3797.411401232758;3873.9612603874166;3879;3899.1421887184774;3916.3146449371247;4350.869473915787;4362.149380870763;4370.694051416371;4381.890452738643;4388.956110438919;5166.870828229325;5168.61235407346;5176.1459359206065;5179.326687530597;5221.503957124067;4360.040791025969;4391.67062470316;4398.824047038082;4427.40230068943;4442.733435993786;4508.549145085531;4516.977415112903;4555.248384016666;4648.302754586772;4652.883677908079;4786.210275304536;4852.393450818648;4858.489858564941;4884.072026314989;4895.314655948099;5186.377634683862;5193.636445448782;5200.5059519345605;5202.947970520398;5247.08176069194;4607.861764147081;4641.535846415331;4843.297721830385;4858.222684370625;4904.337914381513;4956.876078097932;4979.203327467588;4997.125503036881;5023.045621331935;5076.6446348755235;5080.983803239441;5088.262201980766;5092.796288148433;5093.337866077386;5137.049645815536;4827.155247831685;4850.466448690711;4922.384701912261;4968.080905032581;4972.577330926912;4918.48355922623;4918.827841025547;4922.680025798311;4926.4088309403105;4997.800087996439;4845.63657725665;4868.829590964299;4877.341558889504;4899.902001960012;4925.1627223372825;4831.468538460696;4995.500449954975;5004.674696144739;5007.524285192901;5047.965167140654;4734.195186818318;4920.409550853778;4940.308356830118;4958.454569997225;5020.096382651158 07:57:43 INFO - PROCESS | 6170 | |1;ext.html;521.5801279969625;537.7015756255277;547.6905548365173;552.9032419326617;557.8716895114126;27473.725262747368;36174.2765144697;37207.44188837169;37309.06727331818;40926;40175.397369039485;40685;40703.79648101763;40710.18579628406;40755.18489630205;7535.811604709885;7700.730474433396;7701.383889288843;7706.576138312391;7714.922850771477;7378;7565;9662.227021838236;9878.110970012698;9880.95059524705;10014.749631259205;10102.343347682414;10103.292769506137;10103.747406314827;10104.090631843133;9943.502824858764;9982.600695972153;9990.950045249727;10004.699859004242;10010.1491373233;9629.374090684083;9688.75778105553;9697.66058187967;9698.806023879482;9706.514674266258;37187.628123718954;37509.62490375089;37530;37530.249395011946;37564.81217593895;2720.183944816547;3091.922701932447;3351.7821341612716;3383.3233353329433;3417.265287963075;28087.297817554725;28207.858960705064;28262.858685706644;28323.858380707963;28409.715902840915;3262.3801477719157;3299.5215693724517;3309.12308238317;3331.9500207496662;3362.193073662328;245747;246847;247918.9999999982;248117;248682;45301.546984529734;45757.77121114373;45854.54145458503;45900;45902.5409745905;48494;48600.270995934385;48631.75684121557;48639.270410943864;48684.75657621689;13672.384742686603;13917.23455209953;13946.930265348608;13949.721005580035;13950.302484875716;9403.247740180768;9557.856632150524;10403.375797452178;10461.163106951426;10468.947655261827;14954.925225373803;15101.924490377478;15298.158601276815;15771.921140394224;15873.920630396775;6211.378862113753;6241.21984751906;6286.151369565142;6299.464545513591;6371.960972488851;714.7641278378122;789.8854666073387;884.6505630276005;899.2266650680409;935.9859602105973;27109.72890271072;27608;27663.58504622432;27995.580066299022;28079;845.8392905347964;953.1564565359567;959.6737109382843;963.012911765432;969.7139343893568;14346.49787257441;14660.486882959258;14868.992601701859;14885.404583816526;15068.849311506963;369687;400885;406807;407844;628440;43112.56887431148;43594.78202608967;43602.78198608987;43680.56319436828;43689.34465983013;1127.6786115956913;1157.670064031747;1161.1233518693332;1164.557468162093;1174.671092094215;24959.01639344277;25894.1738108924;26276.343091422867;26337.341566460993;26696.466070678867;37256.44115338218;37787.62212377951;37800.243995119396;37801;37827.24345513129;314609;317538;317916;318105;318204;20776.480587984817;21548.67676984878;23424.882875585514;23863.880680596485;23867;36863.81568092143;36934.815325924275;37773.24453510859;39953.2009359817;41193;30914.69085309208;31156.532652009784;31201.219969500944;31262.218444539067;32657.836710816293;31033.379332412773;31239.68760312368;31294.68705313009;31377.372452551277;32350.352992939537;31363;31689.36621267608;31852.203694907814;31894.68105318917;32236;26984.66272894212;28960.855195723885;28977;29267.853660731562;29575;22380.888095559418;22768.88615556978;22801.657975130056;23044.884775576684;23114.884425577766 07:57:43 INFO - PROCESS | 6170 | |2;jquery.html;338.4804325360572;350.5407915630526;362.18869731800766;370.3075249283839;377.7534137346755;12235.204711693745;15510.999999999985;15600.531984040483;16706.916465417686;16782.58043548909;15945.123018233993;16048.83951160488;16633.41783037594;16762.161891905387;16769.496915092535;4814.54261845125;4860.854174374756;4966.701997880139;5022.773975171126;5058.165402708567;3635.8363873625617;3811.085339518523;4911.778969946361;5006.023825354057;5006.949930500703;5648.74580643872;5872.853178670524;5897.793577224798;5956.88086238275;5960.403959604048;5701.515371193454;5847;5877.147813567009;5925.377835327272;5927.4961628261435;5189.688618682853;5193.272941788153;5194.37667479901;5195.870103247449;5197.194434862602;20141.79858201414;20482.897585512124;20596;20601.58796824055;20618.17527298906;1889.3387314439974;1893.8011508791653;1952.463072655017;2112.3346145963974;2273.5680220758168;12192.13484831064;13062.216267024009;13295.800562991562;13572;13636;1678.2951160512614;1714.1429285357322;1714.8885322454125;1785.1877395784886;1805.6930321845186;64693.3530664692;65497;67118;68029.3197068028;68164.6591767043;9444.386114902509;9621.470819104876;9622.182114520345;9700.27247956406;9918.30571859963;13103.475860965646;13162.736745265041;13184.670383240304;13192.274424906722;13193.274369909746;7291.781246562611;7378.299061589248;7426.517276377018;7601.467897247139;7622.237776222333;7159.3914517265575;7240.818979525448;7389.482736208522;7444.627768611548;7464.328210461084;5327.467253274642;5668.744906479218;5675.262215911905;5941.881162376728;6047.274327080779;1679.6497072582072;1752.929882804699;1782.7236778299384;1860.7860096088853;1889.2443022790994;724.8550289942033;769.2000319667483;797.7726347990911;812.2770734046703;875.1205038935828;16241.106739129225;17020.829791702174;17604.295828166985;18437.26250949974;18656.34702785423;786.241277167536;800.6317094136763;826.2068414322198;841.7643059943103;855.3755758296478;9768.609255629837;9887.901120988841;10319.896801032044;10355.482225888676;10359.585616575403;333623;333837;337760;338852;339810;66494;67513;75845;77832.05419864436;79725;912.2291663544295;932.7994481186578;969.2875736333789;970.6117552978724;974.055166488505;15331.693366132838;15401.30694118745;16027.198640068184;16236.26936787871;16340.836591633932;28499.43001140007;34810.82594587011;35650.8217458911;35804;36380.81809590935;43871.56128438675;48891.16461271527;48993.510064898896;51462.48537514577;52437.21344179917;7590.886136708064;7623.69505219785;7669.7315593953945;7760.92239077602;7951.721689740832;10109.64616238428;11766;11788.70528236801;11869.643910682693;12232.938835306122;9918.504074796376;10110.494475276353;10353.844692329772;10491.160707143563;10662.946685266525;9855.901440985499;9967.50162491858;10102;10282.897171028493;10302.381857088598;10200.28597998133;10212.438315892698;10446.843297350697;10679.19906007037;10711.678649640524;7527.736529221451;7543.321101100927;7679.347255483346;7712.460127791001;8045.87931181021;7877.566733829465;9255.25957923378;9790.363626364264;10462.68611941643;10508.740620766572 07:57:43 INFO - PROCESS | 6170 | |3;mootools.html;1308.3065975033232;1312.7571399291128;1390.791381292806;1605.3658804772108;1646.275638718963;7063.187733410659;7516.774496765106;7521.924780752191;7525.0217471728665;7528.736494222697;6392.392722691348;6570.901436478444;6574.704138313776;6685;7392.33468987791;1852.7776666799969;2099.32821497121;2157.11558261113;2170.6201414752436;2183.9344819655435;2147.5490147069136;2177.553601511694;2181.890905454729;2187.2891310324208;2192.013593882751;2142.646463333556;2153.6123497770395;2164.31823975448;2168.609650262952;2169.9132034718673;2023.6155130525153;2043.0806137238228;2115.820155286787;2119.6926445665445;2122.628540005493;2070.730804995356;2072.3990042887544;2102.8212601928853;2106.31544747956;2110.8416868734753;7377;7528.510646807995;7536.585487798169;7538;7540.095188577406;4383.3863259143745;4541.545845415432;4546.636269098497;4548.476925153616;4553.635709143261;2786.205931309567;2968.5695574141846;3033.3326668133195;3034.9696503034907;3035.332226910098;876.145757886056;927.7866090799087;935.0976307862877;935.1677007463363;936.3585943628636;9456.432614043111;9660.37207581505;9677.129058384779;9952.4028558286;9975.501224938796;3785.886423407302;3871.4192871069563;3967.107400834847;3984.780837053932;4009.278329900588;7674.846503069907;7675.808104797425;7685.154632990367;7685.5004424712215;7696.576688282198;4487.528809475023;4487.6185524230805;4490.101979604092;4491.461024676994;4493.707908985905;4057.208844275338;4194.853180138681;4195.265828480004;4198.181354635817;4202.453681021509;3075.108218616621;3120.251139726495;3176.364727054552;3208.4385232584204;3284.293876816496;939.4785893828854;940.7365937537501;946.7964387656687;950.3680052764972;958.6836344006462;634.5494698763929;799.9960000199961;803.6504120707511;804.5558222989631;827.148037521354;4848.854534363974;4881.829135980294;4973.726445045485;5022.7990880365105;5327.067763141435;400.12772156698094;403.95758445362816;410.57300407575786;412.6574942797471;854.6068808348106;3309.586301712286;3332.666733326648;3343.264481813997;3357.84889679965;3580.7314451415727;8790;8854.557272136368;8985.415947963493;8989.146031127033;8990.056044115405;8880.378373513791;8914.197722205032;8924.062973387701;8948.642054317754;8995.865062024075;6661.666916654148;6744.7976560703255;6747.628880411527;6754.18949726036;6917.861642767217;4797.304390863375;4819.373481447389;4838.080764654705;4889.339939108318;5029.748512574283;8257.79355516117;8270.503769773833;8346.33229341639;8419.8737018946;8456.704015359433;8076.515409075474;8331.041930178108;8336.958315208627;8339.749807505785;8475.279601233964;6249.6562689052535;6424.710888010144;6722.294159113223;6832.111825462658;6935.826604334932;6881.41507971828;7151.60666163366;7151.642417879189;7155.248698886542;7155.642217889189;6350.142730731477;6423.389777971085;6431.646259455775;6474.70863811139;6511.218653761579;6227.688615569294;6251.937480625135;6284.5600807943;6344.460720838781;6367.681615919279;5932.851678708067;6031.728572214349;6097.695115244132;6104.877902441837;6113.14415981754;4477.485089214651;4504.211762941538;4552.11233809404;4559.794809233526;4559.794809233659;4376.431063961664;4428.601425871687;4506.1663592235545;4514.0152894066305;4617.307403889309 07:57:43 INFO - PROCESS | 6170 | |4;prototype.html;338.84921210061515;347.92519608284215;349.0297567698882;355.307151055442;356.04934824019864;4810.687305325151;4819.638527110467;4834.564889159979;4854.8300809471675;4865.805367785284;4533.501314855372;4602.171609110359;4658.930116048262;4699.248120300753;4760.262159365296;3824.120452295974;3844.0966372902344;3844.2311537692435;3847.7498962567483;3855.7686538807693;3847.999520124774;3868.4390763339297;3872.961270387302;3876.9806150969207;3880.20455806559;3669.1377526281303;3723.869664561741;3774.67915227206;3815.313243616148;3859.864904728335;3831.1571454280015;3838.7120965927666;3854.6530812226893;3858.884233472972;3861.6331448512487;3412.7269818414466;3418.5555877735983;3459.9481007784902;3462.722982161421;3467.133216695826;4526.592606665416;4634.165850146972;4635.95364046362;4665.020345727401;4691.601213896823;4335.547591556832;4396.582324679151;4399.582039706254;4403.933940990888;4410.889727756799;4986.351774269358;4997.5002499749735;5014.974925125351;5019.4227663818765;5040.84877453677;3757.154640205959;3786.5266841644793;3791.4312853071983;3796.9430458543143;3797.4303854421782;5020.347354843847;5203.505666961632;5226.242194881721;5231.581473482112;5260.158374660036;3886.5336159661024;3892.8905262000762;3893.8637147699696;3894.668953139015;3908.687305015592;3929.3713005918917;3942.6057394260342;3945.546262179829;3951.703622228287;3960.20795840833;4157.230912281238;4365.628921541705;4391.572738859883;4426.3581780641625;4431.964104588367;4999.575036121971;5011;5020.93722829074;5030.522100400456;5031.974840125849;1286.7683816913045;1336.8863646590148;1346.9528566500126;1354.4446776821653;1356.830396200475;923.4505469245788;937.723371605378;969.8448248280382;981.9459929703792;984.7882705218412;4248.851290204828;4292.163028209469;4300.3549467580115;4310.698251122391;4310.7629080400875;4988.201887697951;5006.774695138727;5010;5012.273220383024;5029.139218489182;4178.686598505064;4277.978610106929;4313.288307429302;4403.625691816167;4466.146549182118;2679.303381120884;2684.778425816288;2688.9378695415203;2692.3807524269137;2701.8108732388546;4751.619870410428;4753.862450782536;4775.785089670973;4813.807447702053;4819.361417118197;5038.395392552844;5211.7915283389;5225.50357716024;5233.581313494988;5254.6847189168775;4734.502877197845;4773.0453909218295;4780.426348838092;4786.64100192487;4792.2811578262845;5045.31888195089;5058.848234552969;5063.721495317793;5093.516115968977;5107.336046313955;4735.692180008288;4952.059108769322;4960.578350840219;4964.453910069961;4990.476000019946;4731.503192164911;4742.810287588458;4771.093492236464;4779.737114458738;4791.520847915181;3513.9648603513638;3545.397282462039;3556.288742251508;3565.180008598089;3569.268299998546;4822.662413631012;5053.065182941167;5063.493650634907;5065.39215294167;5095.477738519457;4894.92657610129;4906.313116163668;4916.655834091579;4951.212322573307;4963.627727920348;4879.658423910292;4905.877353066202;4908.828191013297;4917.188663870565;4921.8523444296725;4597.149527337453;4765.571098601143;4816.8554943351755;4833.3958255218095;4843.4430040545785;4962.255661650637;4985.3020577118505;5096.745162741774;5102.617303702163;5107.9233811493605;5000;5001.174806157089;5006.624503162205;5006.721941516674;5006.974965125151 07:57:43 INFO - PROCESS | 6170 | |5;yui.html;580.7996241296754;611.6635850282346;622.4491325177219;681.550176883257;693.1128155960372;11588.362640054793;12374.319412432313;12451.941584965289;12521.749565008706;13368.532101376453;12388.31864247466;12476.189047711892;12763.936180319086;12771.361431928413;12777.552785652504;727.3671905442272;748.842743023963;751.1849643137202;751.3688501658605;751.5978951261077;597.9611325263866;616.1404840247851;734.6583838515089;753.9623018849063;760.794585461925;802.5465611929242;803.4697099914058;805.1666525146475;805.6334367862638;805.730080423059;793.1235984237393;793.6031984007996;793.6745934166993;794.1105961323298;794.3724457678427;465.5205138707137;474.9905001899943;566.057514238796;582.123903525196;584.7397907930972;12906.548270810477;13031.674208144777;13169.144005639602;13222.933885330607;13315.733685326239;12166.756664866742;12437.875621243762;12814.23114613117;12829.67925801853;12945.935270323587;11400.030997365235;11404.714882128013;11438.828417573659;11487.725998090504;11504.827427588592;3946.782926939017;4011.4183443400543;4059.97970010151;4082.4692789937417;4117.814698338582;62771.68614156946;62939;63936.68031659812;64009.359906401274;64504.677476612786;9133.315001374924;9253.537323133816;9705.12653861156;9824.950875245579;9847.704568862946;17797.377091801725;18127.18427670758;18159;18162.182701778453;18170.818291817177;6242.188515492957;6242.563020588515;6254.468370188494;6415.903761443582;6455;3499.825008749552;3500.5274287971306;3531.3820081485637;3571.6428357164077;3597.244578638515;2853.4721076600895;2950.498415269409;2950.645922489315;2953.7784666149696;2962.333474968158;520.8932168905366;529.3568314497903;531.7979167916167;532.3000254665103;535.2426316761738;550.9834704958857;565.9830205093854;578.5660754434174;578.8972008324149;586.3725813379643;7455.664495097733;8031.277185053374;8082.31300339466;8198.303144232807;8200.876986845202;559.5076332827086;578.2569398323135;589.4635881347953;601.5127746525241;611.4680228201494;3543.078799512094;3777.320082385197;3821.293060783764;3857.8456861725776;3984.6613037891525;50087.49912500901;54428.45571544234;63284.36715632785;64327.67836160789;67216.6639166801;56480.717596411756;59000.7049964756;59772.40227597668;60428.39571604228;60570;43735;49452.50547494551;51073.233901491505;53028.46971530312;53045.469545304055;7071.25751796054;7165.964170179116;7378.520396174232;7512.812179695551;7583.658735356812;35709.46435803517;36556.26887462289;36632.08419789527;36873;38602.80698596489;43795;47778.28332574945;48121.278180826615;50204.74897625489;50457.24314135365;9129.77175570616;9333.533323333942;9618.374805637612;9630.614775409185;9711.854322185032;10118.8482172766;10145.08694217524;10219;10441.947790261;10531.73670658209;9028;9884.950575247365;9959.302848800515;10309.896901031194;11043.668689939315;10547.683569492927;11296.887031129583;11390.487428065591;11431.142664300378;11703.941480292544;11031.779364412827;11056.944715276693;11119.888801111885;11333.773324533298;11656.650300491;9069;9134.680286189952;9296.349255552046;9569.468600959994;9695.418274903528;9620.663276785279;9785.657501987396;9845.85231221518;9877.40735555869;9897.158741507052 07:57:43 INFO - PROCESS | 6170 | __end_tp_report 07:57:43 INFO - PROCESS | 6170 | __start_cc_report 07:57:43 INFO - PROCESS | 6170 | _x_x_mozilla_cycle_collect,1300 07:57:43 INFO - PROCESS | 6170 | __end_cc_report 07:57:43 INFO - PROCESS | 6170 | __startTimestamp1482163063758__endTimestamp 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | ------- Summary: start ------- 07:57:43 INFO - PROCESS | 6170 | Number of tests: 6 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | [#0] dojo.html Cycles:165 Average:4728.95 Median:4845.64 stddev:495.03 (10.2%) stddev-sans-first:467.93 07:57:43 INFO - PROCESS | 6170 | Values: 2614.4 2646.8 2674.6 2691.4 2694.2 4681.7 4694.7 4741.0 4758.4 4792.3 4714.2 4715.6 4769.3 4769.5 4828.9 4325.5 4332.7 4368.4 4414.5 4439.6 4062.9 4390.0 4490.5 4516.4 4573.1 4308.3 4348.3 4455.7 4474.0 4511.2 4387.6 4387.9 4399.9 4407.6 4408.5 4365.6 4375.7 4378.9 4390.7 4391.6 4753.5 4768.0 4770.0 4774.4 4783.4 5055.3 5144.1 5180.4 5186.3 5202.0 5150.0 5154.2 5158.1 5160.3 5206.5 4638.2 4751.1 4806.3 4810.5 4811.9 5090.6 5178.7 5207.8 5245.4 5256.9 5046.4 5056.3 5056.7 5060.9 5069.1 5159.6 5160.9 5162.0 5165.8 5208.2 4948.6 4985.0 4987.9 5085.1 5120.2 5103.8 5162.3 5215.2 5216.5 5218.2 4446.8 4457.3 4457.4 4463.3 4500.8 3797.4 3874.0 3879.0 3899.1 3916.3 4350.9 4362.1 4370.7 4381.9 4389.0 5166.9 5168.6 5176.1 5179.3 5221.5 4360.0 4391.7 4398.8 4427.4 4442.7 4508.5 4517.0 4555.2 4648.3 4652.9 4786.2 4852.4 4858.5 4884.1 4895.3 5186.4 5193.6 5200.5 5202.9 5247.1 4607.9 4641.5 4843.3 4858.2 4904.3 4956.9 4979.2 4997.1 5023.0 5076.6 5081.0 5088.3 5092.8 5093.3 5137.0 4827.2 4850.5 4922.4 4968.1 4972.6 4918.5 4918.8 4922.7 4926.4 4997.8 4845.6 4868.8 4877.3 4899.9 4925.2 4831.5 4995.5 5004.7 5007.5 5048.0 4734.2 4920.4 4940.3 4958.5 5020.1 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | [#1] ext.html Cycles:180 Average:47309.14 Median:3320.54 stddev:92772.53 (2793.9%) stddev-sans-first:92966.28 07:57:43 INFO - PROCESS | 6170 | Values: 521.6 537.7 547.7 552.9 557.9 27473.7 36174.3 37207.4 37309.1 40926.0 40175.4 40685.0 40703.8 40710.2 40755.2 7535.8 7700.7 7701.4 7706.6 7714.9 7378.0 7565.0 9662.2 9878.1 9881.0 10014.7 10102.3 10103.3 10103.7 10104.1 9943.5 9982.6 9991.0 10004.7 10010.1 9629.4 9688.8 9697.7 9698.8 9706.5 37187.6 37509.6 37530.0 37530.2 37564.8 2720.2 3091.9 3351.8 3383.3 3417.3 28087.3 28207.9 28262.9 28323.9 28409.7 3262.4 3299.5 3309.1 3332.0 3362.2 245747.0 246847.0 247919.0 248117.0 248682.0 45301.5 45757.8 45854.5 45900.0 45902.5 48494.0 48600.3 48631.8 48639.3 48684.8 13672.4 13917.2 13946.9 13949.7 13950.3 9403.2 9557.9 10403.4 10461.2 10468.9 14954.9 15101.9 15298.2 15771.9 15873.9 6211.4 6241.2 6286.2 6299.5 6372.0 714.8 789.9 884.7 899.2 936.0 27109.7 27608.0 27663.6 27995.6 28079.0 845.8 953.2 959.7 963.0 969.7 14346.5 14660.5 14869.0 14885.4 15068.8 369687.0 400885.0 406807.0 407844.0 628440.0 43112.6 43594.8 43602.8 43680.6 43689.3 1127.7 1157.7 1161.1 1164.6 1174.7 24959.0 25894.2 26276.3 26337.3 26696.5 37256.4 37787.6 37800.2 37801.0 37827.2 314609.0 317538.0 317916.0 318105.0 318204.0 20776.5 21548.7 23424.9 23863.9 23867.0 36863.8 36934.8 37773.2 39953.2 41193.0 30914.7 31156.5 31201.2 31262.2 32657.8 31033.4 31239.7 31294.7 31377.4 32350.4 31363.0 31689.4 31852.2 31894.7 32236.0 26984.7 28960.9 28977.0 29267.9 29575.0 22380.9 22768.9 22801.7 23044.9 23114.9 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | [#2] jquery.html Cycles:180 Average:22637.66 Median:4837.70 stddev:55795.95 (1153.4%) stddev-sans-first:55927.35 07:57:43 INFO - PROCESS | 6170 | Values: 338.5 350.5 362.2 370.3 377.8 12235.2 15511.0 15600.5 16706.9 16782.6 15945.1 16048.8 16633.4 16762.2 16769.5 4814.5 4860.9 4966.7 5022.8 5058.2 3635.8 3811.1 4911.8 5006.0 5006.9 5648.7 5872.9 5897.8 5956.9 5960.4 5701.5 5847.0 5877.1 5925.4 5927.5 5189.7 5193.3 5194.4 5195.9 5197.2 20141.8 20482.9 20596.0 20601.6 20618.2 1889.3 1893.8 1952.5 2112.3 2273.6 12192.1 13062.2 13295.8 13572.0 13636.0 1678.3 1714.1 1714.9 1785.2 1805.7 64693.4 65497.0 67118.0 68029.3 68164.7 9444.4 9621.5 9622.2 9700.3 9918.3 13103.5 13162.7 13184.7 13192.3 13193.3 7291.8 7378.3 7426.5 7601.5 7622.2 7159.4 7240.8 7389.5 7444.6 7464.3 5327.5 5668.7 5675.3 5941.9 6047.3 1679.6 1752.9 1782.7 1860.8 1889.2 724.9 769.2 797.8 812.3 875.1 16241.1 17020.8 17604.3 18437.3 18656.3 786.2 800.6 826.2 841.8 855.4 9768.6 9887.9 10319.9 10355.5 10359.6 333623.0 333837.0 337760.0 338852.0 339810.0 66494.0 67513.0 75845.0 77832.1 79725.0 912.2 932.8 969.3 970.6 974.1 15331.7 15401.3 16027.2 16236.3 16340.8 28499.4 34810.8 35650.8 35804.0 36380.8 43871.6 48891.2 48993.5 51462.5 52437.2 7590.9 7623.7 7669.7 7760.9 7951.7 10109.6 11766.0 11788.7 11869.6 12232.9 9918.5 10110.5 10353.8 10491.2 10662.9 9855.9 9967.5 10102.0 10282.9 10302.4 10200.3 10212.4 10446.8 10679.2 10711.7 7527.7 7543.3 7679.3 7712.5 8045.9 7877.6 9255.3 9790.4 10462.7 10508.7 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | [#3] mootools.html Cycles:180 Average:4822.83 Median:6064.71 stddev:2644.80 (43.6%) stddev-sans-first:2639.03 07:57:43 INFO - PROCESS | 6170 | Values: 1308.3 1312.8 1390.8 1605.4 1646.3 7063.2 7516.8 7521.9 7525.0 7528.7 6392.4 6570.9 6574.7 6685.0 7392.3 1852.8 2099.3 2157.1 2170.6 2183.9 2147.5 2177.6 2181.9 2187.3 2192.0 2142.6 2153.6 2164.3 2168.6 2169.9 2023.6 2043.1 2115.8 2119.7 2122.6 2070.7 2072.4 2102.8 2106.3 2110.8 7377.0 7528.5 7536.6 7538.0 7540.1 4383.4 4541.5 4546.6 4548.5 4553.6 2786.2 2968.6 3033.3 3035.0 3035.3 876.1 927.8 935.1 935.2 936.4 9456.4 9660.4 9677.1 9952.4 9975.5 3785.9 3871.4 3967.1 3984.8 4009.3 7674.8 7675.8 7685.2 7685.5 7696.6 4487.5 4487.6 4490.1 4491.5 4493.7 4057.2 4194.9 4195.3 4198.2 4202.5 3075.1 3120.3 3176.4 3208.4 3284.3 939.5 940.7 946.8 950.4 958.7 634.5 800.0 803.7 804.6 827.1 4848.9 4881.8 4973.7 5022.8 5327.1 400.1 404.0 410.6 412.7 854.6 3309.6 3332.7 3343.3 3357.8 3580.7 8790.0 8854.6 8985.4 8989.1 8990.1 8880.4 8914.2 8924.1 8948.6 8995.9 6661.7 6744.8 6747.6 6754.2 6917.9 4797.3 4819.4 4838.1 4889.3 5029.7 8257.8 8270.5 8346.3 8419.9 8456.7 8076.5 8331.0 8337.0 8339.7 8475.3 6249.7 6424.7 6722.3 6832.1 6935.8 6881.4 7151.6 7151.6 7155.2 7155.6 6350.1 6423.4 6431.6 6474.7 6511.2 6227.7 6251.9 6284.6 6344.5 6367.7 5932.9 6031.7 6097.7 6104.9 6113.1 4477.5 4504.2 4552.1 4559.8 4559.8 4376.4 4428.6 4506.2 4514.0 4617.3 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | [#4] prototype.html Cycles:180 Average:4171.78 Median:4733.00 stddev:1160.67 (24.5%) stddev-sans-first:1127.71 07:57:43 INFO - PROCESS | 6170 | Values: 338.8 347.9 349.0 355.3 356.0 4810.7 4819.6 4834.6 4854.8 4865.8 4533.5 4602.2 4658.9 4699.2 4760.3 3824.1 3844.1 3844.2 3847.7 3855.8 3848.0 3868.4 3873.0 3877.0 3880.2 3669.1 3723.9 3774.7 3815.3 3859.9 3831.2 3838.7 3854.7 3858.9 3861.6 3412.7 3418.6 3459.9 3462.7 3467.1 4526.6 4634.2 4636.0 4665.0 4691.6 4335.5 4396.6 4399.6 4403.9 4410.9 4986.4 4997.5 5015.0 5019.4 5040.8 3757.2 3786.5 3791.4 3796.9 3797.4 5020.3 5203.5 5226.2 5231.6 5260.2 3886.5 3892.9 3893.9 3894.7 3908.7 3929.4 3942.6 3945.5 3951.7 3960.2 4157.2 4365.6 4391.6 4426.4 4432.0 4999.6 5011.0 5020.9 5030.5 5032.0 1286.8 1336.9 1347.0 1354.4 1356.8 923.5 937.7 969.8 981.9 984.8 4248.9 4292.2 4300.4 4310.7 4310.8 4988.2 5006.8 5010.0 5012.3 5029.1 4178.7 4278.0 4313.3 4403.6 4466.1 2679.3 2684.8 2688.9 2692.4 2701.8 4751.6 4753.9 4775.8 4813.8 4819.4 5038.4 5211.8 5225.5 5233.6 5254.7 4734.5 4773.0 4780.4 4786.6 4792.3 5045.3 5058.8 5063.7 5093.5 5107.3 4735.7 4952.1 4960.6 4964.5 4990.5 4731.5 4742.8 4771.1 4779.7 4791.5 3514.0 3545.4 3556.3 3565.2 3569.3 4822.7 5053.1 5063.5 5065.4 5095.5 4894.9 4906.3 4916.7 4951.2 4963.6 4879.7 4905.9 4908.8 4917.2 4921.9 4597.1 4765.6 4816.9 4833.4 4843.4 4962.3 4985.3 5096.7 5102.6 5107.9 5000.0 5001.2 5006.6 5006.7 5007.0 07:57:43 INFO - PROCESS | 6170 | 07:57:43 INFO - PROCESS | 6170 | [#5] yui.html Cycles:180 Average:14474.41 Median:27489.72 stddev:18298.87 (66.6%) stddev-sans-first:18320.46 07:57:43 INFO - PROCESS | 6170 | Values: 580.8 611.7 622.4 681.6 693.1 11588.4 12374.3 12451.9 12521.7 13368.5 12388.3 12476.2 12763.9 12771.4 12777.6 727.4 748.8 751.2 751.4 751.6 598.0 616.1 734.7 754.0 760.8 802.5 803.5 805.2 805.6 805.7 793.1 793.6 793.7 794.1 794.4 465.5 475.0 566.1 582.1 584.7 12906.5 13031.7 13169.1 13222.9 13315.7 12166.8 12437.9 12814.2 12829.7 12945.9 11400.0 11404.7 11438.8 11487.7 11504.8 3946.8 4011.4 4060.0 4082.5 4117.8 62771.7 62939.0 63936.7 64009.4 64504.7 9133.3 9253.5 9705.1 9825.0 9847.7 17797.4 18127.2 18159.0 18162.2 18170.8 6242.2 6242.6 6254.5 6415.9 6455.0 3499.8 3500.5 3531.4 3571.6 3597.2 2853.5 2950.5 2950.6 2953.8 2962.3 520.9 529.4 531.8 532.3 535.2 551.0 566.0 578.6 578.9 586.4 7455.7 8031.3 8082.3 8198.3 8200.9 559.5 578.3 589.5 601.5 611.5 3543.1 3777.3 3821.3 3857.8 3984.7 50087.5 54428.5 63284.4 64327.7 67216.7 56480.7 59000.7 59772.4 60428.4 60570.0 43735.0 49452.5 51073.2 53028.5 53045.5 7071.3 7166.0 7378.5 7512.8 7583.7 35709.5 36556.3 36632.1 36873.0 38602.8 43795.0 47778.3 48121.3 50204.7 50457.2 9129.8 9333.5 9618.4 9630.6 9711.9 10118.8 10145.1 10219.0 10441.9 10531.7 9028.0 9885.0 9959.3 10309.9 11043.7 10547.7 11296.9 11390.5 11431.1 11703.9 11031.8 11056.9 11119.9 11333.8 11656.7 9069.0 9134.7 9296.3 9569.5 9695.4 9620.7 9785.7 9845.9 9877.4 9897.2 07:57:43 INFO - PROCESS | 6170 | -------- Summary: end -------- 07:57:43 INFO - PROCESS | 6170 | 07:57:44 INFO - TEST-INFO | 6170: exit 0 07:57:44 INFO - TEST-OK | dromaeo_css | took 1122560ms 07:57:44 INFO - TEST-START | kraken 07:57:44 INFO - operating with platform_type : linux_ 07:57:44 INFO - Initialising browser for kraken test... 07:57:44 INFO - TEST-INFO | started process 6477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEhx0L/profile http://localhost:40485/getInfo.html) 07:57:48 INFO - PROCESS | 6477 | __metrics Screen width/height:1600/1200 07:57:48 INFO - PROCESS | 6477 | colorDepth:24 07:57:48 INFO - PROCESS | 6477 | Browser inner width/height: 1024/697 07:57:48 INFO - PROCESS | 6477 | __metrics 07:57:49 INFO - PROCESS | 6477 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:49 INFO - PROCESS | 6477 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:49 INFO - PROCESS | 6477 | console.error: PushService: 07:57:49 INFO - PROCESS | 6477 | stateChangeProcessEnqueue: Error transitioning state 07:57:49 INFO - PROCESS | 6477 | UnknownError 07:57:50 INFO - TEST-INFO | 6477: exit 0 07:57:50 INFO - Browser initialized. 07:57:50 INFO - Running cycle 1/1 for kraken test... 07:57:50 INFO - TEST-INFO | started process 6557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEhx0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:02 INFO - PROCESS | 6557 | RSS: Main: 155303936 07:58:02 INFO - PROCESS | 6557 | 07:58:05 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40485/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:06 INFO - PROCESS | 6557 | RSS: Main: 209031168 07:58:06 INFO - PROCESS | 6557 | 07:58:08 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40485/tests/kraken/driver.html?testName=audio-dft) 07:58:09 INFO - PROCESS | 6557 | RSS: Main: 187875328 07:58:09 INFO - PROCESS | 6557 | 07:58:12 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40485/tests/kraken/driver.html?testName=audio-fft) 07:58:13 INFO - PROCESS | 6557 | RSS: Main: 270008320 07:58:13 INFO - PROCESS | 6557 | 07:58:15 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40485/tests/kraken/driver.html?testName=audio-oscillator) 07:58:15 INFO - PROCESS | 6557 | RSS: Main: 180768768 07:58:15 INFO - PROCESS | 6557 | 07:58:18 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:18 INFO - PROCESS | 6557 | RSS: Main: 184430592 07:58:18 INFO - PROCESS | 6557 | 07:58:22 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40485/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:22 INFO - PROCESS | 6557 | RSS: Main: 223830016 07:58:22 INFO - PROCESS | 6557 | 07:58:26 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40485/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:26 INFO - PROCESS | 6557 | RSS: Main: 217935872 07:58:26 INFO - PROCESS | 6557 | 07:58:29 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40485/tests/kraken/driver.html?testName=json-parse-financial) 07:58:30 INFO - PROCESS | 6557 | RSS: Main: 219725824 07:58:30 INFO - PROCESS | 6557 | 07:58:31 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:32 INFO - PROCESS | 6557 | RSS: Main: 183357440 07:58:32 INFO - PROCESS | 6557 | 07:58:34 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:35 INFO - PROCESS | 6557 | RSS: Main: 190660608 07:58:35 INFO - PROCESS | 6557 | 07:58:37 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:37 INFO - PROCESS | 6557 | RSS: Main: 199405568 07:58:37 INFO - PROCESS | 6557 | 07:58:40 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:41 INFO - PROCESS | 6557 | RSS: Main: 207568896 07:58:41 INFO - PROCESS | 6557 | 07:58:44 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:45 INFO - PROCESS | 6557 | RSS: Main: 204189696 07:58:45 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | Cycle 1(1): loaded http://localhost:40485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40485/tests/kraken/driver.html?testName=ai-astar) 07:58:47 INFO - PROCESS | 6557 | RSS: Main: 255688704 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | __start_tp_report 07:58:47 INFO - PROCESS | 6557 | _x_x_mozilla_page_load 07:58:47 INFO - PROCESS | 6557 | _x_x_mozilla_page_load_details 07:58:47 INFO - PROCESS | 6557 | |i|pagename|runs| 07:58:47 INFO - PROCESS | 6557 | |0;ai-astar;107;114;115;113;114;113;115;117;114;114 07:58:47 INFO - PROCESS | 6557 | |1;audio-beat-detection;157;128;133;185;130;126;125;124;147;126 07:58:47 INFO - PROCESS | 6557 | |2;audio-dft;160;160;161;162;162;161;162;163;161;161 07:58:47 INFO - PROCESS | 6557 | |3;audio-fft;78;77;76;107;76;77;76;76;104;77 07:58:47 INFO - PROCESS | 6557 | |4;audio-oscillator;85;85;105;86;85;85;102;85;84;107 07:58:47 INFO - PROCESS | 6557 | |5;imaging-gaussian-blur;127;127;127;128;128;126;127;128;127;127 07:58:47 INFO - PROCESS | 6557 | |6;imaging-darkroom;147;147;147;146;147;147;146;146;146;146 07:58:47 INFO - PROCESS | 6557 | |7;imaging-desaturate;96;96;95;95;95;96;96;96;95;96 07:58:47 INFO - PROCESS | 6557 | |8;json-parse-financial;64;64;65;64;65;66;66;65;65;64 07:58:47 INFO - PROCESS | 6557 | |9;json-stringify-tinderbox;65;65;66;65;66;66;65;65;66;65 07:58:47 INFO - PROCESS | 6557 | |10;stanford-crypto-aes;86;85;94;92;84;84;85;85;95;94 07:58:47 INFO - PROCESS | 6557 | |11;stanford-crypto-ccm;144;142;142;133;143;139;140;141;182;137 07:58:47 INFO - PROCESS | 6557 | |12;stanford-crypto-pbkdf2;181;180;179;182;185;183;182;179;178;178 07:58:47 INFO - PROCESS | 6557 | |13;stanford-crypto-sha256-iterative;69;68;68;69;68;69;68;67;68;68 07:58:47 INFO - PROCESS | 6557 | __end_tp_report 07:58:47 INFO - PROCESS | 6557 | __start_cc_report 07:58:47 INFO - PROCESS | 6557 | _x_x_mozilla_cycle_collect,1964 07:58:47 INFO - PROCESS | 6557 | __end_cc_report 07:58:47 INFO - PROCESS | 6557 | __startTimestamp1482163127264__endTimestamp 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | ------- Summary: start ------- 07:58:47 INFO - PROCESS | 6557 | Number of tests: 14 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.59 (2.3%) stddev-sans-first:1.22 07:58:47 INFO - PROCESS | 6557 | Values: 107.0 114.0 115.0 113.0 114.0 113.0 115.0 117.0 114.0 114.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:131.50 stddev:19.70 (15.0%) stddev-sans-first:19.67 07:58:47 INFO - PROCESS | 6557 | Values: 157.0 128.0 133.0 185.0 130.0 126.0 125.0 124.0 147.0 126.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 07:58:47 INFO - PROCESS | 6557 | Values: 160.0 160.0 161.0 162.0 162.0 161.0 162.0 163.0 161.0 161.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:12.21 (16.0%) stddev-sans-first:12.85 07:58:47 INFO - PROCESS | 6557 | Values: 78.0 77.0 76.0 107.0 76.0 77.0 76.0 76.0 104.0 77.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:85.00 stddev:9.59 (11.3%) stddev-sans-first:9.93 07:58:47 INFO - PROCESS | 6557 | Values: 85.0 85.0 105.0 86.0 85.0 85.0 102.0 85.0 84.0 107.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#5] imaging-gaussian-blur Cycles:10 Average:127.20 Median:127.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:58:47 INFO - PROCESS | 6557 | Values: 127.0 127.0 127.0 128.0 128.0 126.0 127.0 128.0 127.0 127.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:58:47 INFO - PROCESS | 6557 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:58:47 INFO - PROCESS | 6557 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 07:58:47 INFO - PROCESS | 6557 | Values: 64.0 64.0 65.0 64.0 65.0 66.0 66.0 65.0 65.0 64.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:58:47 INFO - PROCESS | 6557 | Values: 65.0 65.0 66.0 65.0 66.0 66.0 65.0 65.0 66.0 65.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:4.70 (5.3%) stddev-sans-first:4.90 07:58:47 INFO - PROCESS | 6557 | Values: 86.0 85.0 94.0 92.0 84.0 84.0 85.0 85.0 95.0 94.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:142.00 stddev:13.63 (9.6%) stddev-sans-first:14.46 07:58:47 INFO - PROCESS | 6557 | Values: 144.0 142.0 142.0 133.0 143.0 139.0 140.0 141.0 182.0 137.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:181.50 stddev:2.31 (1.3%) stddev-sans-first:2.45 07:58:47 INFO - PROCESS | 6557 | Values: 181.0 180.0 179.0 182.0 185.0 183.0 182.0 179.0 178.0 178.0 07:58:47 INFO - PROCESS | 6557 | 07:58:47 INFO - PROCESS | 6557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 07:58:47 INFO - PROCESS | 6557 | Values: 69.0 68.0 68.0 69.0 68.0 69.0 68.0 67.0 68.0 68.0 07:58:47 INFO - PROCESS | 6557 | -------- Summary: end -------- 07:58:47 INFO - PROCESS | 6557 | 07:58:48 INFO - TEST-INFO | 6557: exit 0 07:58:48 INFO - TEST-OK | kraken | took 63741ms 07:58:48 INFO - SUITE-END | took 1186s 07:58:48 INFO - Completed test suite (00:19:46) 07:58:48 INFO - javascript benchmark 07:58:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.4117573545955, 2646.8279561828467, 2674.5720684690446, 2691.3675286307716, 2694.232143839005, 4681.719096854191, 4694.671373003891, 4740.9762951185285, 4758.428988521382, 4792.329073929648, 4714.245720684691, 4715.646326525516, 4769.260764581487, 4769.546893045163, 4828.879278018051, 4325.545817689144, 4332.740035597859, 4368.366586844905, 4414.4923333816705, 4439.644828413735, 4062.9121281688163, 4390.0, 4490.528494508078, 4516.435445569304, 4573.062522182944, 4308.310670292738, 4348.304271316574, 4455.710378825366, 4473.977630111861, 4511.210538155826, 4387.62705170061, 4387.934180987288, 4399.912001759979, 4407.647388208936, 4408.4709834819705, 4365.563443655641, 4375.7374557526655, 4378.868633940955, 4390.692651514395, 4391.604755572014, 4753.524647535253, 4767.976160119212, 4770.045990801854, 4774.379330687023, 4783.4499032611, 5055.342805435306, 5144.0740666679985, 5180.4042535108565, 5186.273921650972, 5201.973990130063, 5150.047241260341, 5154.175331946871, 5158.097332966716, 5160.329157209576, 5206.453322401169, 4638.2115040443205, 4751.121042607128, 4806.327114204014, 4810.542998415215, 4811.879703007453, 5090.618203634742, 5178.715170665574, 5207.843764687065, 5245.449227831099, 5256.92114618281, 5046.369203849519, 5056.317397151338, 5056.747162641853, 5060.924086138711, 5069.138246498104, 5159.561437277798, 5160.896782064413, 5161.974190129025, 5165.793368265227, 5208.244804503326, 4948.604111671058, 4984.975075124674, 4987.900241995139, 5085.059264036166, 5120.231965205175, 5103.770330335144, 5162.328897243335, 5215.191645294985, 5216.504432078947, 5218.243354713545, 4446.777661116931, 4457.3091170868565, 4457.398251236106, 4463.263561512379, 4500.819967201341, 3797.411401232758, 3873.9612603874166, 3879.0, 3899.1421887184774, 3916.3146449371247, 4350.869473915787, 4362.149380870763, 4370.694051416371, 4381.890452738643, 4388.956110438919, 5166.870828229325, 5168.61235407346, 5176.1459359206065, 5179.326687530597, 5221.503957124067, 4360.040791025969, 4391.67062470316, 4398.824047038082, 4427.40230068943, 4442.733435993786, 4508.549145085531, 4516.977415112903, 4555.248384016666, 4648.302754586772, 4652.883677908079, 4786.210275304536, 4852.393450818648, 4858.489858564941, 4884.072026314989, 4895.314655948099, 5186.377634683862, 5193.636445448782, 5200.5059519345605, 5202.947970520398, 5247.08176069194, 4607.861764147081, 4641.535846415331, 4843.297721830385, 4858.222684370625, 4904.337914381513, 4956.876078097932, 4979.203327467588, 4997.125503036881, 5023.045621331935, 5076.6446348755235, 5080.983803239441, 5088.262201980766, 5092.796288148433, 5093.337866077386, 5137.049645815536, 4827.155247831685, 4850.466448690711, 4922.384701912261, 4968.080905032581, 4972.577330926912, 4918.48355922623, 4918.827841025547, 4922.680025798311, 4926.4088309403105, 4997.800087996439, 4845.63657725665, 4868.829590964299, 4877.341558889504, 4899.902001960012, 4925.1627223372825, 4831.468538460696, 4995.500449954975, 5004.674696144739, 5007.524285192901, 5047.965167140654, 4734.195186818318, 4920.409550853778, 4940.308356830118, 4958.454569997225, 5020.096382651158], "value": 4697.543888173934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.5801279969625, 537.7015756255277, 547.6905548365173, 552.9032419326617, 557.8716895114126, 27473.725262747368, 36174.2765144697, 37207.44188837169, 37309.06727331818, 40926.0, 40175.397369039485, 40685.0, 40703.79648101763, 40710.18579628406, 40755.18489630205, 7535.811604709885, 7700.730474433396, 7701.383889288843, 7706.576138312391, 7714.922850771477, 7378.0, 7565.0, 9662.227021838236, 9878.110970012698, 9880.95059524705, 10014.749631259205, 10102.343347682414, 10103.292769506137, 10103.747406314827, 10104.090631843133, 9943.502824858764, 9982.600695972153, 9990.950045249727, 10004.699859004242, 10010.1491373233, 9629.374090684083, 9688.75778105553, 9697.66058187967, 9698.806023879482, 9706.514674266258, 37187.628123718954, 37509.62490375089, 37530.0, 37530.249395011946, 37564.81217593895, 2720.183944816547, 3091.922701932447, 3351.7821341612716, 3383.3233353329433, 3417.265287963075, 28087.297817554725, 28207.858960705064, 28262.858685706644, 28323.858380707963, 28409.715902840915, 3262.3801477719157, 3299.5215693724517, 3309.12308238317, 3331.9500207496662, 3362.193073662328, 245747.0, 246847.0, 247918.9999999982, 248117.0, 248682.0, 45301.546984529734, 45757.77121114373, 45854.54145458503, 45900.0, 45902.5409745905, 48494.0, 48600.270995934385, 48631.75684121557, 48639.270410943864, 48684.75657621689, 13672.384742686603, 13917.23455209953, 13946.930265348608, 13949.721005580035, 13950.302484875716, 9403.247740180768, 9557.856632150524, 10403.375797452178, 10461.163106951426, 10468.947655261827, 14954.925225373803, 15101.924490377478, 15298.158601276815, 15771.921140394224, 15873.920630396775, 6211.378862113753, 6241.21984751906, 6286.151369565142, 6299.464545513591, 6371.960972488851, 714.7641278378122, 789.8854666073387, 884.6505630276005, 899.2266650680409, 935.9859602105973, 27109.72890271072, 27608.0, 27663.58504622432, 27995.580066299022, 28079.0, 845.8392905347964, 953.1564565359567, 959.6737109382843, 963.012911765432, 969.7139343893568, 14346.49787257441, 14660.486882959258, 14868.992601701859, 14885.404583816526, 15068.849311506963, 369687.0, 400885.0, 406807.0, 407844.0, 628440.0, 43112.56887431148, 43594.78202608967, 43602.78198608987, 43680.56319436828, 43689.34465983013, 1127.6786115956913, 1157.670064031747, 1161.1233518693332, 1164.557468162093, 1174.671092094215, 24959.01639344277, 25894.1738108924, 26276.343091422867, 26337.341566460993, 26696.466070678867, 37256.44115338218, 37787.62212377951, 37800.243995119396, 37801.0, 37827.24345513129, 314609.0, 317538.0, 317916.0, 318105.0, 318204.0, 20776.480587984817, 21548.67676984878, 23424.882875585514, 23863.880680596485, 23867.0, 36863.81568092143, 36934.815325924275, 37773.24453510859, 39953.2009359817, 41193.0, 30914.69085309208, 31156.532652009784, 31201.219969500944, 31262.218444539067, 32657.836710816293, 31033.379332412773, 31239.68760312368, 31294.68705313009, 31377.372452551277, 32350.352992939537, 31363.0, 31689.36621267608, 31852.203694907814, 31894.68105318917, 32236.0, 26984.66272894212, 28960.855195723885, 28977.0, 29267.853660731562, 29575.0, 22380.888095559418, 22768.88615556978, 22801.657975130056, 23044.884775576684, 23114.884425577766], "value": 16951.836635117583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4804325360572, 350.5407915630526, 362.18869731800766, 370.3075249283839, 377.7534137346755, 12235.204711693745, 15510.999999999985, 15600.531984040483, 16706.916465417686, 16782.58043548909, 15945.123018233993, 16048.83951160488, 16633.41783037594, 16762.161891905387, 16769.496915092535, 4814.54261845125, 4860.854174374756, 4966.701997880139, 5022.773975171126, 5058.165402708567, 3635.8363873625617, 3811.085339518523, 4911.778969946361, 5006.023825354057, 5006.949930500703, 5648.74580643872, 5872.853178670524, 5897.793577224798, 5956.88086238275, 5960.403959604048, 5701.515371193454, 5847.0, 5877.147813567009, 5925.377835327272, 5927.4961628261435, 5189.688618682853, 5193.272941788153, 5194.37667479901, 5195.870103247449, 5197.194434862602, 20141.79858201414, 20482.897585512124, 20596.0, 20601.58796824055, 20618.17527298906, 1889.3387314439974, 1893.8011508791653, 1952.463072655017, 2112.3346145963974, 2273.5680220758168, 12192.13484831064, 13062.216267024009, 13295.800562991562, 13572.0, 13636.0, 1678.2951160512614, 1714.1429285357322, 1714.8885322454125, 1785.1877395784886, 1805.6930321845186, 64693.3530664692, 65497.0, 67118.0, 68029.3197068028, 68164.6591767043, 9444.386114902509, 9621.470819104876, 9622.182114520345, 9700.27247956406, 9918.30571859963, 13103.475860965646, 13162.736745265041, 13184.670383240304, 13192.274424906722, 13193.274369909746, 7291.781246562611, 7378.299061589248, 7426.517276377018, 7601.467897247139, 7622.237776222333, 7159.3914517265575, 7240.818979525448, 7389.482736208522, 7444.627768611548, 7464.328210461084, 5327.467253274642, 5668.744906479218, 5675.262215911905, 5941.881162376728, 6047.274327080779, 1679.6497072582072, 1752.929882804699, 1782.7236778299384, 1860.7860096088853, 1889.2443022790994, 724.8550289942033, 769.2000319667483, 797.7726347990911, 812.2770734046703, 875.1205038935828, 16241.106739129225, 17020.829791702174, 17604.295828166985, 18437.26250949974, 18656.34702785423, 786.241277167536, 800.6317094136763, 826.2068414322198, 841.7643059943103, 855.3755758296478, 9768.609255629837, 9887.901120988841, 10319.896801032044, 10355.482225888676, 10359.585616575403, 333623.0, 333837.0, 337760.0, 338852.0, 339810.0, 66494.0, 67513.0, 75845.0, 77832.05419864436, 79725.0, 912.2291663544295, 932.7994481186578, 969.2875736333789, 970.6117552978724, 974.055166488505, 15331.693366132838, 15401.30694118745, 16027.198640068184, 16236.26936787871, 16340.836591633932, 28499.43001140007, 34810.82594587011, 35650.8217458911, 35804.0, 36380.81809590935, 43871.56128438675, 48891.16461271527, 48993.510064898896, 51462.48537514577, 52437.21344179917, 7590.886136708064, 7623.69505219785, 7669.7315593953945, 7760.92239077602, 7951.721689740832, 10109.64616238428, 11766.0, 11788.70528236801, 11869.643910682693, 12232.938835306122, 9918.504074796376, 10110.494475276353, 10353.844692329772, 10491.160707143563, 10662.946685266525, 9855.901440985499, 9967.50162491858, 10102.0, 10282.897171028493, 10302.381857088598, 10200.28597998133, 10212.438315892698, 10446.843297350697, 10679.19906007037, 10711.678649640524, 7527.736529221451, 7543.321101100927, 7679.347255483346, 7712.460127791001, 8045.87931181021, 7877.566733829465, 9255.25957923378, 9790.363626364264, 10462.68611941643, 10508.740620766572], "value": 8219.397925880856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.3065975033232, 1312.7571399291128, 1390.791381292806, 1605.3658804772108, 1646.275638718963, 7063.187733410659, 7516.774496765106, 7521.924780752191, 7525.0217471728665, 7528.736494222697, 6392.392722691348, 6570.901436478444, 6574.704138313776, 6685.0, 7392.33468987791, 1852.7776666799969, 2099.32821497121, 2157.11558261113, 2170.6201414752436, 2183.9344819655435, 2147.5490147069136, 2177.553601511694, 2181.890905454729, 2187.2891310324208, 2192.013593882751, 2142.646463333556, 2153.6123497770395, 2164.31823975448, 2168.609650262952, 2169.9132034718673, 2023.6155130525153, 2043.0806137238228, 2115.820155286787, 2119.6926445665445, 2122.628540005493, 2070.730804995356, 2072.3990042887544, 2102.8212601928853, 2106.31544747956, 2110.8416868734753, 7377.0, 7528.510646807995, 7536.585487798169, 7538.0, 7540.095188577406, 4383.3863259143745, 4541.545845415432, 4546.636269098497, 4548.476925153616, 4553.635709143261, 2786.205931309567, 2968.5695574141846, 3033.3326668133195, 3034.9696503034907, 3035.332226910098, 876.145757886056, 927.7866090799087, 935.0976307862877, 935.1677007463363, 936.3585943628636, 9456.432614043111, 9660.37207581505, 9677.129058384779, 9952.4028558286, 9975.501224938796, 3785.886423407302, 3871.4192871069563, 3967.107400834847, 3984.780837053932, 4009.278329900588, 7674.846503069907, 7675.808104797425, 7685.154632990367, 7685.5004424712215, 7696.576688282198, 4487.528809475023, 4487.6185524230805, 4490.101979604092, 4491.461024676994, 4493.707908985905, 4057.208844275338, 4194.853180138681, 4195.265828480004, 4198.181354635817, 4202.453681021509, 3075.108218616621, 3120.251139726495, 3176.364727054552, 3208.4385232584204, 3284.293876816496, 939.4785893828854, 940.7365937537501, 946.7964387656687, 950.3680052764972, 958.6836344006462, 634.5494698763929, 799.9960000199961, 803.6504120707511, 804.5558222989631, 827.148037521354, 4848.854534363974, 4881.829135980294, 4973.726445045485, 5022.7990880365105, 5327.067763141435, 400.12772156698094, 403.95758445362816, 410.57300407575786, 412.6574942797471, 854.6068808348106, 3309.586301712286, 3332.666733326648, 3343.264481813997, 3357.84889679965, 3580.7314451415727, 8790.0, 8854.557272136368, 8985.415947963493, 8989.146031127033, 8990.056044115405, 8880.378373513791, 8914.197722205032, 8924.062973387701, 8948.642054317754, 8995.865062024075, 6661.666916654148, 6744.7976560703255, 6747.628880411527, 6754.18949726036, 6917.861642767217, 4797.304390863375, 4819.373481447389, 4838.080764654705, 4889.339939108318, 5029.748512574283, 8257.79355516117, 8270.503769773833, 8346.33229341639, 8419.8737018946, 8456.704015359433, 8076.515409075474, 8331.041930178108, 8336.958315208627, 8339.749807505785, 8475.279601233964, 6249.6562689052535, 6424.710888010144, 6722.294159113223, 6832.111825462658, 6935.826604334932, 6881.41507971828, 7151.60666163366, 7151.642417879189, 7155.248698886542, 7155.642217889189, 6350.142730731477, 6423.389777971085, 6431.646259455775, 6474.70863811139, 6511.218653761579, 6227.688615569294, 6251.937480625135, 6284.5600807943, 6344.460720838781, 6367.681615919279, 5932.851678708067, 6031.728572214349, 6097.695115244132, 6104.877902441837, 6113.14415981754, 4477.485089214651, 4504.211762941538, 4552.11233809404, 4559.794809233526, 4559.794809233659, 4376.431063961664, 4428.601425871687, 4506.1663592235545, 4514.0152894066305, 4617.307403889309], "value": 3862.564835605642, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.84921210061515, 347.92519608284215, 349.0297567698882, 355.307151055442, 356.04934824019864, 4810.687305325151, 4819.638527110467, 4834.564889159979, 4854.8300809471675, 4865.805367785284, 4533.501314855372, 4602.171609110359, 4658.930116048262, 4699.248120300753, 4760.262159365296, 3824.120452295974, 3844.0966372902344, 3844.2311537692435, 3847.7498962567483, 3855.7686538807693, 3847.999520124774, 3868.4390763339297, 3872.961270387302, 3876.9806150969207, 3880.20455806559, 3669.1377526281303, 3723.869664561741, 3774.67915227206, 3815.313243616148, 3859.864904728335, 3831.1571454280015, 3838.7120965927666, 3854.6530812226893, 3858.884233472972, 3861.6331448512487, 3412.7269818414466, 3418.5555877735983, 3459.9481007784902, 3462.722982161421, 3467.133216695826, 4526.592606665416, 4634.165850146972, 4635.95364046362, 4665.020345727401, 4691.601213896823, 4335.547591556832, 4396.582324679151, 4399.582039706254, 4403.933940990888, 4410.889727756799, 4986.351774269358, 4997.5002499749735, 5014.974925125351, 5019.4227663818765, 5040.84877453677, 3757.154640205959, 3786.5266841644793, 3791.4312853071983, 3796.9430458543143, 3797.4303854421782, 5020.347354843847, 5203.505666961632, 5226.242194881721, 5231.581473482112, 5260.158374660036, 3886.5336159661024, 3892.8905262000762, 3893.8637147699696, 3894.668953139015, 3908.687305015592, 3929.3713005918917, 3942.6057394260342, 3945.546262179829, 3951.703622228287, 3960.20795840833, 4157.230912281238, 4365.628921541705, 4391.572738859883, 4426.3581780641625, 4431.964104588367, 4999.575036121971, 5011.0, 5020.93722829074, 5030.522100400456, 5031.974840125849, 1286.7683816913045, 1336.8863646590148, 1346.9528566500126, 1354.4446776821653, 1356.830396200475, 923.4505469245788, 937.723371605378, 969.8448248280382, 981.9459929703792, 984.7882705218412, 4248.851290204828, 4292.163028209469, 4300.3549467580115, 4310.698251122391, 4310.7629080400875, 4988.201887697951, 5006.774695138727, 5010.0, 5012.273220383024, 5029.139218489182, 4178.686598505064, 4277.978610106929, 4313.288307429302, 4403.625691816167, 4466.146549182118, 2679.303381120884, 2684.778425816288, 2688.9378695415203, 2692.3807524269137, 2701.8108732388546, 4751.619870410428, 4753.862450782536, 4775.785089670973, 4813.807447702053, 4819.361417118197, 5038.395392552844, 5211.7915283389, 5225.50357716024, 5233.581313494988, 5254.6847189168775, 4734.502877197845, 4773.0453909218295, 4780.426348838092, 4786.64100192487, 4792.2811578262845, 5045.31888195089, 5058.848234552969, 5063.721495317793, 5093.516115968977, 5107.336046313955, 4735.692180008288, 4952.059108769322, 4960.578350840219, 4964.453910069961, 4990.476000019946, 4731.503192164911, 4742.810287588458, 4771.093492236464, 4779.737114458738, 4791.520847915181, 3513.9648603513638, 3545.397282462039, 3556.288742251508, 3565.180008598089, 3569.268299998546, 4822.662413631012, 5053.065182941167, 5063.493650634907, 5065.39215294167, 5095.477738519457, 4894.92657610129, 4906.313116163668, 4916.655834091579, 4951.212322573307, 4963.627727920348, 4879.658423910292, 4905.877353066202, 4908.828191013297, 4917.188663870565, 4921.8523444296725, 4597.149527337453, 4765.571098601143, 4816.8554943351755, 4833.3958255218095, 4843.4430040545785, 4962.255661650637, 4985.3020577118505, 5096.745162741774, 5102.617303702163, 5107.9233811493605, 5000.0, 5001.174806157089, 5006.624503162205, 5006.721941516674, 5006.974965125151], "value": 3822.9440661910203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7996241296754, 611.6635850282346, 622.4491325177219, 681.550176883257, 693.1128155960372, 11588.362640054793, 12374.319412432313, 12451.941584965289, 12521.749565008706, 13368.532101376453, 12388.31864247466, 12476.189047711892, 12763.936180319086, 12771.361431928413, 12777.552785652504, 727.3671905442272, 748.842743023963, 751.1849643137202, 751.3688501658605, 751.5978951261077, 597.9611325263866, 616.1404840247851, 734.6583838515089, 753.9623018849063, 760.794585461925, 802.5465611929242, 803.4697099914058, 805.1666525146475, 805.6334367862638, 805.730080423059, 793.1235984237393, 793.6031984007996, 793.6745934166993, 794.1105961323298, 794.3724457678427, 465.5205138707137, 474.9905001899943, 566.057514238796, 582.123903525196, 584.7397907930972, 12906.548270810477, 13031.674208144777, 13169.144005639602, 13222.933885330607, 13315.733685326239, 12166.756664866742, 12437.875621243762, 12814.23114613117, 12829.67925801853, 12945.935270323587, 11400.030997365235, 11404.714882128013, 11438.828417573659, 11487.725998090504, 11504.827427588592, 3946.782926939017, 4011.4183443400543, 4059.97970010151, 4082.4692789937417, 4117.814698338582, 62771.68614156946, 62939.0, 63936.68031659812, 64009.359906401274, 64504.677476612786, 9133.315001374924, 9253.537323133816, 9705.12653861156, 9824.950875245579, 9847.704568862946, 17797.377091801725, 18127.18427670758, 18159.0, 18162.182701778453, 18170.818291817177, 6242.188515492957, 6242.563020588515, 6254.468370188494, 6415.903761443582, 6455.0, 3499.825008749552, 3500.5274287971306, 3531.3820081485637, 3571.6428357164077, 3597.244578638515, 2853.4721076600895, 2950.498415269409, 2950.645922489315, 2953.7784666149696, 2962.333474968158, 520.8932168905366, 529.3568314497903, 531.7979167916167, 532.3000254665103, 535.2426316761738, 550.9834704958857, 565.9830205093854, 578.5660754434174, 578.8972008324149, 586.3725813379643, 7455.664495097733, 8031.277185053374, 8082.31300339466, 8198.303144232807, 8200.876986845202, 559.5076332827086, 578.2569398323135, 589.4635881347953, 601.5127746525241, 611.4680228201494, 3543.078799512094, 3777.320082385197, 3821.293060783764, 3857.8456861725776, 3984.6613037891525, 50087.49912500901, 54428.45571544234, 63284.36715632785, 64327.67836160789, 67216.6639166801, 56480.717596411756, 59000.7049964756, 59772.40227597668, 60428.39571604228, 60570.0, 43735.0, 49452.50547494551, 51073.233901491505, 53028.46971530312, 53045.469545304055, 7071.25751796054, 7165.964170179116, 7378.520396174232, 7512.812179695551, 7583.658735356812, 35709.46435803517, 36556.26887462289, 36632.08419789527, 36873.0, 38602.80698596489, 43795.0, 47778.28332574945, 48121.278180826615, 50204.74897625489, 50457.24314135365, 9129.77175570616, 9333.533323333942, 9618.374805637612, 9630.614775409185, 9711.854322185032, 10118.8482172766, 10145.08694217524, 10219.0, 10441.947790261, 10531.73670658209, 9028.0, 9884.950575247365, 9959.302848800515, 10309.896901031194, 11043.668689939315, 10547.683569492927, 11296.887031129583, 11390.487428065591, 11431.142664300378, 11703.941480292544, 11031.779364412827, 11056.944715276693, 11119.888801111885, 11333.773324533298, 11656.650300491, 9069.0, 9134.680286189952, 9296.349255552046, 9569.468600959994, 9695.418274903528, 9620.663276785279, 9785.657501987396, 9845.85231221518, 9877.40735555869, 9897.158741507052], "value": 6053.074890941037, "unit": "score"}], "name": "dromaeo_css", "value": 6230.716271239457, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 115.0, 113.0, 114.0, 113.0, 115.0, 117.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 133.0, 185.0, 130.0, 126.0, 125.0, 124.0, 147.0, 126.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 107.0, 76.0, 77.0, 76.0, 76.0, 104.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 86.0, 85.0, 85.0, 102.0, 85.0, 84.0, 107.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 128.0, 128.0, 126.0, 127.0, 128.0, 127.0, 127.0], "value": 127.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 66.0, 66.0, 65.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 94.0, 92.0, 84.0, 84.0, 85.0, 85.0, 95.0, 94.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 142.0, 133.0, 143.0, 139.0, 140.0, 141.0, 182.0, 137.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 179.0, 182.0, 185.0, 183.0, 182.0, 179.0, 178.0, 178.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 67.0, 68.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1567.4, "alertThreshold": 2.0}]} 07:58:48 INFO - Return code: 0 07:58:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:48 INFO - # TBPL SUCCESS # 07:58:48 INFO - Running post-action listener: _resource_record_post_action 07:58:48 INFO - [mozharness: 2016-12-19 15:58:48.556309Z] Finished run-tests step (success) 07:58:48 INFO - Running post-run listener: _resource_record_post_run 07:58:48 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 398442496; Read time: 536; Write time: 374260 07:58:48 INFO - TinderboxPrint: CPU usage
13.2% 07:58:48 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 536 07:58:48 INFO - TinderboxPrint: I/O write bytes / time
398,442,496 / 374,260 07:58:48 INFO - TinderboxPrint: CPU idle
8,335.6 (86.8%) 07:58:48 INFO - TinderboxPrint: CPU user
1,220.2 (12.7%) 07:58:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115695616; Read time: 348; Write time: 100040 07:58:48 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282206208; Read time: 176; Write time: 274196 07:58:49 INFO - Running post-run listener: _upload_blobber_files 07:58:49 INFO - Blob upload gear active. 07:58:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:49 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 07:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:50 INFO - (blobuploader) - INFO - Done attempting. 07:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:54 INFO - (blobuploader) - INFO - Done attempting. 07:58:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:55 INFO - (blobuploader) - INFO - Done attempting. 07:58:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:58:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:58:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:56 INFO - (blobuploader) - INFO - Done attempting. 07:58:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:56 INFO - Return code: 0 07:58:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3da09c1a6b1b0ce93079be4e4807d534fe685086cc5310c91e058fcc90b0037a01320c966592983995fa9b741cc4c2b010df74e42f0efbe912f178b738224c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef677357dd1c0918698011500b1dc6edadf2130ef41244ad7568ac075981c4027563763ba551a772953d70d3e0bd574aa1caea5d30edd489165b3e65fa6643b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/091c0f185dad9560358ad8dd936cd430566927edf1469f80cba144ac787c7ce8c15b2aa7c00236e682f9adb1a4265971e4eecce9e4e3ffb310e149551e875767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/040f0fbe58269de0427e42edc5598349e36313254fecef16985ac9f1000282b8fbbba06f433827f873fefd3c2316dfe236c6c7772066d0e5b4bc47aa031f9b70"} 07:58:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:56 INFO - Contents: 07:58:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3da09c1a6b1b0ce93079be4e4807d534fe685086cc5310c91e058fcc90b0037a01320c966592983995fa9b741cc4c2b010df74e42f0efbe912f178b738224c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef677357dd1c0918698011500b1dc6edadf2130ef41244ad7568ac075981c4027563763ba551a772953d70d3e0bd574aa1caea5d30edd489165b3e65fa6643b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/091c0f185dad9560358ad8dd936cd430566927edf1469f80cba144ac787c7ce8c15b2aa7c00236e682f9adb1a4265971e4eecce9e4e3ffb310e149551e875767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/040f0fbe58269de0427e42edc5598349e36313254fecef16985ac9f1000282b8fbbba06f433827f873fefd3c2316dfe236c6c7772066d0e5b4bc47aa031f9b70"} 07:58:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:56 INFO - Copying logs to upload dir... 07:58:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.225238 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-19 07:58:53.904936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 07:58:53.908816) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3da09c1a6b1b0ce93079be4e4807d534fe685086cc5310c91e058fcc90b0037a01320c966592983995fa9b741cc4c2b010df74e42f0efbe912f178b738224c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef677357dd1c0918698011500b1dc6edadf2130ef41244ad7568ac075981c4027563763ba551a772953d70d3e0bd574aa1caea5d30edd489165b3e65fa6643b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/091c0f185dad9560358ad8dd936cd430566927edf1469f80cba144ac787c7ce8c15b2aa7c00236e682f9adb1a4265971e4eecce9e4e3ffb310e149551e875767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/040f0fbe58269de0427e42edc5598349e36313254fecef16985ac9f1000282b8fbbba06f433827f873fefd3c2316dfe236c6c7772066d0e5b4bc47aa031f9b70"} build_url:https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011592 build_url: 'https://queue.taskcluster.net/v1/task/WyQgG9Y6SgWR8JHC-NBEhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3da09c1a6b1b0ce93079be4e4807d534fe685086cc5310c91e058fcc90b0037a01320c966592983995fa9b741cc4c2b010df74e42f0efbe912f178b738224c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef677357dd1c0918698011500b1dc6edadf2130ef41244ad7568ac075981c4027563763ba551a772953d70d3e0bd574aa1caea5d30edd489165b3e65fa6643b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/091c0f185dad9560358ad8dd936cd430566927edf1469f80cba144ac787c7ce8c15b2aa7c00236e682f9adb1a4265971e4eecce9e4e3ffb310e149551e875767", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/040f0fbe58269de0427e42edc5598349e36313254fecef16985ac9f1000282b8fbbba06f433827f873fefd3c2316dfe236c6c7772066d0e5b4bc47aa031f9b70"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 07:58:53.936136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:58:53.936460) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1482161483.506879-1740058125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 07:58:54.019349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 07:58:54.019764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 07:58:54.020058) ========= ========= Total master_lag: 0.16 =========