builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1477018772.65 results: success (0) buildid: 20161020165949 builduid: df213a843fca46d2829e25f439558eba revision: d61548e284cacc0dea96ae32f15a50dff7c4eb24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.650359) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.650816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.651098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.665662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.665976) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 19:59:33-- 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.4M=0s 2016-10-20 19:59:33 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.804604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.804919) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019389 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.854116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:32.854501) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d61548e284cacc0dea96ae32f15a50dff7c4eb24 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d61548e284cacc0dea96ae32f15a50dff7c4eb24 --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=97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 19:59:33,577 truncating revision to first 12 chars 2016-10-20 19:59:33,577 Setting DEBUG logging. 2016-10-20 19:59:33,577 attempt 1/10 2016-10-20 19:59:33,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d61548e284ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 19:59:34,060 unpacking tar archive at: mozilla-aurora-d61548e284ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.812875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:33.680715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:33.681050) ========= script_repo_revision: d61548e284cacc0dea96ae32f15a50dff7c4eb24 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:33.681503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:33.681791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 19:59:33.690710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-20 19:59:33.691076) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:34 INFO - MultiFileLogger online at 20161020 19:59:34 in /builds/slave/test 19:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:59:34 INFO - {'append_to_log': False, 19:59:34 INFO - 'base_work_dir': '/builds/slave/test', 19:59:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:59:34 INFO - 'branch': 'Mozilla-Aurora', 19:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:34 INFO - 'config_files': ('talos/linux_config.py',), 19:59:34 INFO - 'default_actions': ('clobber', 19:59:34 INFO - 'read-buildbot-config', 19:59:34 INFO - 'download-and-extract', 19:59:34 INFO - 'populate-webroot', 19:59:34 INFO - 'create-virtualenv', 19:59:34 INFO - 'install', 19:59:34 INFO - 'run-tests'), 19:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:34 INFO - 'download_minidump_stackwalk': True, 19:59:34 INFO - 'download_symbols': 'ondemand', 19:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:34 INFO - 'installer_path': 'installer.exe', 19:59:34 INFO - 'log_level': 'info', 19:59:34 INFO - 'log_name': 'talos', 19:59:34 INFO - 'log_to_console': True, 19:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:34 INFO - 'opt_config_files': (), 19:59:34 INFO - 'pip_index': False, 19:59:34 INFO - 'sps_profile': False, 19:59:34 INFO - 'sps_profile_interval': 0, 19:59:34 INFO - 'suite': 'dromaeojs', 19:59:34 INFO - 'system_bits': '32', 19:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:34 INFO - 'title': 'talos-linux64-ix-068', 19:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:34 INFO - 'use_talos_json': True, 19:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:34 INFO - 'work_dir': 'build'} 19:59:34 INFO - [mozharness: 2016-10-21 02:59:34.505228Z] Running clobber step. 19:59:34 INFO - Running pre-action listener: _resource_record_pre_action 19:59:34 INFO - Running main action method: clobber 19:59:34 INFO - rmtree: /builds/slave/test/build 19:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:59:34 INFO - Running post-action listener: _resource_record_post_action 19:59:34 INFO - [mozharness: 2016-10-21 02:59:34.982346Z] Finished clobber step (success) 19:59:34 INFO - [mozharness: 2016-10-21 02:59:34.982446Z] Running read-buildbot-config step. 19:59:34 INFO - Running pre-action listener: _resource_record_pre_action 19:59:34 INFO - Running main action method: read_buildbot_config 19:59:34 INFO - Using buildbot properties: 19:59:34 INFO - { 19:59:34 INFO - "project": "", 19:59:34 INFO - "product": "firefox", 19:59:34 INFO - "script_repo_revision": "production", 19:59:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:59:34 INFO - "repository": "", 19:59:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:59:34 INFO - "buildid": "20161020165949", 19:59:34 INFO - "pgo_build": "True", 19:59:34 INFO - "basedir": "/builds/slave/test", 19:59:34 INFO - "buildnumber": 542, 19:59:34 INFO - "slavename": "talos-linux64-ix-068", 19:59:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:59:34 INFO - "platform": "ubuntu64_hw", 19:59:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:59:34 INFO - "branch": "mozilla-aurora", 19:59:34 INFO - "repo_path": "releases/mozilla-aurora", 19:59:34 INFO - "revision": "d61548e284cacc0dea96ae32f15a50dff7c4eb24", 19:59:34 INFO - "stage_platform": "linux64-pgo", 19:59:34 INFO - "builduid": "df213a843fca46d2829e25f439558eba", 19:59:34 INFO - "slavebuilddir": "test" 19:59:34 INFO - } 19:59:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 19:59:34 INFO - Running post-action listener: _resource_record_post_action 19:59:34 INFO - [mozharness: 2016-10-21 02:59:34.984888Z] Finished read-buildbot-config step (success) 19:59:34 INFO - [mozharness: 2016-10-21 02:59:34.984976Z] Running download-and-extract step. 19:59:34 INFO - Running pre-action listener: _resource_record_pre_action 19:59:34 INFO - Running main action method: download_and_extract 19:59:34 INFO - mkdir: /builds/slave/test/build/tests 19:59: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')]} 19:59:34 INFO - trying https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:59:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:59:35 INFO - Downloaded 1361 bytes. 19:59:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:59:35 INFO - Using the following test package requirements: 19:59:35 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:59:35 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:35 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:59:35 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'jsshell-linux-x86_64.zip'], 19:59:35 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:35 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:59:35 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:59:35 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:59:35 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:35 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:35 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:59:36 INFO - Expected file size: 21908284 19:59:40 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:59:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:59:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:59:41 INFO - Expected file size: 21908284 19:59:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 19:59:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:59:45 INFO - Fetch https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 19:59:46 INFO - Expected file size: 14414081 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:46 INFO - trying https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:59:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:59:47 INFO - Downloaded 64008175 bytes. 19:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:59:47 INFO - mkdir: /builds/slave/test/properties 19:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:47 INFO - Contents: 19:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - Running post-action listener: set_extra_try_arguments 19:59:48 INFO - [mozharness: 2016-10-21 02:59:48.462107Z] Finished download-and-extract step (success) 19:59:48 INFO - [mozharness: 2016-10-21 02:59:48.462334Z] Running populate-webroot step. 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: populate_webroot 19:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:48 INFO - '--tppagecycles', 19:59:48 INFO - '7'], 19:59:48 INFO - 'tests': ['tsvgm']}}, 19:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['damp', 'tps']}, 19:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['damp', 'tps']}, 19:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['dromaeo_dom']}, 19:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['basic_compositor_video']}, 19:59:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore', 19:59:48 INFO - 'tabpaint']}, 19:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore', 19:59:48 INFO - 'tabpaint']}, 19:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore', 19:59:48 INFO - 'tabpaint']}, 19:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore', 19:59:48 INFO - 'tabpaint']}, 19:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore', 19:59:48 INFO - 'tabpaint']}, 19:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore', 19:59:48 INFO - 'tabpaint']}, 19:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['tsvgx', 19:59:48 INFO - 'tsvgr_opacity', 19:59:48 INFO - 'tart', 19:59:48 INFO - 'tscrollx', 19:59:48 INFO - 'cart']}, 19:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:59:48 INFO - 'tsvgr_opacity', 19:59:48 INFO - 'tart', 19:59:48 INFO - 'tscrollx', 19:59:48 INFO - 'cart']}, 19:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--disable-e10s'], 19:59:48 INFO - 'tests': ['tp5o']}, 19:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['tp5o']}, 19:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--disable-e10s', 19:59:48 INFO - '--xperf_path', 19:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:48 INFO - 'tests': ['tp5n']}, 19:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--xperf_path', 19:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:48 INFO - 'tests': ['tp5n']}}, 19:59:48 INFO - 'talos.zip': {'path': '', 19:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - [mozharness: 2016-10-21 02:59:48.480180Z] Finished populate-webroot step (success) 19:59:48 INFO - [mozharness: 2016-10-21 02:59:48.480268Z] Running create-virtualenv step. 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: create_virtualenv 19:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:48 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 19:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:48 INFO - Using real prefix '/usr' 19:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:49 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:51 INFO - Installing pip.................done. 19:59:51 INFO - Return code: 0 19:59:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:51 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')]} 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:51 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')]} 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:51 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 19:59:51 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 19:59:51 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 19:59:51 INFO - Using env: {'DISPLAY': ':0', 19:59:51 INFO - 'HOME': '/home/cltbld', 19:59:51 INFO - 'LANG': 'en_US.UTF-8', 19:59:51 INFO - 'LANGUAGE': 'en_US:en', 19:59:51 INFO - 'LOGNAME': 'cltbld', 19:59:51 INFO - 'MAIL': '/var/mail/cltbld', 19:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:51 INFO - 'MOZ_NO_REMOTE': '1', 19:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:51 INFO - 'NO_EM_RESTART': '1', 19:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:51 INFO - 'PWD': '/builds/slave/test', 19:59:51 INFO - 'SHELL': '/bin/bash', 19:59:51 INFO - 'SHLVL': '1', 19:59:51 INFO - 'TERM': 'linux', 19:59:51 INFO - 'TMOUT': '86400', 19:59:51 INFO - 'USER': 'cltbld', 19:59:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 19:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:51 INFO - '_': '/tools/buildbot/bin/python'} 19:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:51 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 19:59:51 INFO - Cleaning up... 19:59:51 INFO - Return code: 0 19:59:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:59:51 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')]} 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:51 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')]} 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:51 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 19:59:51 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 19:59:51 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 19:59:51 INFO - Using env: {'DISPLAY': ':0', 19:59:51 INFO - 'HOME': '/home/cltbld', 19:59:51 INFO - 'LANG': 'en_US.UTF-8', 19:59:51 INFO - 'LANGUAGE': 'en_US:en', 19:59:51 INFO - 'LOGNAME': 'cltbld', 19:59:51 INFO - 'MAIL': '/var/mail/cltbld', 19:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:51 INFO - 'MOZ_NO_REMOTE': '1', 19:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:51 INFO - 'NO_EM_RESTART': '1', 19:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:51 INFO - 'PWD': '/builds/slave/test', 19:59:51 INFO - 'SHELL': '/bin/bash', 19:59:51 INFO - 'SHLVL': '1', 19:59:51 INFO - 'TERM': 'linux', 19:59:51 INFO - 'TMOUT': '86400', 19:59:51 INFO - 'USER': 'cltbld', 19:59:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 19:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:51 INFO - '_': '/tools/buildbot/bin/python'} 19:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:51 INFO - Downloading/unpacking psutil>=3.1.1 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:51 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 19:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:53 INFO - Installing collected packages: psutil 19:59:53 INFO - Running setup.py install for psutil 19:59:53 INFO - building 'psutil._psutil_linux' extension 19:59:53 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 19:59:53 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 19:59:53 INFO - building 'psutil._psutil_posix' extension 19:59:53 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 19:59:53 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 19:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:54 INFO - Successfully installed psutil 19:59:54 INFO - Cleaning up... 19:59:54 INFO - Return code: 0 19:59:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:59:54 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')]} 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:54 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')]} 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:54 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 19:59:54 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 19:59:54 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 19:59:54 INFO - Using env: {'DISPLAY': ':0', 19:59:54 INFO - 'HOME': '/home/cltbld', 19:59:54 INFO - 'LANG': 'en_US.UTF-8', 19:59:54 INFO - 'LANGUAGE': 'en_US:en', 19:59:54 INFO - 'LOGNAME': 'cltbld', 19:59:54 INFO - 'MAIL': '/var/mail/cltbld', 19:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:54 INFO - 'MOZ_NO_REMOTE': '1', 19:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:54 INFO - 'NO_EM_RESTART': '1', 19:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:54 INFO - 'PWD': '/builds/slave/test', 19:59:54 INFO - 'SHELL': '/bin/bash', 19:59:54 INFO - 'SHLVL': '1', 19:59:54 INFO - 'TERM': 'linux', 19:59:54 INFO - 'TMOUT': '86400', 19:59:54 INFO - 'USER': 'cltbld', 19:59:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 19:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:54 INFO - '_': '/tools/buildbot/bin/python'} 19:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:59:54 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 19:59:54 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 19:59:54 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 19:59:54 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 19:59:54 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 19:59:54 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 19:59:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:59:56 INFO - Installing collected packages: mozsystemmonitor 19:59:56 INFO - Running setup.py install for mozsystemmonitor 19:59:56 INFO - Successfully installed mozsystemmonitor 19:59:56 INFO - Cleaning up... 19:59:56 INFO - Return code: 0 19:59:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 19:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:59:56 INFO - Using env: {'DISPLAY': ':0', 19:59:56 INFO - 'HOME': '/home/cltbld', 19:59:56 INFO - 'LANG': 'en_US.UTF-8', 19:59:56 INFO - 'LANGUAGE': 'en_US:en', 19:59:56 INFO - 'LOGNAME': 'cltbld', 19:59:56 INFO - 'MAIL': '/var/mail/cltbld', 19:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:56 INFO - 'MOZ_NO_REMOTE': '1', 19:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:56 INFO - 'NO_EM_RESTART': '1', 19:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:56 INFO - 'PWD': '/builds/slave/test', 19:59:56 INFO - 'SHELL': '/bin/bash', 19:59:56 INFO - 'SHLVL': '1', 19:59:56 INFO - 'TERM': 'linux', 19:59:56 INFO - 'TMOUT': '86400', 19:59:56 INFO - 'USER': 'cltbld', 19:59:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 19:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:56 INFO - '_': '/tools/buildbot/bin/python'} 19:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:56 INFO - Downloading/unpacking jsonschema==2.5.1 19:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:58 INFO - warning: no files found matching '*.txt' 19:59:58 INFO - no previously-included directories found matching 'build' 19:59:58 INFO - no previously-included directories found matching 'dist' 19:59:58 INFO - no previously-included directories found matching '.git*' 19:59:58 INFO - Installing collected packages: jsonschema, functools32 19:59:58 INFO - Running setup.py install for functools32 19:59:59 INFO - warning: no files found matching '*.txt' 19:59:59 INFO - no previously-included directories found matching 'build' 19:59:59 INFO - no previously-included directories found matching 'dist' 19:59:59 INFO - no previously-included directories found matching '.git*' 19:59:59 INFO - Successfully installed jsonschema functools32 19:59:59 INFO - Cleaning up... 19:59:59 INFO - Return code: 0 19:59:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:59:59 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')]} 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:59 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')]} 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:59 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 19:59:59 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 19:59:59 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 19:59:59 INFO - Using env: {'DISPLAY': ':0', 19:59:59 INFO - 'HOME': '/home/cltbld', 19:59:59 INFO - 'LANG': 'en_US.UTF-8', 19:59:59 INFO - 'LANGUAGE': 'en_US:en', 19:59:59 INFO - 'LOGNAME': 'cltbld', 19:59:59 INFO - 'MAIL': '/var/mail/cltbld', 19:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:59 INFO - 'MOZ_NO_REMOTE': '1', 19:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:59 INFO - 'NO_EM_RESTART': '1', 19:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:59 INFO - 'PWD': '/builds/slave/test', 19:59:59 INFO - 'SHELL': '/bin/bash', 19:59:59 INFO - 'SHLVL': '1', 19:59:59 INFO - 'TERM': 'linux', 19:59:59 INFO - 'TMOUT': '86400', 19:59:59 INFO - 'USER': 'cltbld', 19:59:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 19:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:59 INFO - '_': '/tools/buildbot/bin/python'} 19:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:59:59 INFO - Cleaning up... 19:59:59 INFO - Return code: 0 19:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59:59 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')]} 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:59 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')]} 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:59 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 19:59:59 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 19:59:59 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 19:59:59 INFO - Using env: {'DISPLAY': ':0', 19:59:59 INFO - 'HOME': '/home/cltbld', 19:59:59 INFO - 'LANG': 'en_US.UTF-8', 19:59:59 INFO - 'LANGUAGE': 'en_US:en', 19:59:59 INFO - 'LOGNAME': 'cltbld', 19:59:59 INFO - 'MAIL': '/var/mail/cltbld', 19:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:59 INFO - 'MOZ_NO_REMOTE': '1', 19:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:59 INFO - 'NO_EM_RESTART': '1', 19:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:59 INFO - 'PWD': '/builds/slave/test', 19:59:59 INFO - 'SHELL': '/bin/bash', 19:59:59 INFO - 'SHLVL': '1', 19:59:59 INFO - 'TERM': 'linux', 19:59:59 INFO - 'TMOUT': '86400', 19:59:59 INFO - 'USER': 'cltbld', 19:59:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 19:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:59 INFO - '_': '/tools/buildbot/bin/python'} 19:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:00:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:02 INFO - Downloading docopt-0.6.1.tar.gz 20:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:00:02 INFO - Running setup.py install for blobuploader 20:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:00:02 INFO - Running setup.py install for requests 20:00:02 INFO - Running setup.py install for docopt 20:00:02 INFO - Successfully installed blobuploader requests docopt 20:00:02 INFO - Cleaning up... 20:00:02 INFO - Return code: 0 20:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 20:00:02 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 20:00:02 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 20:00:02 INFO - Using env: {'DISPLAY': ':0', 20:00:02 INFO - 'HOME': '/home/cltbld', 20:00:02 INFO - 'LANG': 'en_US.UTF-8', 20:00:02 INFO - 'LANGUAGE': 'en_US:en', 20:00:02 INFO - 'LOGNAME': 'cltbld', 20:00:02 INFO - 'MAIL': '/var/mail/cltbld', 20:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:02 INFO - 'MOZ_NO_REMOTE': '1', 20:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:02 INFO - 'NO_EM_RESTART': '1', 20:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:02 INFO - 'PWD': '/builds/slave/test', 20:00:02 INFO - 'SHELL': '/bin/bash', 20:00:02 INFO - 'SHLVL': '1', 20:00:02 INFO - 'TERM': 'linux', 20:00:02 INFO - 'TMOUT': '86400', 20:00:02 INFO - 'USER': 'cltbld', 20:00:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 20:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:02 INFO - '_': '/tools/buildbot/bin/python'} 20:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:03 INFO - Running setup.py (path:/tmp/pip-qTd50L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:03 INFO - Running setup.py (path:/tmp/pip-oqKJx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:03 INFO - Running setup.py (path:/tmp/pip-o8CYZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:03 INFO - Running setup.py (path:/tmp/pip-RllkRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:03 INFO - Running setup.py (path:/tmp/pip-LkKHQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:03 INFO - Running setup.py (path:/tmp/pip-qWKAjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:03 INFO - Running setup.py (path:/tmp/pip-5TA5Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:03 INFO - Running setup.py (path:/tmp/pip-NGnMzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:03 INFO - Running setup.py (path:/tmp/pip-EAgRAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:03 INFO - Running setup.py (path:/tmp/pip-al6byy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:03 INFO - Running setup.py (path:/tmp/pip-AXdH9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:03 INFO - Running setup.py (path:/tmp/pip-_qo0v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:03 INFO - Running setup.py (path:/tmp/pip-X_VFW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:04 INFO - Running setup.py (path:/tmp/pip-WM4aqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:04 INFO - Running setup.py (path:/tmp/pip-Tp9kQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:04 INFO - Running setup.py (path:/tmp/pip-6jBJQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:04 INFO - Running setup.py (path:/tmp/pip-bixkwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:04 INFO - Running setup.py install for manifestparser 20:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:00:04 INFO - Running setup.py install for mozcrash 20:00:04 INFO - Running setup.py install for mozdebug 20:00:04 INFO - Running setup.py install for mozdevice 20:00:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:00:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:00:04 INFO - Running setup.py install for mozfile 20:00:04 INFO - Running setup.py install for mozhttpd 20:00:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:00:04 INFO - Running setup.py install for mozinfo 20:00:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for mozInstall 20:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for mozleak 20:00:05 INFO - Running setup.py install for mozlog 20:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for moznetwork 20:00:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for mozprocess 20:00:05 INFO - Running setup.py install for mozprofile 20:00:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for mozrunner 20:00:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:00:05 INFO - Running setup.py install for mozscreenshot 20:00:05 INFO - Running setup.py install for moztest 20:00:06 INFO - Running setup.py install for mozversion 20:00:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:00:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:06 INFO - Cleaning up... 20:00:06 INFO - Return code: 0 20:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:06 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 20:00:06 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 20:00:06 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 20:00:06 INFO - Using env: {'DISPLAY': ':0', 20:00:06 INFO - 'HOME': '/home/cltbld', 20:00:06 INFO - 'LANG': 'en_US.UTF-8', 20:00:06 INFO - 'LANGUAGE': 'en_US:en', 20:00:06 INFO - 'LOGNAME': 'cltbld', 20:00:06 INFO - 'MAIL': '/var/mail/cltbld', 20:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:06 INFO - 'MOZ_NO_REMOTE': '1', 20:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:06 INFO - 'NO_EM_RESTART': '1', 20:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:06 INFO - 'PWD': '/builds/slave/test', 20:00:06 INFO - 'SHELL': '/bin/bash', 20:00:06 INFO - 'SHLVL': '1', 20:00:06 INFO - 'TERM': 'linux', 20:00:06 INFO - 'TMOUT': '86400', 20:00:06 INFO - 'USER': 'cltbld', 20:00:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 20:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:06 INFO - '_': '/tools/buildbot/bin/python'} 20:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:06 INFO - Running setup.py (path:/tmp/pip-wFjN8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:06 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)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:06 INFO - Running setup.py (path:/tmp/pip-CU5VeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:06 INFO - Running setup.py (path:/tmp/pip-Rxl8Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:06 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)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:06 INFO - Running setup.py (path:/tmp/pip-Lfrqfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:06 INFO - Running setup.py (path:/tmp/pip-WOdicA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:06 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)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:06 INFO - Running setup.py (path:/tmp/pip-Pb2xCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:06 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)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:06 INFO - Running setup.py (path:/tmp/pip-dXePnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:06 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)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:06 INFO - Running setup.py (path:/tmp/pip-zxaKQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:06 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)) 20:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:06 INFO - Running setup.py (path:/tmp/pip-yAUg7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:07 INFO - Running setup.py (path:/tmp/pip-jVTeUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:07 INFO - Running setup.py (path:/tmp/pip-oV0Vee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:07 INFO - Running setup.py (path:/tmp/pip-TCS7F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:07 INFO - Running setup.py (path:/tmp/pip-3mB7tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:07 INFO - Running setup.py (path:/tmp/pip-92xJi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:07 INFO - Running setup.py (path:/tmp/pip-06mpPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:07 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)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:07 INFO - Running setup.py (path:/tmp/pip-74nEmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:07 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)) 20:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:07 INFO - Running setup.py (path:/tmp/pip-8zPzyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:07 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)) 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:00:07 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)) 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:07 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 20:00:07 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 20:00:07 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 20:00:07 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 20:00:07 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 20:00:07 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 20:00:09 INFO - Downloading blessings-1.6.tar.gz 20:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:09 INFO - Installing collected packages: blessings 20:00:09 INFO - Running setup.py install for blessings 20:00:09 INFO - Successfully installed blessings 20:00:09 INFO - Cleaning up... 20:00:09 INFO - Return code: 0 20:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:10 INFO - Reading from file tmpfile_stdout 20:00:10 INFO - Current package versions: 20:00:10 INFO - argparse == 1.2.1 20:00:10 INFO - blessings == 1.6 20:00:10 INFO - blobuploader == 1.2.4 20:00:10 INFO - docopt == 0.6.1 20:00:10 INFO - functools32 == 3.2.3-2 20:00:10 INFO - jsonschema == 2.5.1 20:00:10 INFO - manifestparser == 1.1 20:00:10 INFO - mozInstall == 1.12 20:00:10 INFO - mozcrash == 0.17 20:00:10 INFO - mozdebug == 0.1 20:00:10 INFO - mozdevice == 0.48 20:00:10 INFO - mozfile == 1.2 20:00:10 INFO - mozhttpd == 0.7 20:00:10 INFO - mozinfo == 0.9 20:00:10 INFO - mozleak == 0.1 20:00:10 INFO - mozlog == 3.4 20:00:10 INFO - moznetwork == 0.27 20:00:10 INFO - mozprocess == 0.23 20:00:10 INFO - mozprofile == 0.28 20:00:10 INFO - mozrunner == 6.12 20:00:10 INFO - mozscreenshot == 0.1 20:00:10 INFO - mozsystemmonitor == 0.3 20:00:10 INFO - moztest == 0.7 20:00:10 INFO - mozversion == 1.4 20:00:10 INFO - psutil == 3.1.1 20:00:10 INFO - requests == 1.2.3 20:00:10 INFO - wsgiref == 0.1.2 20:00:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:10 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')]} 20:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:10 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')]} 20:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:10 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 20:00:10 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 20:00:10 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 20:00:10 INFO - Using env: {'DISPLAY': ':0', 20:00:10 INFO - 'HOME': '/home/cltbld', 20:00:10 INFO - 'LANG': 'en_US.UTF-8', 20:00:10 INFO - 'LANGUAGE': 'en_US:en', 20:00:10 INFO - 'LOGNAME': 'cltbld', 20:00:10 INFO - 'MAIL': '/var/mail/cltbld', 20:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:10 INFO - 'MOZ_NO_REMOTE': '1', 20:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:10 INFO - 'NO_EM_RESTART': '1', 20:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:10 INFO - 'PWD': '/builds/slave/test', 20:00:10 INFO - 'SHELL': '/bin/bash', 20:00:10 INFO - 'SHLVL': '1', 20:00:10 INFO - 'TERM': 'linux', 20:00:10 INFO - 'TMOUT': '86400', 20:00:10 INFO - 'USER': 'cltbld', 20:00:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 20:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:10 INFO - '_': '/tools/buildbot/bin/python'} 20:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 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)) 20:00:10 INFO - Cleaning up... 20:00:10 INFO - Return code: 0 20:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:00:10 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')]} 20:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:10 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')]} 20:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:10 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 0x7f32728bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2358ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', '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 20:00:10 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 20:00:10 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 20:00:10 INFO - Using env: {'DISPLAY': ':0', 20:00:10 INFO - 'HOME': '/home/cltbld', 20:00:10 INFO - 'LANG': 'en_US.UTF-8', 20:00:10 INFO - 'LANGUAGE': 'en_US:en', 20:00:10 INFO - 'LOGNAME': 'cltbld', 20:00:10 INFO - 'MAIL': '/var/mail/cltbld', 20:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:10 INFO - 'MOZ_NO_REMOTE': '1', 20:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:10 INFO - 'NO_EM_RESTART': '1', 20:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:10 INFO - 'PWD': '/builds/slave/test', 20:00:10 INFO - 'SHELL': '/bin/bash', 20:00:10 INFO - 'SHLVL': '1', 20:00:10 INFO - 'TERM': 'linux', 20:00:10 INFO - 'TMOUT': '86400', 20:00:10 INFO - 'USER': 'cltbld', 20:00:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 20:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:10 INFO - '_': '/tools/buildbot/bin/python'} 20:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:00:10 INFO - Cleaning up... 20:00:10 INFO - Return code: 0 20:00:10 INFO - Running post-action listener: _resource_record_post_action 20:00:10 INFO - Running post-action listener: _start_resource_monitoring 20:00:10 INFO - Starting resource monitoring. 20:00:10 INFO - [mozharness: 2016-10-21 03:00:10.507611Z] Finished create-virtualenv step (success) 20:00:10 INFO - [mozharness: 2016-10-21 03:00:10.508067Z] Running install step. 20:00:10 INFO - Running pre-action listener: _resource_record_pre_action 20:00:10 INFO - Running main action method: install 20:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:10 INFO - Reading from file tmpfile_stdout 20:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:00:10 INFO - Reading from file tmpfile_stdout 20:00:10 INFO - Output received: 20:00:10 INFO - Usage: mozinstall [options] installer 20:00:10 INFO - Options: 20:00:10 INFO - -h, --help show this help message and exit 20:00:10 INFO - -d DEST, --destination=DEST 20:00:10 INFO - Directory to install application into. [default: 20:00:10 INFO - "/builds/slave/test"] 20:00:10 INFO - --app=APP Application being installed. [default: firefox] 20:00:10 INFO - mkdir: /builds/slave/test/build/application 20:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:00:26 INFO - Reading from file tmpfile_stdout 20:00:26 INFO - Output received: 20:00:26 INFO - /builds/slave/test/build/application/firefox/firefox 20:00:26 INFO - Running post-action listener: _resource_record_post_action 20:00:26 INFO - [mozharness: 2016-10-21 03:00:26.827182Z] Finished install step (success) 20:00:26 INFO - [mozharness: 2016-10-21 03:00:26.827428Z] Running run-tests step. 20:00:26 INFO - Running pre-action listener: _resource_record_pre_action 20:00:26 INFO - Running main action method: run_tests 20:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:26 INFO - Python 2.7.3 20:00:26 INFO - Return code: 0 20:00:26 INFO - grabbing minidump binary from tooltool 20:00:26 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')]} 20:00:26 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 0x2355f60>, '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 0x2356d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23571d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:26 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 20:00:26 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 20:00:26 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 20:00:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:26 INFO - Return code: 0 20:00:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:00:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:00:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 20:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 20:00:26 INFO - Using env: {'DISPLAY': ':0', 20:00:26 INFO - 'HOME': '/home/cltbld', 20:00:26 INFO - 'LANG': 'en_US.UTF-8', 20:00:26 INFO - 'LANGUAGE': 'en_US:en', 20:00:26 INFO - 'LOGNAME': 'cltbld', 20:00:26 INFO - 'MAIL': '/var/mail/cltbld', 20:00:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:26 INFO - 'MOZ_NO_REMOTE': '1', 20:00:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:26 INFO - 'NO_EM_RESTART': '1', 20:00:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:26 INFO - 'PWD': '/builds/slave/test', 20:00:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:26 INFO - 'SHELL': '/bin/bash', 20:00:26 INFO - 'SHLVL': '1', 20:00:26 INFO - 'TERM': 'linux', 20:00:26 INFO - 'TMOUT': '86400', 20:00:26 INFO - 'USER': 'cltbld', 20:00:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031', 20:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:26 INFO - '_': '/tools/buildbot/bin/python'} 20:00:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 20:00:27 INFO - mozversion application_buildid: 20161020165949 20:00:27 INFO - mozversion application_changeset: d61548e284cacc0dea96ae32f15a50dff7c4eb24 20:00:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:27 INFO - mozversion application_name: Firefox 20:00:27 INFO - mozversion application_remotingname: firefox-dev 20:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:00:27 INFO - mozversion application_vendor: Mozilla 20:00:27 INFO - mozversion application_version: 51.0a2 20:00:27 INFO - mozversion platform_buildid: 20161020165949 20:00:27 INFO - mozversion platform_changeset: d61548e284cacc0dea96ae32f15a50dff7c4eb24 20:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:00:27 INFO - mozversion platform_version: 51.0a2 20:00:27 INFO - using testdate: 1477018827 20:00:27 INFO - actual date: 1477018827 20:00:27 INFO - starting webserver on 'localhost:54468' 20:00:27 INFO - SUITE-START | Running 2 tests 20:00:27 INFO - TEST-START | dromaeo_css 20:00:27 INFO - operating with platform_type : linux_ 20:00:27 INFO - Initialising browser for dromaeo_css test... 20:00:27 INFO - TEST-INFO | started process 2953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v5n2B/profile http://localhost:54468/getInfo.html) 20:00:31 INFO - PROCESS | 2953 | __metrics Screen width/height:1600/1200 20:00:31 INFO - PROCESS | 2953 | colorDepth:24 20:00:31 INFO - PROCESS | 2953 | Browser inner width/height: 1024/697 20:00:31 INFO - PROCESS | 2953 | __metrics 20:00:31 INFO - PROCESS | 2953 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:00:31 INFO - PROCESS | 2953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:32 INFO - PROCESS | 2953 | console.error: PushService: 20:00:32 INFO - PROCESS | 2953 | stateChangeProcessEnqueue: Error transitioning state 20:00:32 INFO - PROCESS | 2953 | UnknownError 20:00:32 INFO - TEST-INFO | 2953: exit 0 20:00:32 INFO - Browser initialized. 20:00:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:32 INFO - TEST-INFO | started process 3043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v5n2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:44 INFO - PROCESS | 3043 | RSS: Main: 145358848 20:00:44 INFO - PROCESS | 3043 | 20:01:35 INFO - PROCESS | 3043 | 1477018895779 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] 20:03:45 INFO - PROCESS | 3043 | Cycle 1(1): loaded http://localhost:54468/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54468/tests/dromaeo/cssquery-ext.html) 20:03:46 INFO - PROCESS | 3043 | RSS: Main: 264069120 20:03:46 INFO - PROCESS | 3043 | 20:06:48 INFO - PROCESS | 3043 | Cycle 1(1): loaded http://localhost:54468/tests/dromaeo/cssquery-ext.html (next: http://localhost:54468/tests/dromaeo/cssquery-jquery.html) 20:06:49 INFO - PROCESS | 3043 | RSS: Main: 236068864 20:06:49 INFO - PROCESS | 3043 | 20:09:51 INFO - PROCESS | 3043 | Cycle 1(1): loaded http://localhost:54468/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54468/tests/dromaeo/cssquery-mootools.html) 20:09:51 INFO - PROCESS | 3043 | RSS: Main: 175886336 20:09:51 INFO - PROCESS | 3043 | 20:12:53 INFO - PROCESS | 3043 | Cycle 1(1): loaded http://localhost:54468/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54468/tests/dromaeo/cssquery-prototype.html) 20:12:54 INFO - PROCESS | 3043 | RSS: Main: 175067136 20:12:54 INFO - PROCESS | 3043 | 20:15:57 INFO - PROCESS | 3043 | Cycle 1(1): loaded http://localhost:54468/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54468/tests/dromaeo/cssquery-yui.html) 20:15:57 INFO - PROCESS | 3043 | RSS: Main: 177623040 20:15:57 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | Cycle 1(1): loaded http://localhost:54468/tests/dromaeo/cssquery-yui.html (next: http://localhost:54468/tests/dromaeo/cssquery-dojo.html) 20:19:00 INFO - PROCESS | 3043 | RSS: Main: 258965504 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | __start_tp_report 20:19:00 INFO - PROCESS | 3043 | _x_x_mozilla_page_load 20:19:00 INFO - PROCESS | 3043 | _x_x_mozilla_page_load_details 20:19:00 INFO - PROCESS | 3043 | |i|pagename|runs| 20:19:00 INFO - PROCESS | 3043 | |0;dojo.html;3077.830719310438;3121.5005599104147;3131.3580715953244;3150.527420886868;3168.7781855270127;5467.179923011546;5542.39033706293;5544.8336549903515;5570.693611851357;5574.414686457919;5584.804531841386;5648.435156484349;5651.689157096358;5658.60389772715;5673.177389278552;5038.21907604321;5087.720175390352;5133.512316329943;5170.53465188133;5173.896522069556;5008.774605142778;5131.717755523445;5189.221616757479;5194.11700010999;5194.8441546753465;4981.825636102737;5006.173981293082;5070.188769796833;5094.898102037957;5108.948910510903;5102.515261050195;5128.333316668809;5130.897382052375;5184.688918664892;5185.714785686786;5022.347094877679;5090.312807770941;5134.845954621367;5149.613778966593;5176.482351764831;5370.248165256867;5433.022056029913;5442.047641662693;5500.202470641774;5510.118381059051;5916.852078698024;5931.584789064767;5940.049592065248;5942.613730107572;5945.375735547792;5992.640441573476;5997.730102145414;6000.789972350991;6000.849978750566;6002.879942401171;5356.9732151339385;5412.107002344608;5458.099413596791;5552.861178470571;5568.860778480571;6081.17904082952;6081.543884208702;6086.204669005438;6111.816645500642;6120.908186377208;5818.94181058184;5830.533557315404;5833.416658334218;5835.883282334329;5841.561882858802;5728.598998070095;5769.480746732815;5852.209951656557;5868.647881127146;5911.379305172981;5937.821865344046;5979.611325263931;5981.222441082718;5985.221921150222;6021.307549631849;5931.110333450017;5946.375630558729;5948.791792287336;5975.611585247032;5980.102984552352;4416.3596278539435;4605.723656580549;4611.584957353787;4613.331066995267;4638.582527572535;3992.780397078189;4066.8169932353117;4068.5524592294823;4079.204555111784;4085.7957102144774;5582.190582365615;5629;5636.323641163087;5645.350784659735;5649.830505084854;5976.850578735566;5994.970025149846;6026.728797204137;6039.7282122304605;6071.301800293023;5691.004074286983;5700.971495142498;5706.543476521868;5711.857203569861;5712.371639119693;4960.280759289883;5012.172991456442;5200.193969934666;5202.3497062867145;5214.582833373321;5963.344032156459;6077.058056001327;6104.481119104926;6169.105479705418;6180.6291622502795;5979.953508135972;6000.129981152796;6018.518518518596;6020.51835853122;6058.7273572688455;6141.785037523665;6147.631142131487;6154.692265386623;6157.630542167484;6172.722227499863;5709.286339207599;5739.971300143473;5777.0179069557435;5855.063189889597;5865.178874957424;6031.396860313934;6035.336113027475;6051.334353221054;6064.484518815773;6068.332483426908;5915.822525324247;5917.91123133162;5922.73347699346;5925.200097986889;5927.14056461802;5612.7754889803955;5627.0434026214825;5778.94221057784;5874.794382196603;5888.852778680567;5865.618734782225;5900.64596124234;5919.348871624032;5922.496587790086;5935.525157987437;5906.527477801679;5927.851803704942;5928.9110663339225;5939.792107276225;5943.64338139713;5532.5297349724115;5599.692016938944;5674.858128546819;5768.740406681625;5824.679642619527 20:19:00 INFO - PROCESS | 3043 | |1;ext.html;593.0866465642907;633.448899457472;658.4863806231141;663.4294506724218;668.8528523724779;35007.47488787667;35703.64296357035;46809.999999999956;47506.762466187705;47532.76233618827;46168.76915615417;50993.745031274884;51016;51024.74487627557;51054.48945510544;8450.704225352114;9409.623615055407;9573.569189386459;9576.47329396883;9585;8835.249003834682;11028.613998510054;11290.548378064868;11298.943505282463;11728.237664551776;11485.081193504542;11544.422778861066;11555.2489088209;11558.768824623503;11561.884381156207;11332.150088743336;11365.431728413547;11399.430028498542;11409.657710268706;11415.714607134763;11238.719032024183;11354.48904799286;11380.487878045426;11387.943060284728;11390.316581005167;46130;46333.30500042502;46339.53660463386;46365;46426.53573464256;3825.368814145663;3831.65515103642;3847.7883716395586;3895.435161901537;3900.804959752001;35803;36231;36668.083297917765;36871.262574748354;37777.811110944545;4617.8152873885;4694.788734506956;4810.374651295344;4836.951630483685;4866.951330486685;361400;363334;364204;365047;365351;66388;66687;66820.33179668238;66878.66560667165;66879;40643;41309.380359294635;41525.169496610506;44192.3371149433;44271.114577708264;19431.319903803298;19596.608067838562;19618.70571941422;19626.411207663794;19636.607267854564;13734.313284335944;14087.929560352133;14645.414183432757;14986.700265994838;15111.697766044837;20676.276330328667;20676.58646827055;20947.16211351529;21012;21073.683894741593;7520.887186692204;7589;7652.081750190013;7752.410755795048;7762.534247945141;1021.4841505040056;1056.571425723532;1058.7829494953517;1090.51472094917;1150.1373969522858;35114;35435.64564354375;35712.107197319754;35812.363839866084;35834.81019256252;1000.8348622477355;1028.6245520385005;1050.821360368739;1052.347544522401;1150.2810743285447;18015.468685161908;18483.260669573065;18571.25714971413;18609.627807443776;18757.155927983273;617245;621527;621973;624150;624355;44085.559144408784;44280.778596106815;44347.113057738665;44388.3341749874;44517.109657806664;1321.6431563478;1359.4222455456588;1399.4682020832222;1422.5163444428945;1469.9710202858041;31397.68602314039;36087;36157.457638134925;36754.26491470102;36796.448053278684;54999.72500137474;55653.99999999838;55662;55726;55869.44130558642;443923;445008;446413;448978.79595417634;449594;29005.12984610465;29787;29974.85012574923;30017.249568760955;33981.83009084939;52869.471305287996;53224.73387633037;53265.4673453276;53694.194587082005;53925.19112213398;44339.11321773611;44642.776786115865;46152.307715384966;46476.535234648574;47732.76133619449;45181.548184517735;45778.54221457876;46863;47496;48434.75782621064;44348.33477497775;44385.33421998608;44636.10727785361;46036.30945535887;47938.280925785446;37521;39987.80006099951;40595.59404405918;40952.59047409607;40996.18007639771;30087;30208.848955755082;30451;30673.53989690112;30843.228919277197 20:19:00 INFO - PROCESS | 3043 | |2;jquery.html;392.95873933237027;414.15099046953753;426.18385791209835;436.70304193148644;442.7387841173707;15214.847851521481;19277.31319260818;21151.259705910295;21183.57632847342;21361.572768544658;19508.90245548774;20010.69983950242;20110.195592176296;20196.697049544233;20275.898620506912;5744.310682718069;5987.131865879445;5992.161097446361;5993.101034844786;5993.250843644544;5757.942420575803;6034.306054803688;6063.575549711522;6122.755089796403;6138.0792881067755;6046.244219472566;6119.051547010221;6122.571420000601;6126.050462178369;6571.408573228408;6540.3132671069325;6568.967155164241;6574.638394888279;6578.835529111762;6583.210014798231;5272.209168624737;5450.836474905759;5484.122540393558;5484.670919744828;5903.557233207526;22239.221627243132;22576;22701.978410971547;22868.77131228683;23000.309990700305;2205.2061257947125;2879.424115176973;3073.0627158716584;3136.168915237441;3145.480995635717;10832.512536935857;10914.072303854182;11160.944195279053;11162.274452160584;11343.886561134366;1943.6112777444425;1973.7434133562688;2011.426743378145;2015.4356780101596;2068.958620827575;82727.17272827255;82728.58635706843;85531.5723421379;85775.57112214399;85947;10086.344387614781;11286.717832054264;11401.657950261506;11751.588694395656;11828.467718952668;15180.240987950558;27948.72051279461;31937.361252774816;32292.35415291681;32571.022869313958;10822.24244302907;10874.18443616732;10902.182336324808;11277.943610281896;11370.772584548262;9093.454392736458;9252.444853308823;9613.855792163124;9649.469279189712;9649.855252171223;8965.731028069169;9266.073392660815;9406.200472959876;9583.137517623447;9602.279829012852;3447.517347571342;3457.2048428861503;3644.4351125575577;3702.962970370316;3763.5483741951143;907.7458311672742;966.8308046091905;992.4938281476499;1004.4174378860243;1040.8186708086225;19128.521786955436;20367.185312587626;20403.591928161353;20407.285744998855;20502;970.7718686108759;1003.3327836988467;1004.6483730694199;1006.4816619440994;1048.7745134796055;11081.833772493419;11341.43292835355;11436;11564.363959982282;11672.474738636613;456391;464750;478653;479066;483994;73381;88398.55800720955;88873.55563222272;91325;92898;1020.7397113736098;1030.6083688198437;1057.6668349469892;1061.3843970497094;1062.1449732965036;17479.650406992045;17892.55268618295;17997.820021800137;18044.729329060337;18287.634247315244;41636.58363416448;42337.364939526546;43111.784441077594;43723.56276437322;44185.558144418144;54504.45495544994;59176.704116479144;59706.40293597182;60810.69594651998;61173.38826611855;8706.738797836075;8794.384393092678;8937.553122343726;9035.548222588975;9056.456612603264;12807.679808004874;13453.730925381242;13717.108387954751;13803.930980345436;13984.300784960915;11619.5352185915;11705.765884682429;11831.585894493652;11945.940270298941;11977.401129943642;11540.596079137189;11822.940885295862;11975.221610595283;12088.697782555506;12472.625821225378;11581.710457238636;11606.593769218374;11868.991135753558;12144.392780361124;12420.503179872703;8118.350531957547;8215.835683286421;8310.667573297;8694.608742606471;9017.917849858059;10600.787984240425;11585.304881707125;11988.520459181884;12140.757184856076;12198.390080495763 20:19:00 INFO - PROCESS | 3043 | |3;mootools.html;1344.5630170194688;1491.9104853708777;1516.1736853414889;1678.6990082685918;1829.2042961311831;8079.151689072651;8985.10148985102;9357.204637605802;9368.437893726381;9692.66075687351;9271.629134834599;9440.339176257648;9442.622295108205;9447.433154010765;9451.196648284887;2499.6500489931423;2527.2039307618043;2527.5071361084597;2529.3170843872144;2532.987335063322;2424.369663887393;2490.8380955237944;2492.6510288559616;2495.8502489850666;2496.8252222344445;2423.866687332196;2427.5387676341525;2481.702195736514;2486.552420564298;2486.5772818620876;2394.0543485323287;2403.627437747152;2411.8794060297005;2424.321190066775;2435;2374.81001519878;2408.0849277274697;2408.277516744987;2411.360989337827;2415.263344679872;9125;9235.353525253235;9267.675631352939;9289.90710092904;9395.62417503306;5446.700431476267;5641.266635337421;5650.576206784508;5667.263255776764;5688.459596338341;3589.4436362363876;3622.456631505269;3649.4708267301357;3664.6518580734787;3734.8879533613763;1109.2401704832216;1124.797536443448;1145.873953865074;1186.0689358853258;1187.1155988788407;13092.738145237137;13190.67023324415;13223.404946777418;13277.46890124394;13301.201927884358;4765.69023013503;4777.402824646919;4886.022795440926;4965.776540055706;4982.825601104017;10359.430231337197;10369.688909332732;10375.221858360503;10396.896031039592;10397.58409663605;5525.668459892339;5533.335999680065;5535.501804837584;5538.169274608841;5544;4399.428074350378;4519.141363140992;5059.443461219263;5128.282040514331;5195.3246078009615;4152.130285231978;4168.291390463629;4182.562668530898;4209.284421648266;4236.533981262059;1214.6902539852458;1225.503671013241;1254.7992321228742;1268.5813681485088;1277.6678063703318;754.2495217258862;834.4701114792151;916.4089162490156;926.7683079230193;971.121135372489;6356.237251529754;6359.077933699587;6475.643839588868;6583.07836902834;6634.137562116894;1000.564754331868;1030.36172485748;1051.984220236697;1061.8778840433295;1080.8865069167782;4366.694331396835;4392;4488.663350248745;4531.071130418322;4632.166210082218;11654.941725291319;12047.879521204852;12051.517939282507;12097.758044839054;12122.575709850289;11233;11977.820332695017;12018.098642601839;12039.097067719957;12082.395880205955;8640.870386944202;9054.683086091954;9055.1850333469;9067.727968160965;9068.138526839939;6451.41937225652;6560.179977502812;6572.671366431564;6733.192016957996;6868.862622747617;10570.524326405484;10987.61543345979;10989.340639561651;11015.944920275348;11124.388158651353;11043.116550675766;11191;11345.205835591429;11361;11436.313821170423;8580.570971451527;8584.871226931476;8630.050694423733;8711.912880871363;8745.256653184551;8780.956095219739;8824.11758824138;8834.734957951272;8835.514046727492;8838.513881736566;7793.06483222017;7840.255175758294;7883.763487095396;7998.080220774453;8186.7953301167945;7844.176361481962;7857.410694198073;7872.881906771518;7959.164287749702;7978.720744773905;7417.184109748031;7419.925800741924;7496;7558.281963213486;7558.357539609195;5461.836144915659;5558.055130627884;5584.497395234448;5628.493435590816;5634.464725851201;5426.213199086189;5459.672419654833;5580.302462192226;5624.887502250014;5658.292713410824 20:19:00 INFO - PROCESS | 3043 | |4;prototype.html;342.6950014487106;357.75315032627486;362.5124207940319;363.55646111743664;366.15783697495755;5548.306461692288;5551.611387202897;5579.414161513038;5617.466340697637;5626.352969408519;5439.5920305977015;5483.917741233885;5511.311086114236;5514.696691681956;5521.365043020054;3851.961480385188;4079.6736261099113;4260;4319.956800432003;4322.881787923926;4316.56834316569;4327.437433133704;4328.329108988112;4328.619259407329;4338.869833904972;4290.4636920384955;4301.5698430157045;4311.978440107795;4314.899700576349;4322.481302243719;4001.8799436016966;4119.443875076856;4151.925440495209;4304.504981927056;4330.501992270898;3827.5406951166037;3836.271108489378;3840.615938406165;3851.1912498375373;3855.151866589374;5286.233496143076;5313;5313.0967735485065;5317.973410132963;5360.517553420211;4869.391326084239;4939;4967.82612608557;4974.825881094181;4977.452480227172;5688.8862222755315;5693.861227754424;5695.943040569624;5706.687461883748;5720.971395143039;4244.766537840417;4244.893877653052;4266.5946735060115;4279.7218180818145;4284.2930916398755;5569.888602227933;5719.19931209631;5753.309602847643;5886.822635472922;5971.850703732398;4104.8152833122585;4200.348945913388;4212.094399704017;4215.536291007987;4239.0674051708575;4353.368761529624;4353.49934757507;4367.803448844809;4368.84225680195;4369.946125321094;4790.4969978152485;4953.7120348709595;4954.851354459372;4980.651354405157;5003.149464590955;5737.84418569785;5749.367569567345;5763.6541807491685;5765.538756899522;5786.479216870418;1494.2230040378943;1501.6321001354738;1505.6235941014747;1508.5700575335977;1510.4184888817665;902.1499658132699;928.8281667891462;933.7432206143229;936.9906300936904;940.7930255343813;5008.774605142778;5020.723860187724;5033.364156649103;5035.77339019745;5035.874103147451;5191.8182863599595;5205.323307970016;5221.738913054332;5225.686458812484;5233.973830130825;4667.2031267962075;4922;4962.354893863847;5004.799808007711;5018.971110922253;2759.8960415833826;2773.9167824965284;2782.4296019315993;2792.7346902044274;2797.8736160517747;5316.6544174628525;5328.547073498796;5340.572754179656;5340.813071542555;5354.705491198021;5294.735263236823;5331.760070796823;5697.857553561112;6050.031994880886;6062.545309101835;6070.696465176724;6079.3920607939735;6082.300535438393;6111;6121.724522396414;5634.985702573576;5933.554983376178;5961.165436838759;5979.701014949148;6015.488683461955;5780.971095144666;5838.795642152674;5870;5884.735186916685;5911.379305173067;5816.82549523515;5941.613795103304;6003.909941350796;6068.969655151696;6123.7244324006415;4263.76549289792;4268.6917638830155;4269.91460170801;4282.715185444416;4294.677899157513;5815.156802263733;5943.197668314895;5980.8803823924145;5995.340512543529;6001.519878409629;5717.628354156966;5769.94230057694;5770.163326317576;5799.536037117105;5806.577388539835;5793.522651723783;5801.94198058014;5811.86668599619;5900.822975310747;5904.498117660047;5547.528460080938;5807.622504537191;5812.558725335285;5842.853928651818;5844.6785426801935;5838.503727183237;5838.970805145947;5856.150858125633;5882.382349853204;5894.557908156819;5506.752196151263;5704.686242256716;5728.684922329312;5755.223044889054;5775.826725198251 20:19:00 INFO - PROCESS | 3043 | |5;yui.html;731.049635473884;792.7225471085118;811.2455416462689;853.9103394143615;868.8175483148539;16385.42651007215;16548.586285342873;16785.580360490992;18049.63900721985;18055.368062117814;16123.355065797383;16492.752608710878;16500.33998640053;16526.83473165268;16531.421400250994;719.377738256407;739.6227923758868;859.8022454835392;872.6945569050845;875.5972252763736;842.0316635868769;867.8177582707639;868.3574155125193;871.9476831390106;880.2473884828476;903.9096090390941;904.3940559824933;905.9456432614064;906.1708536688922;907.6414816147618;742.4839736383216;767.0335377424485;901.1844280925773;901.4591245252828;901.6528636474972;650.8015055408099;659.1464054050017;661.6691654172913;661.6956200147938;663.4029373563783;14802.629934251621;15017.924910375488;15024.09855408668;15034.548963531111;15072.924635376863;15256.542303730796;15787.28957196929;15802.762958555631;15882.126483043428;16174.35302587895;13891.861081389157;14112.717745645132;14185.716285674333;14192.92903535486;14393.496227632088;4643.187442197602;4681.461631912305;4713.835015774432;4730.881727956794;4810.63920205986;88005.55997220037;91475;92554.53722731343;93345;94488.52755736247;10997.61508347204;11444.14168937333;12103.75792484163;12873.485060597659;12888.226706397647;24015.759842401352;24115.15596954098;24147.63778543323;24175.153869614478;24364;8791.912080879109;9014.098590140933;9098.454092754324;9234.261259099256;9364.484953327496;4976.800927962841;5178.223266510054;5209.609279304067;5234.2933703949475;5270.420253772082;3532.434810430319;3652.5069115669044;3658.0854786303425;3666.7433279670167;3673.393890008119;629.329763801559;632.7563887903099;645.2192846655599;645.7255666341786;650.8642418978912;629.7481007596998;675.4393853102011;699.566268913277;702.1959855964892;709.4218212157075;8615.710531312177;9244.630214791467;9267.907320926839;9281.67514137002;9544.379615324982;602.4276936909953;623.5136593457111;643.8422586466346;708.0512113767576;726.0670038999859;4548.727076375428;4560;4590.586847183769;4622.6764126510825;4765.547273009059;122427.77572224164;127130;138048.30975845057;138866.305668471;138921;66648;107125.4643726792;114665;117343.41328293475;119454.40272798754;98108.50945745225;99347;101217;102614.48692756638;107055;8660.39377243587;8854.026057133582;8955.194032537103;9050.50905397727;9085.318601104811;55105;59030;60078.09882851848;60141;61057;55073.724631376586;64421.355786441534;74650.25349746433;79964;84330.57834710788;13665.248411337074;13727.656808579466;13857.584272471842;13888.583342499742;14013.502776014782;15182.240887955337;15332.386704531693;15389.846101538842;15533.45632902843;16093.275802588678;13931.72136557243;14429.278536072945;14542.127472351693;14710.338034788674;15339.846601534287;13132.212067275994;13355.265460399383;13429;13523.932380338036;13537.997231840716;13528;13546.525871594447;13705.314734263446;14142.646433839236;14608.342624581706;10011.849822252527;10331.94834025825;10359;10554.577816887238;10604.469776510989;10871.29336593119;11029.338239705643;11178.496967636638;11200.327980321206;11306.547738090385 20:19:00 INFO - PROCESS | 3043 | __end_tp_report 20:19:00 INFO - PROCESS | 3043 | __start_cc_report 20:19:00 INFO - PROCESS | 3043 | _x_x_mozilla_cycle_collect,935 20:19:00 INFO - PROCESS | 3043 | __end_cc_report 20:19:00 INFO - PROCESS | 3043 | __startTimestamp1477019940562__endTimestamp 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | ------- Summary: start ------- 20:19:00 INFO - PROCESS | 3043 | Number of tests: 6 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | [#0] dojo.html Cycles:165 Average:5540.98 Median:5739.97 stddev:637.89 (11.1%) stddev-sans-first:609.87 20:19:00 INFO - PROCESS | 3043 | Values: 3077.8 3121.5 3131.4 3150.5 3168.8 5467.2 5542.4 5544.8 5570.7 5574.4 5584.8 5648.4 5651.7 5658.6 5673.2 5038.2 5087.7 5133.5 5170.5 5173.9 5008.8 5131.7 5189.2 5194.1 5194.8 4981.8 5006.2 5070.2 5094.9 5108.9 5102.5 5128.3 5130.9 5184.7 5185.7 5022.3 5090.3 5134.8 5149.6 5176.5 5370.2 5433.0 5442.0 5500.2 5510.1 5916.9 5931.6 5940.0 5942.6 5945.4 5992.6 5997.7 6000.8 6000.8 6002.9 5357.0 5412.1 5458.1 5552.9 5568.9 6081.2 6081.5 6086.2 6111.8 6120.9 5818.9 5830.5 5833.4 5835.9 5841.6 5728.6 5769.5 5852.2 5868.6 5911.4 5937.8 5979.6 5981.2 5985.2 6021.3 5931.1 5946.4 5948.8 5975.6 5980.1 4416.4 4605.7 4611.6 4613.3 4638.6 3992.8 4066.8 4068.6 4079.2 4085.8 5582.2 5629.0 5636.3 5645.4 5649.8 5976.9 5995.0 6026.7 6039.7 6071.3 5691.0 5701.0 5706.5 5711.9 5712.4 4960.3 5012.2 5200.2 5202.3 5214.6 5963.3 6077.1 6104.5 6169.1 6180.6 5980.0 6000.1 6018.5 6020.5 6058.7 6141.8 6147.6 6154.7 6157.6 6172.7 5709.3 5740.0 5777.0 5855.1 5865.2 6031.4 6035.3 6051.3 6064.5 6068.3 5915.8 5917.9 5922.7 5925.2 5927.1 5612.8 5627.0 5778.9 5874.8 5888.9 5865.6 5900.6 5919.3 5922.5 5935.5 5906.5 5927.9 5928.9 5939.8 5943.6 5532.5 5599.7 5674.9 5768.7 5824.7 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | [#1] ext.html Cycles:180 Average:64692.81 Median:3898.12 stddev:129942.30 (3333.5%) stddev-sans-first:130217.69 20:19:00 INFO - PROCESS | 3043 | Values: 593.1 633.4 658.5 663.4 668.9 35007.5 35703.6 46810.0 47506.8 47532.8 46168.8 50993.7 51016.0 51024.7 51054.5 8450.7 9409.6 9573.6 9576.5 9585.0 8835.2 11028.6 11290.5 11298.9 11728.2 11485.1 11544.4 11555.2 11558.8 11561.9 11332.2 11365.4 11399.4 11409.7 11415.7 11238.7 11354.5 11380.5 11387.9 11390.3 46130.0 46333.3 46339.5 46365.0 46426.5 3825.4 3831.7 3847.8 3895.4 3900.8 35803.0 36231.0 36668.1 36871.3 37777.8 4617.8 4694.8 4810.4 4837.0 4867.0 361400.0 363334.0 364204.0 365047.0 365351.0 66388.0 66687.0 66820.3 66878.7 66879.0 40643.0 41309.4 41525.2 44192.3 44271.1 19431.3 19596.6 19618.7 19626.4 19636.6 13734.3 14087.9 14645.4 14986.7 15111.7 20676.3 20676.6 20947.2 21012.0 21073.7 7520.9 7589.0 7652.1 7752.4 7762.5 1021.5 1056.6 1058.8 1090.5 1150.1 35114.0 35435.6 35712.1 35812.4 35834.8 1000.8 1028.6 1050.8 1052.3 1150.3 18015.5 18483.3 18571.3 18609.6 18757.2 617245.0 621527.0 621973.0 624150.0 624355.0 44085.6 44280.8 44347.1 44388.3 44517.1 1321.6 1359.4 1399.5 1422.5 1470.0 31397.7 36087.0 36157.5 36754.3 36796.4 54999.7 55654.0 55662.0 55726.0 55869.4 443923.0 445008.0 446413.0 448978.8 449594.0 29005.1 29787.0 29974.9 30017.2 33981.8 52869.5 53224.7 53265.5 53694.2 53925.2 44339.1 44642.8 46152.3 46476.5 47732.8 45181.5 45778.5 46863.0 47496.0 48434.8 44348.3 44385.3 44636.1 46036.3 47938.3 37521.0 39987.8 40595.6 40952.6 40996.2 30087.0 30208.8 30451.0 30673.5 30843.2 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | [#2] jquery.html Cycles:180 Average:29410.57 Median:3104.62 stddev:77864.52 (2508.0%) stddev-sans-first:78052.47 20:19:00 INFO - PROCESS | 3043 | Values: 393.0 414.2 426.2 436.7 442.7 15214.8 19277.3 21151.3 21183.6 21361.6 19508.9 20010.7 20110.2 20196.7 20275.9 5744.3 5987.1 5992.2 5993.1 5993.3 5757.9 6034.3 6063.6 6122.8 6138.1 6046.2 6119.1 6122.6 6126.1 6571.4 6540.3 6569.0 6574.6 6578.8 6583.2 5272.2 5450.8 5484.1 5484.7 5903.6 22239.2 22576.0 22702.0 22868.8 23000.3 2205.2 2879.4 3073.1 3136.2 3145.5 10832.5 10914.1 11160.9 11162.3 11343.9 1943.6 1973.7 2011.4 2015.4 2069.0 82727.2 82728.6 85531.6 85775.6 85947.0 10086.3 11286.7 11401.7 11751.6 11828.5 15180.2 27948.7 31937.4 32292.4 32571.0 10822.2 10874.2 10902.2 11277.9 11370.8 9093.5 9252.4 9613.9 9649.5 9649.9 8965.7 9266.1 9406.2 9583.1 9602.3 3447.5 3457.2 3644.4 3703.0 3763.5 907.7 966.8 992.5 1004.4 1040.8 19128.5 20367.2 20403.6 20407.3 20502.0 970.8 1003.3 1004.6 1006.5 1048.8 11081.8 11341.4 11436.0 11564.4 11672.5 456391.0 464750.0 478653.0 479066.0 483994.0 73381.0 88398.6 88873.6 91325.0 92898.0 1020.7 1030.6 1057.7 1061.4 1062.1 17479.7 17892.6 17997.8 18044.7 18287.6 41636.6 42337.4 43111.8 43723.6 44185.6 54504.5 59176.7 59706.4 60810.7 61173.4 8706.7 8794.4 8937.6 9035.5 9056.5 12807.7 13453.7 13717.1 13803.9 13984.3 11619.5 11705.8 11831.6 11945.9 11977.4 11540.6 11822.9 11975.2 12088.7 12472.6 11581.7 11606.6 11869.0 12144.4 12420.5 8118.4 8215.8 8310.7 8694.6 9017.9 10600.8 11585.3 11988.5 12140.8 12198.4 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | [#3] mootools.html Cycles:180 Average:6190.64 Median:4581.62 stddev:3557.15 (77.6%) stddev-sans-first:3548.49 20:19:00 INFO - PROCESS | 3043 | Values: 1344.6 1491.9 1516.2 1678.7 1829.2 8079.2 8985.1 9357.2 9368.4 9692.7 9271.6 9440.3 9442.6 9447.4 9451.2 2499.7 2527.2 2527.5 2529.3 2533.0 2424.4 2490.8 2492.7 2495.9 2496.8 2423.9 2427.5 2481.7 2486.6 2486.6 2394.1 2403.6 2411.9 2424.3 2435.0 2374.8 2408.1 2408.3 2411.4 2415.3 9125.0 9235.4 9267.7 9289.9 9395.6 5446.7 5641.3 5650.6 5667.3 5688.5 3589.4 3622.5 3649.5 3664.7 3734.9 1109.2 1124.8 1145.9 1186.1 1187.1 13092.7 13190.7 13223.4 13277.5 13301.2 4765.7 4777.4 4886.0 4965.8 4982.8 10359.4 10369.7 10375.2 10396.9 10397.6 5525.7 5533.3 5535.5 5538.2 5544.0 4399.4 4519.1 5059.4 5128.3 5195.3 4152.1 4168.3 4182.6 4209.3 4236.5 1214.7 1225.5 1254.8 1268.6 1277.7 754.2 834.5 916.4 926.8 971.1 6356.2 6359.1 6475.6 6583.1 6634.1 1000.6 1030.4 1052.0 1061.9 1080.9 4366.7 4392.0 4488.7 4531.1 4632.2 11654.9 12047.9 12051.5 12097.8 12122.6 11233.0 11977.8 12018.1 12039.1 12082.4 8640.9 9054.7 9055.2 9067.7 9068.1 6451.4 6560.2 6572.7 6733.2 6868.9 10570.5 10987.6 10989.3 11015.9 11124.4 11043.1 11191.0 11345.2 11361.0 11436.3 8580.6 8584.9 8630.1 8711.9 8745.3 8781.0 8824.1 8834.7 8835.5 8838.5 7793.1 7840.3 7883.8 7998.1 8186.8 7844.2 7857.4 7872.9 7959.2 7978.7 7417.2 7419.9 7496.0 7558.3 7558.4 5461.8 5558.1 5584.5 5628.5 5634.5 5426.2 5459.7 5580.3 5624.9 5658.3 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | [#4] prototype.html Cycles:180 Average:4775.98 Median:5323.26 stddev:1400.84 (26.3%) stddev-sans-first:1364.68 20:19:00 INFO - PROCESS | 3043 | Values: 342.7 357.8 362.5 363.6 366.2 5548.3 5551.6 5579.4 5617.5 5626.4 5439.6 5483.9 5511.3 5514.7 5521.4 3852.0 4079.7 4260.0 4320.0 4322.9 4316.6 4327.4 4328.3 4328.6 4338.9 4290.5 4301.6 4312.0 4314.9 4322.5 4001.9 4119.4 4151.9 4304.5 4330.5 3827.5 3836.3 3840.6 3851.2 3855.2 5286.2 5313.0 5313.1 5318.0 5360.5 4869.4 4939.0 4967.8 4974.8 4977.5 5688.9 5693.9 5695.9 5706.7 5721.0 4244.8 4244.9 4266.6 4279.7 4284.3 5569.9 5719.2 5753.3 5886.8 5971.9 4104.8 4200.3 4212.1 4215.5 4239.1 4353.4 4353.5 4367.8 4368.8 4369.9 4790.5 4953.7 4954.9 4980.7 5003.1 5737.8 5749.4 5763.7 5765.5 5786.5 1494.2 1501.6 1505.6 1508.6 1510.4 902.1 928.8 933.7 937.0 940.8 5008.8 5020.7 5033.4 5035.8 5035.9 5191.8 5205.3 5221.7 5225.7 5234.0 4667.2 4922.0 4962.4 5004.8 5019.0 2759.9 2773.9 2782.4 2792.7 2797.9 5316.7 5328.5 5340.6 5340.8 5354.7 5294.7 5331.8 5697.9 6050.0 6062.5 6070.7 6079.4 6082.3 6111.0 6121.7 5635.0 5933.6 5961.2 5979.7 6015.5 5781.0 5838.8 5870.0 5884.7 5911.4 5816.8 5941.6 6003.9 6069.0 6123.7 4263.8 4268.7 4269.9 4282.7 4294.7 5815.2 5943.2 5980.9 5995.3 6001.5 5717.6 5769.9 5770.2 5799.5 5806.6 5793.5 5801.9 5811.9 5900.8 5904.5 5547.5 5807.6 5812.6 5842.9 5844.7 5838.5 5839.0 5856.2 5882.4 5894.6 5506.8 5704.7 5728.7 5755.2 5775.8 20:19:00 INFO - PROCESS | 3043 | 20:19:00 INFO - PROCESS | 3043 | [#5] yui.html Cycles:180 Average:22840.24 Median:4632.93 stddev:34051.81 (735.0%) stddev-sans-first:34106.87 20:19:00 INFO - PROCESS | 3043 | Values: 731.0 792.7 811.2 853.9 868.8 16385.4 16548.6 16785.6 18049.6 18055.4 16123.4 16492.8 16500.3 16526.8 16531.4 719.4 739.6 859.8 872.7 875.6 842.0 867.8 868.4 871.9 880.2 903.9 904.4 905.9 906.2 907.6 742.5 767.0 901.2 901.5 901.7 650.8 659.1 661.7 661.7 663.4 14802.6 15017.9 15024.1 15034.5 15072.9 15256.5 15787.3 15802.8 15882.1 16174.4 13891.9 14112.7 14185.7 14192.9 14393.5 4643.2 4681.5 4713.8 4730.9 4810.6 88005.6 91475.0 92554.5 93345.0 94488.5 10997.6 11444.1 12103.8 12873.5 12888.2 24015.8 24115.2 24147.6 24175.2 24364.0 8791.9 9014.1 9098.5 9234.3 9364.5 4976.8 5178.2 5209.6 5234.3 5270.4 3532.4 3652.5 3658.1 3666.7 3673.4 629.3 632.8 645.2 645.7 650.9 629.7 675.4 699.6 702.2 709.4 8615.7 9244.6 9267.9 9281.7 9544.4 602.4 623.5 643.8 708.1 726.1 4548.7 4560.0 4590.6 4622.7 4765.5 122427.8 127130.0 138048.3 138866.3 138921.0 66648.0 107125.5 114665.0 117343.4 119454.4 98108.5 99347.0 101217.0 102614.5 107055.0 8660.4 8854.0 8955.2 9050.5 9085.3 55105.0 59030.0 60078.1 60141.0 61057.0 55073.7 64421.4 74650.3 79964.0 84330.6 13665.2 13727.7 13857.6 13888.6 14013.5 15182.2 15332.4 15389.8 15533.5 16093.3 13931.7 14429.3 14542.1 14710.3 15339.8 13132.2 13355.3 13429.0 13523.9 13538.0 13528.0 13546.5 13705.3 14142.6 14608.3 10011.8 10331.9 10359.0 10554.6 10604.5 10871.3 11029.3 11178.5 11200.3 11306.5 20:19:00 INFO - PROCESS | 3043 | -------- Summary: end -------- 20:19:00 INFO - PROCESS | 3043 | 20:19:01 INFO - TEST-INFO | 3043: exit 0 20:19:01 INFO - TEST-OK | dromaeo_css | took 1114265ms 20:19:01 INFO - TEST-START | kraken 20:19:01 INFO - operating with platform_type : linux_ 20:19:01 INFO - Initialising browser for kraken test... 20:19:01 INFO - TEST-INFO | started process 3365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYX3Thp/profile http://localhost:54468/getInfo.html) 20:19:05 INFO - PROCESS | 3365 | __metrics Screen width/height:1600/1200 20:19:05 INFO - PROCESS | 3365 | colorDepth:24 20:19:05 INFO - PROCESS | 3365 | Browser inner width/height: 1024/697 20:19:05 INFO - PROCESS | 3365 | __metrics 20:19:05 INFO - PROCESS | 3365 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:19:05 INFO - PROCESS | 3365 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:06 INFO - PROCESS | 3365 | console.error: PushService: 20:19:06 INFO - PROCESS | 3365 | stateChangeProcessEnqueue: Error transitioning state 20:19:06 INFO - PROCESS | 3365 | UnknownError 20:19:06 INFO - TEST-INFO | 3365: exit 0 20:19:06 INFO - Browser initialized. 20:19:06 INFO - Running cycle 1/1 for kraken test... 20:19:06 INFO - TEST-INFO | started process 3456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYX3Thp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:18 INFO - PROCESS | 3456 | RSS: Main: 148471808 20:19:18 INFO - PROCESS | 3456 | 20:19:21 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54468/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:22 INFO - PROCESS | 3456 | RSS: Main: 189546496 20:19:22 INFO - PROCESS | 3456 | 20:19:24 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54468/tests/kraken/driver.html?testName=audio-dft) 20:19:25 INFO - PROCESS | 3456 | RSS: Main: 178569216 20:19:25 INFO - PROCESS | 3456 | 20:19:27 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54468/tests/kraken/driver.html?testName=audio-fft) 20:19:28 INFO - PROCESS | 3456 | RSS: Main: 270319616 20:19:28 INFO - PROCESS | 3456 | 20:19:30 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54468/tests/kraken/driver.html?testName=audio-oscillator) 20:19:31 INFO - PROCESS | 3456 | RSS: Main: 176398336 20:19:31 INFO - PROCESS | 3456 | 20:19:33 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54468/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:33 INFO - PROCESS | 3456 | RSS: Main: 177901568 20:19:33 INFO - PROCESS | 3456 | 20:19:36 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54468/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:37 INFO - PROCESS | 3456 | RSS: Main: 214245376 20:19:37 INFO - PROCESS | 3456 | 20:19:40 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54468/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:41 INFO - PROCESS | 3456 | RSS: Main: 213004288 20:19:41 INFO - PROCESS | 3456 | 20:19:44 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54468/tests/kraken/driver.html?testName=json-parse-financial) 20:19:44 INFO - PROCESS | 3456 | RSS: Main: 212516864 20:19:44 INFO - PROCESS | 3456 | 20:19:46 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54468/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:47 INFO - PROCESS | 3456 | RSS: Main: 175218688 20:19:47 INFO - PROCESS | 3456 | 20:19:48 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:49 INFO - PROCESS | 3456 | RSS: Main: 183009280 20:19:49 INFO - PROCESS | 3456 | 20:19:51 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:51 INFO - PROCESS | 3456 | RSS: Main: 188788736 20:19:51 INFO - PROCESS | 3456 | 20:19:54 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:55 INFO - PROCESS | 3456 | RSS: Main: 197316608 20:19:55 INFO - PROCESS | 3456 | 20:19:57 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:58 INFO - PROCESS | 3456 | RSS: Main: 193908736 20:19:58 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:54468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54468/tests/kraken/driver.html?testName=ai-astar) 20:20:00 INFO - PROCESS | 3456 | RSS: Main: 245198848 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | __start_tp_report 20:20:00 INFO - PROCESS | 3456 | _x_x_mozilla_page_load 20:20:00 INFO - PROCESS | 3456 | _x_x_mozilla_page_load_details 20:20:00 INFO - PROCESS | 3456 | |i|pagename|runs| 20:20:00 INFO - PROCESS | 3456 | |0;ai-astar;111;113;112;112;111;115;112;110;112;111 20:20:00 INFO - PROCESS | 3456 | |1;audio-beat-detection;143;118;121;147;119;117;120;117;144;117 20:20:00 INFO - PROCESS | 3456 | |2;audio-dft;161;163;162;161;160;162;161;161;164;162 20:20:00 INFO - PROCESS | 3456 | |3;audio-fft;76;77;77;111;77;76;76;76;104;76 20:20:00 INFO - PROCESS | 3456 | |4;audio-oscillator;82;81;113;82;82;82;106;82;81;113 20:20:00 INFO - PROCESS | 3456 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 20:20:00 INFO - PROCESS | 3456 | |6;imaging-darkroom;146;146;146;146;146;145;146;148;146;145 20:20:00 INFO - PROCESS | 3456 | |7;imaging-desaturate;96;95;96;96;95;95;95;96;95;95 20:20:00 INFO - PROCESS | 3456 | |8;json-parse-financial;52;58;49;50;52;50;54;49;50;49 20:20:00 INFO - PROCESS | 3456 | |9;json-stringify-tinderbox;59;61;58;59;59;59;59;58;59;59 20:20:00 INFO - PROCESS | 3456 | |10;stanford-crypto-aes;74;81;77;82;73;74;77;74;80;73 20:20:00 INFO - PROCESS | 3456 | |11;stanford-crypto-ccm;123;130;128;123;119;128;124;135;160;121 20:20:00 INFO - PROCESS | 3456 | |12;stanford-crypto-pbkdf2;157;158;156;155;160;157;154;155;154;157 20:20:00 INFO - PROCESS | 3456 | |13;stanford-crypto-sha256-iterative;65;64;64;63;70;63;62;64;62;63 20:20:00 INFO - PROCESS | 3456 | __end_tp_report 20:20:00 INFO - PROCESS | 3456 | __start_cc_report 20:20:00 INFO - PROCESS | 3456 | _x_x_mozilla_cycle_collect,1619 20:20:00 INFO - PROCESS | 3456 | __end_cc_report 20:20:00 INFO - PROCESS | 3456 | __startTimestamp1477020000281__endTimestamp 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | ------- Summary: start ------- 20:20:00 INFO - PROCESS | 3456 | Number of tests: 14 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.37 (1.2%) stddev-sans-first:1.41 20:20:00 INFO - PROCESS | 3456 | Values: 111.0 113.0 112.0 112.0 111.0 115.0 112.0 110.0 112.0 111.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:120.50 stddev:12.78 (10.6%) stddev-sans-first:12.04 20:20:00 INFO - PROCESS | 3456 | Values: 143.0 118.0 121.0 147.0 119.0 117.0 120.0 117.0 144.0 117.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 20:20:00 INFO - PROCESS | 3456 | Values: 161.0 163.0 162.0 161.0 160.0 162.0 161.0 161.0 164.0 162.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.23 (17.4%) stddev-sans-first:13.82 20:20:00 INFO - PROCESS | 3456 | Values: 76.0 77.0 77.0 111.0 77.0 76.0 76.0 76.0 104.0 76.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:14.12 (17.2%) stddev-sans-first:14.65 20:20:00 INFO - PROCESS | 3456 | Values: 82.0 81.0 113.0 82.0 82.0 82.0 106.0 82.0 81.0 113.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:20:00 INFO - PROCESS | 3456 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 20:20:00 INFO - PROCESS | 3456 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 148.0 146.0 145.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:20:00 INFO - PROCESS | 3456 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:2.87 (5.6%) stddev-sans-first:3.03 20:20:00 INFO - PROCESS | 3456 | Values: 52.0 58.0 49.0 50.0 52.0 50.0 54.0 49.0 50.0 49.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 20:20:00 INFO - PROCESS | 3456 | Values: 59.0 61.0 58.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.00 stddev:3.44 (4.5%) stddev-sans-first:3.53 20:20:00 INFO - PROCESS | 3456 | Values: 74.0 81.0 77.0 82.0 73.0 74.0 77.0 74.0 80.0 73.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:128.00 stddev:11.84 (9.2%) stddev-sans-first:12.35 20:20:00 INFO - PROCESS | 3456 | Values: 123.0 130.0 128.0 123.0 119.0 128.0 124.0 135.0 160.0 121.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:157.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 20:20:00 INFO - PROCESS | 3456 | Values: 157.0 158.0 156.0 155.0 160.0 157.0 154.0 155.0 154.0 157.0 20:20:00 INFO - PROCESS | 3456 | 20:20:00 INFO - PROCESS | 3456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.31 (3.6%) stddev-sans-first:2.42 20:20:00 INFO - PROCESS | 3456 | Values: 65.0 64.0 64.0 63.0 70.0 63.0 62.0 64.0 62.0 63.0 20:20:00 INFO - PROCESS | 3456 | -------- Summary: end -------- 20:20:00 INFO - PROCESS | 3456 | 20:20:01 INFO - TEST-INFO | 3456: exit 0 20:20:01 INFO - TEST-OK | kraken | took 59976ms 20:20:01 INFO - SUITE-END | took 1174s 20:20:01 INFO - Completed test suite (00:19:34) 20:20:01 INFO - javascript benchmark 20:20:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.830719310438, 3121.5005599104147, 3131.3580715953244, 3150.527420886868, 3168.7781855270127, 5467.179923011546, 5542.39033706293, 5544.8336549903515, 5570.693611851357, 5574.414686457919, 5584.804531841386, 5648.435156484349, 5651.689157096358, 5658.60389772715, 5673.177389278552, 5038.21907604321, 5087.720175390352, 5133.512316329943, 5170.53465188133, 5173.896522069556, 5008.774605142778, 5131.717755523445, 5189.221616757479, 5194.11700010999, 5194.8441546753465, 4981.825636102737, 5006.173981293082, 5070.188769796833, 5094.898102037957, 5108.948910510903, 5102.515261050195, 5128.333316668809, 5130.897382052375, 5184.688918664892, 5185.714785686786, 5022.347094877679, 5090.312807770941, 5134.845954621367, 5149.613778966593, 5176.482351764831, 5370.248165256867, 5433.022056029913, 5442.047641662693, 5500.202470641774, 5510.118381059051, 5916.852078698024, 5931.584789064767, 5940.049592065248, 5942.613730107572, 5945.375735547792, 5992.640441573476, 5997.730102145414, 6000.789972350991, 6000.849978750566, 6002.879942401171, 5356.9732151339385, 5412.107002344608, 5458.099413596791, 5552.861178470571, 5568.860778480571, 6081.17904082952, 6081.543884208702, 6086.204669005438, 6111.816645500642, 6120.908186377208, 5818.94181058184, 5830.533557315404, 5833.416658334218, 5835.883282334329, 5841.561882858802, 5728.598998070095, 5769.480746732815, 5852.209951656557, 5868.647881127146, 5911.379305172981, 5937.821865344046, 5979.611325263931, 5981.222441082718, 5985.221921150222, 6021.307549631849, 5931.110333450017, 5946.375630558729, 5948.791792287336, 5975.611585247032, 5980.102984552352, 4416.3596278539435, 4605.723656580549, 4611.584957353787, 4613.331066995267, 4638.582527572535, 3992.780397078189, 4066.8169932353117, 4068.5524592294823, 4079.204555111784, 4085.7957102144774, 5582.190582365615, 5629.0, 5636.323641163087, 5645.350784659735, 5649.830505084854, 5976.850578735566, 5994.970025149846, 6026.728797204137, 6039.7282122304605, 6071.301800293023, 5691.004074286983, 5700.971495142498, 5706.543476521868, 5711.857203569861, 5712.371639119693, 4960.280759289883, 5012.172991456442, 5200.193969934666, 5202.3497062867145, 5214.582833373321, 5963.344032156459, 6077.058056001327, 6104.481119104926, 6169.105479705418, 6180.6291622502795, 5979.953508135972, 6000.129981152796, 6018.518518518596, 6020.51835853122, 6058.7273572688455, 6141.785037523665, 6147.631142131487, 6154.692265386623, 6157.630542167484, 6172.722227499863, 5709.286339207599, 5739.971300143473, 5777.0179069557435, 5855.063189889597, 5865.178874957424, 6031.396860313934, 6035.336113027475, 6051.334353221054, 6064.484518815773, 6068.332483426908, 5915.822525324247, 5917.91123133162, 5922.73347699346, 5925.200097986889, 5927.14056461802, 5612.7754889803955, 5627.0434026214825, 5778.94221057784, 5874.794382196603, 5888.852778680567, 5865.618734782225, 5900.64596124234, 5919.348871624032, 5922.496587790086, 5935.525157987437, 5906.527477801679, 5927.851803704942, 5928.9110663339225, 5939.792107276225, 5943.64338139713, 5532.5297349724115, 5599.692016938944, 5674.858128546819, 5768.740406681625, 5824.679642619527], "value": 5496.589112451901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.0866465642907, 633.448899457472, 658.4863806231141, 663.4294506724218, 668.8528523724779, 35007.47488787667, 35703.64296357035, 46809.999999999956, 47506.762466187705, 47532.76233618827, 46168.76915615417, 50993.745031274884, 51016.0, 51024.74487627557, 51054.48945510544, 8450.704225352114, 9409.623615055407, 9573.569189386459, 9576.47329396883, 9585.0, 8835.249003834682, 11028.613998510054, 11290.548378064868, 11298.943505282463, 11728.237664551776, 11485.081193504542, 11544.422778861066, 11555.2489088209, 11558.768824623503, 11561.884381156207, 11332.150088743336, 11365.431728413547, 11399.430028498542, 11409.657710268706, 11415.714607134763, 11238.719032024183, 11354.48904799286, 11380.487878045426, 11387.943060284728, 11390.316581005167, 46130.0, 46333.30500042502, 46339.53660463386, 46365.0, 46426.53573464256, 3825.368814145663, 3831.65515103642, 3847.7883716395586, 3895.435161901537, 3900.804959752001, 35803.0, 36231.0, 36668.083297917765, 36871.262574748354, 37777.811110944545, 4617.8152873885, 4694.788734506956, 4810.374651295344, 4836.951630483685, 4866.951330486685, 361400.0, 363334.0, 364204.0, 365047.0, 365351.0, 66388.0, 66687.0, 66820.33179668238, 66878.66560667165, 66879.0, 40643.0, 41309.380359294635, 41525.169496610506, 44192.3371149433, 44271.114577708264, 19431.319903803298, 19596.608067838562, 19618.70571941422, 19626.411207663794, 19636.607267854564, 13734.313284335944, 14087.929560352133, 14645.414183432757, 14986.700265994838, 15111.697766044837, 20676.276330328667, 20676.58646827055, 20947.16211351529, 21012.0, 21073.683894741593, 7520.887186692204, 7589.0, 7652.081750190013, 7752.410755795048, 7762.534247945141, 1021.4841505040056, 1056.571425723532, 1058.7829494953517, 1090.51472094917, 1150.1373969522858, 35114.0, 35435.64564354375, 35712.107197319754, 35812.363839866084, 35834.81019256252, 1000.8348622477355, 1028.6245520385005, 1050.821360368739, 1052.347544522401, 1150.2810743285447, 18015.468685161908, 18483.260669573065, 18571.25714971413, 18609.627807443776, 18757.155927983273, 617245.0, 621527.0, 621973.0, 624150.0, 624355.0, 44085.559144408784, 44280.778596106815, 44347.113057738665, 44388.3341749874, 44517.109657806664, 1321.6431563478, 1359.4222455456588, 1399.4682020832222, 1422.5163444428945, 1469.9710202858041, 31397.68602314039, 36087.0, 36157.457638134925, 36754.26491470102, 36796.448053278684, 54999.72500137474, 55653.99999999838, 55662.0, 55726.0, 55869.44130558642, 443923.0, 445008.0, 446413.0, 448978.79595417634, 449594.0, 29005.12984610465, 29787.0, 29974.85012574923, 30017.249568760955, 33981.83009084939, 52869.471305287996, 53224.73387633037, 53265.4673453276, 53694.194587082005, 53925.19112213398, 44339.11321773611, 44642.776786115865, 46152.307715384966, 46476.535234648574, 47732.76133619449, 45181.548184517735, 45778.54221457876, 46863.0, 47496.0, 48434.75782621064, 44348.33477497775, 44385.33421998608, 44636.10727785361, 46036.30945535887, 47938.280925785446, 37521.0, 39987.80006099951, 40595.59404405918, 40952.59047409607, 40996.18007639771, 30087.0, 30208.848955755082, 30451.0, 30673.53989690112, 30843.228919277197], "value": 21781.17569208638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.95873933237027, 414.15099046953753, 426.18385791209835, 436.70304193148644, 442.7387841173707, 15214.847851521481, 19277.31319260818, 21151.259705910295, 21183.57632847342, 21361.572768544658, 19508.90245548774, 20010.69983950242, 20110.195592176296, 20196.697049544233, 20275.898620506912, 5744.310682718069, 5987.131865879445, 5992.161097446361, 5993.101034844786, 5993.250843644544, 5757.942420575803, 6034.306054803688, 6063.575549711522, 6122.755089796403, 6138.0792881067755, 6046.244219472566, 6119.051547010221, 6122.571420000601, 6126.050462178369, 6571.408573228408, 6540.3132671069325, 6568.967155164241, 6574.638394888279, 6578.835529111762, 6583.210014798231, 5272.209168624737, 5450.836474905759, 5484.122540393558, 5484.670919744828, 5903.557233207526, 22239.221627243132, 22576.0, 22701.978410971547, 22868.77131228683, 23000.309990700305, 2205.2061257947125, 2879.424115176973, 3073.0627158716584, 3136.168915237441, 3145.480995635717, 10832.512536935857, 10914.072303854182, 11160.944195279053, 11162.274452160584, 11343.886561134366, 1943.6112777444425, 1973.7434133562688, 2011.426743378145, 2015.4356780101596, 2068.958620827575, 82727.17272827255, 82728.58635706843, 85531.5723421379, 85775.57112214399, 85947.0, 10086.344387614781, 11286.717832054264, 11401.657950261506, 11751.588694395656, 11828.467718952668, 15180.240987950558, 27948.72051279461, 31937.361252774816, 32292.35415291681, 32571.022869313958, 10822.24244302907, 10874.18443616732, 10902.182336324808, 11277.943610281896, 11370.772584548262, 9093.454392736458, 9252.444853308823, 9613.855792163124, 9649.469279189712, 9649.855252171223, 8965.731028069169, 9266.073392660815, 9406.200472959876, 9583.137517623447, 9602.279829012852, 3447.517347571342, 3457.2048428861503, 3644.4351125575577, 3702.962970370316, 3763.5483741951143, 907.7458311672742, 966.8308046091905, 992.4938281476499, 1004.4174378860243, 1040.8186708086225, 19128.521786955436, 20367.185312587626, 20403.591928161353, 20407.285744998855, 20502.0, 970.7718686108759, 1003.3327836988467, 1004.6483730694199, 1006.4816619440994, 1048.7745134796055, 11081.833772493419, 11341.43292835355, 11436.0, 11564.363959982282, 11672.474738636613, 456391.0, 464750.0, 478653.0, 479066.0, 483994.0, 73381.0, 88398.55800720955, 88873.55563222272, 91325.0, 92898.0, 1020.7397113736098, 1030.6083688198437, 1057.6668349469892, 1061.3843970497094, 1062.1449732965036, 17479.650406992045, 17892.55268618295, 17997.820021800137, 18044.729329060337, 18287.634247315244, 41636.58363416448, 42337.364939526546, 43111.784441077594, 43723.56276437322, 44185.558144418144, 54504.45495544994, 59176.704116479144, 59706.40293597182, 60810.69594651998, 61173.38826611855, 8706.738797836075, 8794.384393092678, 8937.553122343726, 9035.548222588975, 9056.456612603264, 12807.679808004874, 13453.730925381242, 13717.108387954751, 13803.930980345436, 13984.300784960915, 11619.5352185915, 11705.765884682429, 11831.585894493652, 11945.940270298941, 11977.401129943642, 11540.596079137189, 11822.940885295862, 11975.221610595283, 12088.697782555506, 12472.625821225378, 11581.710457238636, 11606.593769218374, 11868.991135753558, 12144.392780361124, 12420.503179872703, 8118.350531957547, 8215.835683286421, 8310.667573297, 8694.608742606471, 9017.917849858059, 10600.787984240425, 11585.304881707125, 11988.520459181884, 12140.757184856076, 12198.390080495763], "value": 10140.776256844027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.5630170194688, 1491.9104853708777, 1516.1736853414889, 1678.6990082685918, 1829.2042961311831, 8079.151689072651, 8985.10148985102, 9357.204637605802, 9368.437893726381, 9692.66075687351, 9271.629134834599, 9440.339176257648, 9442.622295108205, 9447.433154010765, 9451.196648284887, 2499.6500489931423, 2527.2039307618043, 2527.5071361084597, 2529.3170843872144, 2532.987335063322, 2424.369663887393, 2490.8380955237944, 2492.6510288559616, 2495.8502489850666, 2496.8252222344445, 2423.866687332196, 2427.5387676341525, 2481.702195736514, 2486.552420564298, 2486.5772818620876, 2394.0543485323287, 2403.627437747152, 2411.8794060297005, 2424.321190066775, 2435.0, 2374.81001519878, 2408.0849277274697, 2408.277516744987, 2411.360989337827, 2415.263344679872, 9125.0, 9235.353525253235, 9267.675631352939, 9289.90710092904, 9395.62417503306, 5446.700431476267, 5641.266635337421, 5650.576206784508, 5667.263255776764, 5688.459596338341, 3589.4436362363876, 3622.456631505269, 3649.4708267301357, 3664.6518580734787, 3734.8879533613763, 1109.2401704832216, 1124.797536443448, 1145.873953865074, 1186.0689358853258, 1187.1155988788407, 13092.738145237137, 13190.67023324415, 13223.404946777418, 13277.46890124394, 13301.201927884358, 4765.69023013503, 4777.402824646919, 4886.022795440926, 4965.776540055706, 4982.825601104017, 10359.430231337197, 10369.688909332732, 10375.221858360503, 10396.896031039592, 10397.58409663605, 5525.668459892339, 5533.335999680065, 5535.501804837584, 5538.169274608841, 5544.0, 4399.428074350378, 4519.141363140992, 5059.443461219263, 5128.282040514331, 5195.3246078009615, 4152.130285231978, 4168.291390463629, 4182.562668530898, 4209.284421648266, 4236.533981262059, 1214.6902539852458, 1225.503671013241, 1254.7992321228742, 1268.5813681485088, 1277.6678063703318, 754.2495217258862, 834.4701114792151, 916.4089162490156, 926.7683079230193, 971.121135372489, 6356.237251529754, 6359.077933699587, 6475.643839588868, 6583.07836902834, 6634.137562116894, 1000.564754331868, 1030.36172485748, 1051.984220236697, 1061.8778840433295, 1080.8865069167782, 4366.694331396835, 4392.0, 4488.663350248745, 4531.071130418322, 4632.166210082218, 11654.941725291319, 12047.879521204852, 12051.517939282507, 12097.758044839054, 12122.575709850289, 11233.0, 11977.820332695017, 12018.098642601839, 12039.097067719957, 12082.395880205955, 8640.870386944202, 9054.683086091954, 9055.1850333469, 9067.727968160965, 9068.138526839939, 6451.41937225652, 6560.179977502812, 6572.671366431564, 6733.192016957996, 6868.862622747617, 10570.524326405484, 10987.61543345979, 10989.340639561651, 11015.944920275348, 11124.388158651353, 11043.116550675766, 11191.0, 11345.205835591429, 11361.0, 11436.313821170423, 8580.570971451527, 8584.871226931476, 8630.050694423733, 8711.912880871363, 8745.256653184551, 8780.956095219739, 8824.11758824138, 8834.734957951272, 8835.514046727492, 8838.513881736566, 7793.06483222017, 7840.255175758294, 7883.763487095396, 7998.080220774453, 8186.7953301167945, 7844.176361481962, 7857.410694198073, 7872.881906771518, 7959.164287749702, 7978.720744773905, 7417.184109748031, 7419.925800741924, 7496.0, 7558.281963213486, 7558.357539609195, 5461.836144915659, 5558.055130627884, 5584.497395234448, 5628.493435590816, 5634.464725851201, 5426.213199086189, 5459.672419654833, 5580.302462192226, 5624.887502250014, 5658.292713410824], "value": 4912.464320430247, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6950014487106, 357.75315032627486, 362.5124207940319, 363.55646111743664, 366.15783697495755, 5548.306461692288, 5551.611387202897, 5579.414161513038, 5617.466340697637, 5626.352969408519, 5439.5920305977015, 5483.917741233885, 5511.311086114236, 5514.696691681956, 5521.365043020054, 3851.961480385188, 4079.6736261099113, 4260.0, 4319.956800432003, 4322.881787923926, 4316.56834316569, 4327.437433133704, 4328.329108988112, 4328.619259407329, 4338.869833904972, 4290.4636920384955, 4301.5698430157045, 4311.978440107795, 4314.899700576349, 4322.481302243719, 4001.8799436016966, 4119.443875076856, 4151.925440495209, 4304.504981927056, 4330.501992270898, 3827.5406951166037, 3836.271108489378, 3840.615938406165, 3851.1912498375373, 3855.151866589374, 5286.233496143076, 5313.0, 5313.0967735485065, 5317.973410132963, 5360.517553420211, 4869.391326084239, 4939.0, 4967.82612608557, 4974.825881094181, 4977.452480227172, 5688.8862222755315, 5693.861227754424, 5695.943040569624, 5706.687461883748, 5720.971395143039, 4244.766537840417, 4244.893877653052, 4266.5946735060115, 4279.7218180818145, 4284.2930916398755, 5569.888602227933, 5719.19931209631, 5753.309602847643, 5886.822635472922, 5971.850703732398, 4104.8152833122585, 4200.348945913388, 4212.094399704017, 4215.536291007987, 4239.0674051708575, 4353.368761529624, 4353.49934757507, 4367.803448844809, 4368.84225680195, 4369.946125321094, 4790.4969978152485, 4953.7120348709595, 4954.851354459372, 4980.651354405157, 5003.149464590955, 5737.84418569785, 5749.367569567345, 5763.6541807491685, 5765.538756899522, 5786.479216870418, 1494.2230040378943, 1501.6321001354738, 1505.6235941014747, 1508.5700575335977, 1510.4184888817665, 902.1499658132699, 928.8281667891462, 933.7432206143229, 936.9906300936904, 940.7930255343813, 5008.774605142778, 5020.723860187724, 5033.364156649103, 5035.77339019745, 5035.874103147451, 5191.8182863599595, 5205.323307970016, 5221.738913054332, 5225.686458812484, 5233.973830130825, 4667.2031267962075, 4922.0, 4962.354893863847, 5004.799808007711, 5018.971110922253, 2759.8960415833826, 2773.9167824965284, 2782.4296019315993, 2792.7346902044274, 2797.8736160517747, 5316.6544174628525, 5328.547073498796, 5340.572754179656, 5340.813071542555, 5354.705491198021, 5294.735263236823, 5331.760070796823, 5697.857553561112, 6050.031994880886, 6062.545309101835, 6070.696465176724, 6079.3920607939735, 6082.300535438393, 6111.0, 6121.724522396414, 5634.985702573576, 5933.554983376178, 5961.165436838759, 5979.701014949148, 6015.488683461955, 5780.971095144666, 5838.795642152674, 5870.0, 5884.735186916685, 5911.379305173067, 5816.82549523515, 5941.613795103304, 6003.909941350796, 6068.969655151696, 6123.7244324006415, 4263.76549289792, 4268.6917638830155, 4269.91460170801, 4282.715185444416, 4294.677899157513, 5815.156802263733, 5943.197668314895, 5980.8803823924145, 5995.340512543529, 6001.519878409629, 5717.628354156966, 5769.94230057694, 5770.163326317576, 5799.536037117105, 5806.577388539835, 5793.522651723783, 5801.94198058014, 5811.86668599619, 5900.822975310747, 5904.498117660047, 5547.528460080938, 5807.622504537191, 5812.558725335285, 5842.853928651818, 5844.6785426801935, 5838.503727183237, 5838.970805145947, 5856.150858125633, 5882.382349853204, 5894.557908156819, 5506.752196151263, 5704.686242256716, 5728.684922329312, 5755.223044889054, 5775.826725198251], "value": 4332.878669732684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.049635473884, 792.7225471085118, 811.2455416462689, 853.9103394143615, 868.8175483148539, 16385.42651007215, 16548.586285342873, 16785.580360490992, 18049.63900721985, 18055.368062117814, 16123.355065797383, 16492.752608710878, 16500.33998640053, 16526.83473165268, 16531.421400250994, 719.377738256407, 739.6227923758868, 859.8022454835392, 872.6945569050845, 875.5972252763736, 842.0316635868769, 867.8177582707639, 868.3574155125193, 871.9476831390106, 880.2473884828476, 903.9096090390941, 904.3940559824933, 905.9456432614064, 906.1708536688922, 907.6414816147618, 742.4839736383216, 767.0335377424485, 901.1844280925773, 901.4591245252828, 901.6528636474972, 650.8015055408099, 659.1464054050017, 661.6691654172913, 661.6956200147938, 663.4029373563783, 14802.629934251621, 15017.924910375488, 15024.09855408668, 15034.548963531111, 15072.924635376863, 15256.542303730796, 15787.28957196929, 15802.762958555631, 15882.126483043428, 16174.35302587895, 13891.861081389157, 14112.717745645132, 14185.716285674333, 14192.92903535486, 14393.496227632088, 4643.187442197602, 4681.461631912305, 4713.835015774432, 4730.881727956794, 4810.63920205986, 88005.55997220037, 91475.0, 92554.53722731343, 93345.0, 94488.52755736247, 10997.61508347204, 11444.14168937333, 12103.75792484163, 12873.485060597659, 12888.226706397647, 24015.759842401352, 24115.15596954098, 24147.63778543323, 24175.153869614478, 24364.0, 8791.912080879109, 9014.098590140933, 9098.454092754324, 9234.261259099256, 9364.484953327496, 4976.800927962841, 5178.223266510054, 5209.609279304067, 5234.2933703949475, 5270.420253772082, 3532.434810430319, 3652.5069115669044, 3658.0854786303425, 3666.7433279670167, 3673.393890008119, 629.329763801559, 632.7563887903099, 645.2192846655599, 645.7255666341786, 650.8642418978912, 629.7481007596998, 675.4393853102011, 699.566268913277, 702.1959855964892, 709.4218212157075, 8615.710531312177, 9244.630214791467, 9267.907320926839, 9281.67514137002, 9544.379615324982, 602.4276936909953, 623.5136593457111, 643.8422586466346, 708.0512113767576, 726.0670038999859, 4548.727076375428, 4560.0, 4590.586847183769, 4622.6764126510825, 4765.547273009059, 122427.77572224164, 127130.0, 138048.30975845057, 138866.305668471, 138921.0, 66648.0, 107125.4643726792, 114665.0, 117343.41328293475, 119454.40272798754, 98108.50945745225, 99347.0, 101217.0, 102614.48692756638, 107055.0, 8660.39377243587, 8854.026057133582, 8955.194032537103, 9050.50905397727, 9085.318601104811, 55105.0, 59030.0, 60078.09882851848, 60141.0, 61057.0, 55073.724631376586, 64421.355786441534, 74650.25349746433, 79964.0, 84330.57834710788, 13665.248411337074, 13727.656808579466, 13857.584272471842, 13888.583342499742, 14013.502776014782, 15182.240887955337, 15332.386704531693, 15389.846101538842, 15533.45632902843, 16093.275802588678, 13931.72136557243, 14429.278536072945, 14542.127472351693, 14710.338034788674, 15339.846601534287, 13132.212067275994, 13355.265460399383, 13429.0, 13523.932380338036, 13537.997231840716, 13528.0, 13546.525871594447, 13705.314734263446, 14142.646433839236, 14608.342624581706, 10011.849822252527, 10331.94834025825, 10359.0, 10554.577816887238, 10604.469776510989, 10871.29336593119, 11029.338239705643, 11178.496967636638, 11200.327980321206, 11306.547738090385], "value": 7953.655722168876, "unit": "score"}], "name": "dromaeo_css", "value": 7682.260954892498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 112.0, 111.0, 115.0, 112.0, 110.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 121.0, 147.0, 119.0, 117.0, 120.0, 117.0, 144.0, 117.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 164.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 111.0, 77.0, 76.0, 76.0, 76.0, 104.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 113.0, 82.0, 82.0, 82.0, 106.0, 82.0, 81.0, 113.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 148.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 58.0, 49.0, 50.0, 52.0, 50.0, 54.0, 49.0, 50.0, 49.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 77.0, 82.0, 73.0, 74.0, 77.0, 74.0, 80.0, 73.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 128.0, 123.0, 119.0, 128.0, 124.0, 135.0, 160.0, 121.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 156.0, 155.0, 160.0, 157.0, 154.0, 155.0, 154.0, 157.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 70.0, 63.0, 62.0, 64.0, 62.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1467.5999999999997, "alertThreshold": 2.0}]} 20:20:01 INFO - Return code: 0 20:20:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:20:01 INFO - # TBPL SUCCESS # 20:20:01 INFO - Running post-action listener: _resource_record_post_action 20:20:01 INFO - [mozharness: 2016-10-21 03:20:01.580515Z] Finished run-tests step (success) 20:20:01 INFO - Running post-run listener: _resource_record_post_run 20:20:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357392384; Read time: 16; Write time: 247032 20:20:01 INFO - TinderboxPrint: CPU usage
13.0% 20:20:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:20:01 INFO - TinderboxPrint: I/O write bytes / time
357,392,384 / 247,032 20:20:01 INFO - TinderboxPrint: CPU idle
8,264.3 (87.0%) 20:20:01 INFO - TinderboxPrint: CPU user
1,187.1 (12.5%) 20:20:01 INFO - TinderboxPrint: Swap in / out
0 / 0 20:20:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108183552; Read time: 0; Write time: 108408 20:20:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249208832; Read time: 0; Write time: 138624 20:20:02 INFO - Running post-run listener: _upload_blobber_files 20:20:02 INFO - Blob upload gear active. 20:20:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:20:02 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 20:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:20:02 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:06 INFO - (blobuploader) - INFO - Done attempting. 20:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:06 INFO - (blobuploader) - INFO - Done attempting. 20:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:07 INFO - (blobuploader) - INFO - Done attempting. 20:20:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:07 INFO - Return code: 0 20:20:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:20:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab255fde9105428acf5512fe9565134741378869c272ccf8474801d5fc86134e5e23505c62733599a41206f4f785226b9bcb9b0762800906ccc48ca0434ebf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb65114e8369850f708f788469ef47c981b340b91728aa78adac3c4a997854915c286af3ed7e8831a666e85fcdf7337414072b414fbbe1f1b1b63856b9fcdd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d13e51cc26817cd4ff3a9f1b6417e9968cb90442aed301181829c483440dd95b58742fcd6d721c7355696adb08cc1b7c9aa25982e8869cc76ea4b6b0de6c574"} 20:20:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:20:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:20:07 INFO - Contents: 20:20:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab255fde9105428acf5512fe9565134741378869c272ccf8474801d5fc86134e5e23505c62733599a41206f4f785226b9bcb9b0762800906ccc48ca0434ebf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb65114e8369850f708f788469ef47c981b340b91728aa78adac3c4a997854915c286af3ed7e8831a666e85fcdf7337414072b414fbbe1f1b1b63856b9fcdd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d13e51cc26817cd4ff3a9f1b6417e9968cb90442aed301181829c483440dd95b58742fcd6d721c7355696adb08cc1b7c9aa25982e8869cc76ea4b6b0de6c574"} 20:20:07 INFO - Running post-run listener: copy_logs_to_upload_dir 20:20:07 INFO - Copying logs to upload dir... 20:20:07 INFO - mkdir: /builds/slave/test/build/upload/logs 20:20:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.129692 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-20 20:20:06.818918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 20:20:06.822640) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab255fde9105428acf5512fe9565134741378869c272ccf8474801d5fc86134e5e23505c62733599a41206f4f785226b9bcb9b0762800906ccc48ca0434ebf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb65114e8369850f708f788469ef47c981b340b91728aa78adac3c4a997854915c286af3ed7e8831a666e85fcdf7337414072b414fbbe1f1b1b63856b9fcdd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d13e51cc26817cd4ff3a9f1b6417e9968cb90442aed301181829c483440dd95b58742fcd6d721c7355696adb08cc1b7c9aa25982e8869cc76ea4b6b0de6c574"} build_url:https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/ClIoEDRiQiiXcsowAgsx8w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab255fde9105428acf5512fe9565134741378869c272ccf8474801d5fc86134e5e23505c62733599a41206f4f785226b9bcb9b0762800906ccc48ca0434ebf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb65114e8369850f708f788469ef47c981b340b91728aa78adac3c4a997854915c286af3ed7e8831a666e85fcdf7337414072b414fbbe1f1b1b63856b9fcdd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d13e51cc26817cd4ff3a9f1b6417e9968cb90442aed301181829c483440dd95b58742fcd6d721c7355696adb08cc1b7c9aa25982e8869cc76ea4b6b0de6c574"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 20:20:06.853001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 20:20:06.853770) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477018772.591739-493817031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 20:20:06.937119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 20:20:06.937900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 20:20:06.938618) ========= ========= Total master_lag: 0.15 =========