builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1478778906.43 results: success (0) buildid: 20161110011421 builduid: 352e829e33374c159e9d904430dd7a39 revision: 476ff24916373b77e5cc0b1f2658188e3939406d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.428003) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.428899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.429354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.478394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.478702) ========= 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=652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 03:55:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 48.6M=0s 2016-11-10 03:55:06 (48.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.609921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.610241) ========= 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=652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018781 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.660552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:06.660956) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 476ff24916373b77e5cc0b1f2658188e3939406d --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 476ff24916373b77e5cc0b1f2658188e3939406d --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=652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 03:55:06,965 truncating revision to first 12 chars 2016-11-10 03:55:06,965 Setting DEBUG logging. 2016-11-10 03:55:06,965 attempt 1/10 2016-11-10 03:55:06,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/476ff2491637?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 03:55:07,353 unpacking tar archive at: mozilla-aurora-476ff2491637/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725657 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:07.401704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:07.402101) ========= script_repo_revision: 476ff24916373b77e5cc0b1f2658188e3939406d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:07.402877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:07.403480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 03:55:07.414411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-10 03:55:07.414742) ========= /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=652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:55:07 INFO - MultiFileLogger online at 20161110 03:55:07 in /builds/slave/test 03:55:07 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 03:55:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:55:07 INFO - {'append_to_log': False, 03:55:07 INFO - 'base_work_dir': '/builds/slave/test', 03:55:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:55:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:55:07 INFO - 'branch': 'Mozilla-Aurora', 03:55:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:55:07 INFO - 'config_files': ('talos/linux_config.py',), 03:55:07 INFO - 'default_actions': ('clobber', 03:55:07 INFO - 'read-buildbot-config', 03:55:07 INFO - 'download-and-extract', 03:55:07 INFO - 'populate-webroot', 03:55:07 INFO - 'create-virtualenv', 03:55:07 INFO - 'install', 03:55:07 INFO - 'run-tests'), 03:55:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:55:07 INFO - 'download_minidump_stackwalk': True, 03:55:07 INFO - 'download_symbols': 'ondemand', 03:55:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:55:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:55:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:55:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:55:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:55:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:55:07 INFO - 'installer_path': 'installer.exe', 03:55:07 INFO - 'log_level': 'info', 03:55:07 INFO - 'log_name': 'talos', 03:55:07 INFO - 'log_to_console': True, 03:55:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:55:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:55:07 INFO - 'opt_config_files': (), 03:55:07 INFO - 'pip_index': False, 03:55:07 INFO - 'sps_profile': False, 03:55:07 INFO - 'sps_profile_interval': 0, 03:55:07 INFO - 'suite': 'dromaeojs', 03:55:07 INFO - 'system_bits': '32', 03:55:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:55:07 INFO - 'title': 'talos-linux64-ix-046', 03:55:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:55:07 INFO - 'use_talos_json': True, 03:55:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:55:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:55:07 INFO - 'work_dir': 'build'} 03:55:07 INFO - [mozharness: 2016-11-10 11:55:07.818875Z] Running clobber step. 03:55:07 INFO - Running pre-action listener: _resource_record_pre_action 03:55:07 INFO - Running main action method: clobber 03:55:07 INFO - rmtree: /builds/slave/test/build 03:55:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:55:08 INFO - Running post-action listener: _resource_record_post_action 03:55:08 INFO - [mozharness: 2016-11-10 11:55:08.277857Z] Finished clobber step (success) 03:55:08 INFO - [mozharness: 2016-11-10 11:55:08.277958Z] Running read-buildbot-config step. 03:55:08 INFO - Running pre-action listener: _resource_record_pre_action 03:55:08 INFO - Running main action method: read_buildbot_config 03:55:08 INFO - Using buildbot properties: 03:55:08 INFO - { 03:55:08 INFO - "project": "", 03:55:08 INFO - "product": "firefox", 03:55:08 INFO - "script_repo_revision": "production", 03:55:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:55:08 INFO - "repository": "", 03:55:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:55:08 INFO - "buildid": "20161110011421", 03:55:08 INFO - "pgo_build": "True", 03:55:08 INFO - "basedir": "/builds/slave/test", 03:55:08 INFO - "buildnumber": 612, 03:55:08 INFO - "slavename": "talos-linux64-ix-046", 03:55:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:55:08 INFO - "platform": "ubuntu64_hw", 03:55:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:55:08 INFO - "branch": "mozilla-aurora", 03:55:08 INFO - "repo_path": "releases/mozilla-aurora", 03:55:08 INFO - "revision": "476ff24916373b77e5cc0b1f2658188e3939406d", 03:55:08 INFO - "stage_platform": "linux64-pgo", 03:55:08 INFO - "builduid": "352e829e33374c159e9d904430dd7a39", 03:55:08 INFO - "slavebuilddir": "test" 03:55:08 INFO - } 03:55:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:55:08 INFO - Running post-action listener: _resource_record_post_action 03:55:08 INFO - [mozharness: 2016-11-10 11:55:08.280410Z] Finished read-buildbot-config step (success) 03:55:08 INFO - [mozharness: 2016-11-10 11:55:08.280500Z] Running download-and-extract step. 03:55:08 INFO - Running pre-action listener: _resource_record_pre_action 03:55:08 INFO - Running main action method: download_and_extract 03:55:08 INFO - mkdir: /builds/slave/test/build/tests 03:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:08 INFO - trying https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:55:08 INFO - Downloading https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/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 03:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/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 03:55:08 INFO - Downloaded 1361 bytes. 03:55:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:55:08 INFO - Using the following test package requirements: 03:55:08 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:55:08 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:55:08 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:55:08 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'jsshell-linux-x86_64.zip'], 03:55:08 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:55:08 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:55:08 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:55:08 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:55:08 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:55:08 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:55:08 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:55:08 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:55:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:55:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:55:08 INFO - Fetch https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:55:09 INFO - Expected file size: 21897203 03:55:13 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 03:55:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:55:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:55:13 INFO - Fetch https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:55:14 INFO - Expected file size: 21897203 03:55:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:55:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:55:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:55:19 INFO - Expected file size: 14414089 03:55:20 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')]} 03:55:20 INFO - trying https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:55:20 INFO - Downloading https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/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 03:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/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 03:55:22 INFO - Downloaded 64007426 bytes. 03:55:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:55:22 INFO - mkdir: /builds/slave/test/properties 03:55:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:22 INFO - Contents: 03:55:22 INFO - build_url:https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:55:23 INFO - Running post-action listener: _resource_record_post_action 03:55:23 INFO - Running post-action listener: set_extra_try_arguments 03:55:23 INFO - [mozharness: 2016-11-10 11:55:23.244664Z] Finished download-and-extract step (success) 03:55:23 INFO - [mozharness: 2016-11-10 11:55:23.244891Z] Running populate-webroot step. 03:55:23 INFO - Running pre-action listener: _resource_record_pre_action 03:55:23 INFO - Running main action method: populate_webroot 03:55:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:23 INFO - '--tppagecycles', 03:55:23 INFO - '7'], 03:55:23 INFO - 'tests': ['tsvgm']}}, 03:55:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:55:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:55:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['damp', 'tps']}, 03:55:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'tests': ['damp', 'tps']}, 03:55:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['dromaeo_dom']}, 03:55:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['basic_compositor_video']}, 03:55:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:55:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['a11yr', 03:55:23 INFO - 'ts_paint', 03:55:23 INFO - 'tpaint', 03:55:23 INFO - 'sessionrestore', 03:55:23 INFO - 'sessionrestore_no_auto_restore', 03:55:23 INFO - 'tabpaint']}, 03:55:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:23 INFO - 'ts_paint', 03:55:23 INFO - 'tpaint', 03:55:23 INFO - 'sessionrestore', 03:55:23 INFO - 'sessionrestore_no_auto_restore', 03:55:23 INFO - 'tabpaint']}, 03:55:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:55:23 INFO - 'ts_paint', 03:55:23 INFO - 'tpaint', 03:55:23 INFO - 'sessionrestore', 03:55:23 INFO - 'sessionrestore_no_auto_restore', 03:55:23 INFO - 'tabpaint']}, 03:55:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:55:23 INFO - 'ts_paint', 03:55:23 INFO - 'tpaint', 03:55:23 INFO - 'sessionrestore', 03:55:23 INFO - 'sessionrestore_no_auto_restore', 03:55:23 INFO - 'tabpaint']}, 03:55:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['a11yr', 03:55:23 INFO - 'ts_paint', 03:55:23 INFO - 'tpaint', 03:55:23 INFO - 'sessionrestore', 03:55:23 INFO - 'sessionrestore_no_auto_restore', 03:55:23 INFO - 'tabpaint']}, 03:55:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['a11yr', 03:55:23 INFO - 'ts_paint', 03:55:23 INFO - 'tpaint', 03:55:23 INFO - 'sessionrestore', 03:55:23 INFO - 'sessionrestore_no_auto_restore', 03:55:23 INFO - 'tabpaint']}, 03:55:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['tsvgx', 03:55:23 INFO - 'tsvgr_opacity', 03:55:23 INFO - 'tart', 03:55:23 INFO - 'tscrollx', 03:55:23 INFO - 'cart']}, 03:55:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:23 INFO - 'tsvgr_opacity', 03:55:23 INFO - 'tart', 03:55:23 INFO - 'tscrollx', 03:55:23 INFO - 'cart']}, 03:55:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'talos_options': ['--disable-e10s'], 03:55:23 INFO - 'tests': ['tp5o']}, 03:55:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'tests': ['tp5o']}, 03:55:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'talos_options': ['--disable-e10s', 03:55:23 INFO - '--xperf_path', 03:55:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:23 INFO - 'tests': ['tp5n']}, 03:55:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:55:23 INFO - 'talos_options': ['--xperf_path', 03:55:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:23 INFO - 'tests': ['tp5n']}}, 03:55:23 INFO - 'talos.zip': {'path': '', 03:55:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:23 INFO - Running post-action listener: _resource_record_post_action 03:55:23 INFO - [mozharness: 2016-11-10 11:55:23.260835Z] Finished populate-webroot step (success) 03:55:23 INFO - [mozharness: 2016-11-10 11:55:23.260951Z] Running create-virtualenv step. 03:55:23 INFO - Running pre-action listener: _resource_record_pre_action 03:55:23 INFO - Running main action method: create_virtualenv 03:55:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:23 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 03:55:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:55:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:23 INFO - Using real prefix '/usr' 03:55:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:25 INFO - Installing pip.................done. 03:55:25 INFO - Return code: 0 03:55:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:55:25 INFO - Using env: {'DISPLAY': ':0', 03:55:25 INFO - 'HOME': '/home/cltbld', 03:55:25 INFO - 'LANG': 'en_US.UTF-8', 03:55:25 INFO - 'LANGUAGE': 'en_US:en', 03:55:25 INFO - 'LOGNAME': 'cltbld', 03:55:25 INFO - 'MAIL': '/var/mail/cltbld', 03:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:25 INFO - 'MOZ_NO_REMOTE': '1', 03:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:25 INFO - 'NO_EM_RESTART': '1', 03:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:25 INFO - 'PWD': '/builds/slave/test', 03:55:25 INFO - 'SHELL': '/bin/bash', 03:55:25 INFO - 'SHLVL': '1', 03:55:25 INFO - 'TERM': 'linux', 03:55:25 INFO - 'TMOUT': '86400', 03:55:25 INFO - 'USER': 'cltbld', 03:55:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:25 INFO - '_': '/tools/buildbot/bin/python'} 03:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:26 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 03:55:26 INFO - Cleaning up... 03:55:26 INFO - Return code: 0 03:55:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:26 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 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:26 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 03:55:26 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 03:55:26 INFO - Using env: {'DISPLAY': ':0', 03:55:26 INFO - 'HOME': '/home/cltbld', 03:55:26 INFO - 'LANG': 'en_US.UTF-8', 03:55:26 INFO - 'LANGUAGE': 'en_US:en', 03:55:26 INFO - 'LOGNAME': 'cltbld', 03:55:26 INFO - 'MAIL': '/var/mail/cltbld', 03:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:26 INFO - 'MOZ_NO_REMOTE': '1', 03:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:26 INFO - 'NO_EM_RESTART': '1', 03:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:26 INFO - 'PWD': '/builds/slave/test', 03:55:26 INFO - 'SHELL': '/bin/bash', 03:55:26 INFO - 'SHLVL': '1', 03:55:26 INFO - 'TERM': 'linux', 03:55:26 INFO - 'TMOUT': '86400', 03:55:26 INFO - 'USER': 'cltbld', 03:55:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:26 INFO - '_': '/tools/buildbot/bin/python'} 03:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:26 INFO - Downloading/unpacking psutil>=3.1.1 03:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:28 INFO - Installing collected packages: psutil 03:55:28 INFO - Running setup.py install for psutil 03:55:28 INFO - building 'psutil._psutil_linux' extension 03:55:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:55:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:55:28 INFO - building 'psutil._psutil_posix' extension 03:55:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:55:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:55:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:28 INFO - Successfully installed psutil 03:55:28 INFO - Cleaning up... 03:55:28 INFO - Return code: 0 03:55:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:55:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:55:28 INFO - Using env: {'DISPLAY': ':0', 03:55:28 INFO - 'HOME': '/home/cltbld', 03:55:28 INFO - 'LANG': 'en_US.UTF-8', 03:55:28 INFO - 'LANGUAGE': 'en_US:en', 03:55:28 INFO - 'LOGNAME': 'cltbld', 03:55:28 INFO - 'MAIL': '/var/mail/cltbld', 03:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:28 INFO - 'MOZ_NO_REMOTE': '1', 03:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:28 INFO - 'NO_EM_RESTART': '1', 03:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:28 INFO - 'PWD': '/builds/slave/test', 03:55:28 INFO - 'SHELL': '/bin/bash', 03:55:28 INFO - 'SHLVL': '1', 03:55:28 INFO - 'TERM': 'linux', 03:55:28 INFO - 'TMOUT': '86400', 03:55:28 INFO - 'USER': 'cltbld', 03:55:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:28 INFO - '_': '/tools/buildbot/bin/python'} 03:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:55:29 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 03:55:29 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 03:55:29 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 03:55:29 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 03:55:29 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 03:55:29 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 03:55:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:31 INFO - Installing collected packages: mozsystemmonitor 03:55:31 INFO - Running setup.py install for mozsystemmonitor 03:55:31 INFO - Successfully installed mozsystemmonitor 03:55:31 INFO - Cleaning up... 03:55:31 INFO - Return code: 0 03:55:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:55:31 INFO - Using env: {'DISPLAY': ':0', 03:55:31 INFO - 'HOME': '/home/cltbld', 03:55:31 INFO - 'LANG': 'en_US.UTF-8', 03:55:31 INFO - 'LANGUAGE': 'en_US:en', 03:55:31 INFO - 'LOGNAME': 'cltbld', 03:55:31 INFO - 'MAIL': '/var/mail/cltbld', 03:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:31 INFO - 'MOZ_NO_REMOTE': '1', 03:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:31 INFO - 'NO_EM_RESTART': '1', 03:55:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:31 INFO - 'PWD': '/builds/slave/test', 03:55:31 INFO - 'SHELL': '/bin/bash', 03:55:31 INFO - 'SHLVL': '1', 03:55:31 INFO - 'TERM': 'linux', 03:55:31 INFO - 'TMOUT': '86400', 03:55:31 INFO - 'USER': 'cltbld', 03:55:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:31 INFO - '_': '/tools/buildbot/bin/python'} 03:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:33 INFO - warning: no files found matching '*.txt' 03:55:33 INFO - no previously-included directories found matching 'build' 03:55:33 INFO - no previously-included directories found matching 'dist' 03:55:33 INFO - no previously-included directories found matching '.git*' 03:55:33 INFO - Installing collected packages: jsonschema, functools32 03:55:33 INFO - Running setup.py install for functools32 03:55:33 INFO - warning: no files found matching '*.txt' 03:55:33 INFO - no previously-included directories found matching 'build' 03:55:33 INFO - no previously-included directories found matching 'dist' 03:55:33 INFO - no previously-included directories found matching '.git*' 03:55:33 INFO - Successfully installed jsonschema functools32 03:55:33 INFO - Cleaning up... 03:55:33 INFO - Return code: 0 03:55:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:55:33 INFO - Using env: {'DISPLAY': ':0', 03:55:33 INFO - 'HOME': '/home/cltbld', 03:55:33 INFO - 'LANG': 'en_US.UTF-8', 03:55:33 INFO - 'LANGUAGE': 'en_US:en', 03:55:33 INFO - 'LOGNAME': 'cltbld', 03:55:33 INFO - 'MAIL': '/var/mail/cltbld', 03:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:33 INFO - 'MOZ_NO_REMOTE': '1', 03:55:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:33 INFO - 'NO_EM_RESTART': '1', 03:55:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:33 INFO - 'PWD': '/builds/slave/test', 03:55:33 INFO - 'SHELL': '/bin/bash', 03:55:33 INFO - 'SHLVL': '1', 03:55:33 INFO - 'TERM': 'linux', 03:55:33 INFO - 'TMOUT': '86400', 03:55:33 INFO - 'USER': 'cltbld', 03:55:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:33 INFO - '_': '/tools/buildbot/bin/python'} 03:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:34 INFO - Cleaning up... 03:55:34 INFO - Return code: 0 03:55:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:55:34 INFO - Using env: {'DISPLAY': ':0', 03:55:34 INFO - 'HOME': '/home/cltbld', 03:55:34 INFO - 'LANG': 'en_US.UTF-8', 03:55:34 INFO - 'LANGUAGE': 'en_US:en', 03:55:34 INFO - 'LOGNAME': 'cltbld', 03:55:34 INFO - 'MAIL': '/var/mail/cltbld', 03:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:34 INFO - 'MOZ_NO_REMOTE': '1', 03:55:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:34 INFO - 'NO_EM_RESTART': '1', 03:55:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:34 INFO - 'PWD': '/builds/slave/test', 03:55:34 INFO - 'SHELL': '/bin/bash', 03:55:34 INFO - 'SHLVL': '1', 03:55:34 INFO - 'TERM': 'linux', 03:55:34 INFO - 'TMOUT': '86400', 03:55:34 INFO - 'USER': 'cltbld', 03:55:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:34 INFO - '_': '/tools/buildbot/bin/python'} 03:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:36 INFO - Downloading docopt-0.6.1.tar.gz 03:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:36 INFO - Running setup.py install for blobuploader 03:55:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:37 INFO - Running setup.py install for requests 03:55:37 INFO - Running setup.py install for docopt 03:55:37 INFO - Successfully installed blobuploader requests docopt 03:55:37 INFO - Cleaning up... 03:55:37 INFO - Return code: 0 03:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:55:37 INFO - Using env: {'DISPLAY': ':0', 03:55:37 INFO - 'HOME': '/home/cltbld', 03:55:37 INFO - 'LANG': 'en_US.UTF-8', 03:55:37 INFO - 'LANGUAGE': 'en_US:en', 03:55:37 INFO - 'LOGNAME': 'cltbld', 03:55:37 INFO - 'MAIL': '/var/mail/cltbld', 03:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:37 INFO - 'MOZ_NO_REMOTE': '1', 03:55:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:37 INFO - 'NO_EM_RESTART': '1', 03:55:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:37 INFO - 'PWD': '/builds/slave/test', 03:55:37 INFO - 'SHELL': '/bin/bash', 03:55:37 INFO - 'SHLVL': '1', 03:55:37 INFO - 'TERM': 'linux', 03:55:37 INFO - 'TMOUT': '86400', 03:55:37 INFO - 'USER': 'cltbld', 03:55:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:37 INFO - '_': '/tools/buildbot/bin/python'} 03:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:37 INFO - Running setup.py (path:/tmp/pip-LxRr7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:37 INFO - Running setup.py (path:/tmp/pip-vKysDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:37 INFO - Running setup.py (path:/tmp/pip-O8B292-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:38 INFO - Running setup.py (path:/tmp/pip-m42DJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:38 INFO - Running setup.py (path:/tmp/pip-wz8eb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:38 INFO - Running setup.py (path:/tmp/pip-uMhroi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:38 INFO - Running setup.py (path:/tmp/pip-foG4qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:38 INFO - Running setup.py (path:/tmp/pip-XkIQel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:38 INFO - Running setup.py (path:/tmp/pip-oIju1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:38 INFO - Running setup.py (path:/tmp/pip-lCYWho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:38 INFO - Running setup.py (path:/tmp/pip-3bf7BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:38 INFO - Running setup.py (path:/tmp/pip-7kJI0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:38 INFO - Running setup.py (path:/tmp/pip-guqOYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:38 INFO - Running setup.py (path:/tmp/pip-VXCNE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:38 INFO - Running setup.py (path:/tmp/pip-RHRuOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:38 INFO - Running setup.py (path:/tmp/pip-hN5cU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:38 INFO - Running setup.py (path:/tmp/pip-6PVrrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:55:39 INFO - Running setup.py install for manifestparser 03:55:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Running setup.py install for mozcrash 03:55:39 INFO - Running setup.py install for mozdebug 03:55:39 INFO - Running setup.py install for mozdevice 03:55:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Running setup.py install for mozfile 03:55:39 INFO - Running setup.py install for mozhttpd 03:55:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Running setup.py install for mozinfo 03:55:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Running setup.py install for mozInstall 03:55:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:55:39 INFO - Running setup.py install for mozleak 03:55:39 INFO - Running setup.py install for mozlog 03:55:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Running setup.py install for moznetwork 03:55:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Running setup.py install for mozprocess 03:55:40 INFO - Running setup.py install for mozprofile 03:55:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Running setup.py install for mozrunner 03:55:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Running setup.py install for mozscreenshot 03:55:40 INFO - Running setup.py install for moztest 03:55:40 INFO - Running setup.py install for mozversion 03:55:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:55:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:55:40 INFO - Cleaning up... 03:55:40 INFO - Return code: 0 03:55:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:55:40 INFO - Using env: {'DISPLAY': ':0', 03:55:40 INFO - 'HOME': '/home/cltbld', 03:55:40 INFO - 'LANG': 'en_US.UTF-8', 03:55:40 INFO - 'LANGUAGE': 'en_US:en', 03:55:40 INFO - 'LOGNAME': 'cltbld', 03:55:40 INFO - 'MAIL': '/var/mail/cltbld', 03:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:40 INFO - 'MOZ_NO_REMOTE': '1', 03:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:40 INFO - 'NO_EM_RESTART': '1', 03:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:40 INFO - 'PWD': '/builds/slave/test', 03:55:40 INFO - 'SHELL': '/bin/bash', 03:55:40 INFO - 'SHLVL': '1', 03:55:40 INFO - 'TERM': 'linux', 03:55:40 INFO - 'TMOUT': '86400', 03:55:40 INFO - 'USER': 'cltbld', 03:55:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:40 INFO - '_': '/tools/buildbot/bin/python'} 03:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:41 INFO - Running setup.py (path:/tmp/pip-t2Bbbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:41 INFO - Running setup.py (path:/tmp/pip-B_K1An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:41 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)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:41 INFO - Running setup.py (path:/tmp/pip-alPEOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:41 INFO - Running setup.py (path:/tmp/pip-fk3qWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:41 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)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:41 INFO - Running setup.py (path:/tmp/pip-Yk27Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:41 INFO - Running setup.py (path:/tmp/pip-uD7QC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:41 INFO - Running setup.py (path:/tmp/pip-xm6j3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:41 INFO - Running setup.py (path:/tmp/pip-dB0kgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:41 INFO - Running setup.py (path:/tmp/pip-q2o50p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:41 INFO - Running setup.py (path:/tmp/pip-gX96Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:41 INFO - Running setup.py (path:/tmp/pip-Vyry93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:41 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)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:41 INFO - Running setup.py (path:/tmp/pip-4C1bAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:41 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)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:41 INFO - Running setup.py (path:/tmp/pip-I1XS5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:41 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)) 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:41 INFO - Running setup.py (path:/tmp/pip-ibpBpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:42 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)) 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:42 INFO - Running setup.py (path:/tmp/pip-Qz_ECn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:42 INFO - Running setup.py (path:/tmp/pip-IYv0Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:42 INFO - Running setup.py (path:/tmp/pip-Ep_6iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:55:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:44 INFO - Downloading blessings-1.6.tar.gz 03:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:55:44 INFO - Installing collected packages: blessings 03:55:44 INFO - Running setup.py install for blessings 03:55:44 INFO - Successfully installed blessings 03:55:44 INFO - Cleaning up... 03:55:44 INFO - Return code: 0 03:55:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:55:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:44 INFO - Reading from file tmpfile_stdout 03:55:44 INFO - Current package versions: 03:55:44 INFO - argparse == 1.2.1 03:55:44 INFO - blessings == 1.6 03:55:44 INFO - blobuploader == 1.2.4 03:55:44 INFO - docopt == 0.6.1 03:55:44 INFO - functools32 == 3.2.3-2 03:55:44 INFO - jsonschema == 2.5.1 03:55:44 INFO - manifestparser == 1.1 03:55:44 INFO - mozInstall == 1.12 03:55:44 INFO - mozcrash == 0.17 03:55:44 INFO - mozdebug == 0.1 03:55:44 INFO - mozdevice == 0.48 03:55:44 INFO - mozfile == 1.2 03:55:44 INFO - mozhttpd == 0.7 03:55:44 INFO - mozinfo == 0.9 03:55:44 INFO - mozleak == 0.1 03:55:44 INFO - mozlog == 3.4 03:55:44 INFO - moznetwork == 0.27 03:55:44 INFO - mozprocess == 0.23 03:55:44 INFO - mozprofile == 0.28 03:55:44 INFO - mozrunner == 6.12 03:55:44 INFO - mozscreenshot == 0.1 03:55:44 INFO - mozsystemmonitor == 0.3 03:55:44 INFO - moztest == 0.7 03:55:44 INFO - mozversion == 1.4 03:55:44 INFO - psutil == 3.1.1 03:55:44 INFO - requests == 1.2.3 03:55:44 INFO - wsgiref == 0.1.2 03:55:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:55:44 INFO - Using env: {'DISPLAY': ':0', 03:55:44 INFO - 'HOME': '/home/cltbld', 03:55:44 INFO - 'LANG': 'en_US.UTF-8', 03:55:44 INFO - 'LANGUAGE': 'en_US:en', 03:55:44 INFO - 'LOGNAME': 'cltbld', 03:55:44 INFO - 'MAIL': '/var/mail/cltbld', 03:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:44 INFO - 'MOZ_NO_REMOTE': '1', 03:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:44 INFO - 'NO_EM_RESTART': '1', 03:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:44 INFO - 'PWD': '/builds/slave/test', 03:55:44 INFO - 'SHELL': '/bin/bash', 03:55:44 INFO - 'SHLVL': '1', 03:55:44 INFO - 'TERM': 'linux', 03:55:44 INFO - 'TMOUT': '86400', 03:55:44 INFO - 'USER': 'cltbld', 03:55:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:44 INFO - '_': '/tools/buildbot/bin/python'} 03:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 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)) 03:55:44 INFO - Cleaning up... 03:55:44 INFO - Return code: 0 03:55:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:44 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 0x7fdb375f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', '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 03:55:44 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 03:55:44 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 03:55:44 INFO - Using env: {'DISPLAY': ':0', 03:55:44 INFO - 'HOME': '/home/cltbld', 03:55:44 INFO - 'LANG': 'en_US.UTF-8', 03:55:44 INFO - 'LANGUAGE': 'en_US:en', 03:55:44 INFO - 'LOGNAME': 'cltbld', 03:55:44 INFO - 'MAIL': '/var/mail/cltbld', 03:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:44 INFO - 'MOZ_NO_REMOTE': '1', 03:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:44 INFO - 'NO_EM_RESTART': '1', 03:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:44 INFO - 'PWD': '/builds/slave/test', 03:55:44 INFO - 'SHELL': '/bin/bash', 03:55:44 INFO - 'SHLVL': '1', 03:55:44 INFO - 'TERM': 'linux', 03:55:44 INFO - 'TMOUT': '86400', 03:55:44 INFO - 'USER': 'cltbld', 03:55:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:44 INFO - '_': '/tools/buildbot/bin/python'} 03:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:55:45 INFO - Cleaning up... 03:55:45 INFO - Return code: 0 03:55:45 INFO - Running post-action listener: _resource_record_post_action 03:55:45 INFO - Running post-action listener: _start_resource_monitoring 03:55:45 INFO - Starting resource monitoring. 03:55:45 INFO - [mozharness: 2016-11-10 11:55:45.117049Z] Finished create-virtualenv step (success) 03:55:45 INFO - [mozharness: 2016-11-10 11:55:45.117509Z] Running install step. 03:55:45 INFO - Running pre-action listener: _resource_record_pre_action 03:55:45 INFO - Running main action method: install 03:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:45 INFO - Reading from file tmpfile_stdout 03:55:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:55:45 INFO - Reading from file tmpfile_stdout 03:55:45 INFO - Output received: 03:55:45 INFO - Usage: mozinstall [options] installer 03:55:45 INFO - Options: 03:55:45 INFO - -h, --help show this help message and exit 03:55:45 INFO - -d DEST, --destination=DEST 03:55:45 INFO - Directory to install application into. [default: 03:55:45 INFO - "/builds/slave/test"] 03:55:45 INFO - --app=APP Application being installed. [default: firefox] 03:55:45 INFO - mkdir: /builds/slave/test/build/application 03:55:45 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'] 03:55:45 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 03:56:01 INFO - Reading from file tmpfile_stdout 03:56:01 INFO - Output received: 03:56:01 INFO - /builds/slave/test/build/application/firefox/firefox 03:56:01 INFO - Running post-action listener: _resource_record_post_action 03:56:01 INFO - [mozharness: 2016-11-10 11:56:01.397560Z] Finished install step (success) 03:56:01 INFO - [mozharness: 2016-11-10 11:56:01.397805Z] Running run-tests step. 03:56:01 INFO - Running pre-action listener: _resource_record_pre_action 03:56:01 INFO - Running main action method: run_tests 03:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:56:01 INFO - Python 2.7.3 03:56:01 INFO - Return code: 0 03:56:01 INFO - grabbing minidump binary from tooltool 03:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0f60>, '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 0x18f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:56:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:56:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:56:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:56:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:01 INFO - Return code: 0 03:56:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:56:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:56:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:56:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:56:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:56:01 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/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 03:56:01 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/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 03:56:01 INFO - Using env: {'DISPLAY': ':0', 03:56:01 INFO - 'HOME': '/home/cltbld', 03:56:01 INFO - 'LANG': 'en_US.UTF-8', 03:56:01 INFO - 'LANGUAGE': 'en_US:en', 03:56:01 INFO - 'LOGNAME': 'cltbld', 03:56:01 INFO - 'MAIL': '/var/mail/cltbld', 03:56:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:01 INFO - 'MOZ_NO_REMOTE': '1', 03:56:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:01 INFO - 'NO_EM_RESTART': '1', 03:56:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:01 INFO - 'PWD': '/builds/slave/test', 03:56:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:01 INFO - 'SHELL': '/bin/bash', 03:56:01 INFO - 'SHLVL': '1', 03:56:01 INFO - 'TERM': 'linux', 03:56:01 INFO - 'TMOUT': '86400', 03:56:01 INFO - 'USER': 'cltbld', 03:56:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701', 03:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:01 INFO - '_': '/tools/buildbot/bin/python'} 03:56:01 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/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 03:56:01 INFO - mozversion application_buildid: 20161110011421 03:56:01 INFO - mozversion application_changeset: 476ff24916373b77e5cc0b1f2658188e3939406d 03:56:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:56:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:01 INFO - mozversion application_name: Firefox 03:56:01 INFO - mozversion application_remotingname: firefox-dev 03:56:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:56:01 INFO - mozversion application_vendor: Mozilla 03:56:01 INFO - mozversion application_version: 51.0a2 03:56:01 INFO - mozversion platform_buildid: 20161110011421 03:56:01 INFO - mozversion platform_changeset: 476ff24916373b77e5cc0b1f2658188e3939406d 03:56:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:56:01 INFO - mozversion platform_version: 51.0a2 03:56:01 INFO - using testdate: 1478778961 03:56:01 INFO - actual date: 1478778961 03:56:01 INFO - starting webserver on 'localhost:37606' 03:56:01 INFO - SUITE-START | Running 2 tests 03:56:01 INFO - TEST-START | dromaeo_css 03:56:01 INFO - operating with platform_type : linux_ 03:56:01 INFO - Initialising browser for dromaeo_css test... 03:56:01 INFO - TEST-INFO | started process 25897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp80d8el/profile http://localhost:37606/getInfo.html) 03:56:05 INFO - PROCESS | 25897 | __metrics Screen width/height:1600/1200 03:56:05 INFO - PROCESS | 25897 | colorDepth:24 03:56:05 INFO - PROCESS | 25897 | Browser inner width/height: 1024/697 03:56:05 INFO - PROCESS | 25897 | __metrics 03:56:06 INFO - PROCESS | 25897 | 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" 03:56:06 INFO - PROCESS | 25897 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:06 INFO - PROCESS | 25897 | console.error: PushService: 03:56:06 INFO - PROCESS | 25897 | stateChangeProcessEnqueue: Error transitioning state 03:56:06 INFO - PROCESS | 25897 | UnknownError 03:56:07 INFO - TEST-INFO | 25897: exit 0 03:56:07 INFO - Browser initialized. 03:56:07 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:07 INFO - TEST-INFO | started process 25987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp80d8el/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:19 INFO - PROCESS | 25987 | RSS: Main: 144412672 03:56:19 INFO - PROCESS | 25987 | 03:57:10 INFO - PROCESS | 25987 | 1478779030096 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] 03:59:19 INFO - PROCESS | 25987 | Cycle 1(1): loaded http://localhost:37606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37606/tests/dromaeo/cssquery-ext.html) 03:59:20 INFO - PROCESS | 25987 | RSS: Main: 242577408 03:59:20 INFO - PROCESS | 25987 | 04:02:22 INFO - PROCESS | 25987 | Cycle 1(1): loaded http://localhost:37606/tests/dromaeo/cssquery-ext.html (next: http://localhost:37606/tests/dromaeo/cssquery-jquery.html) 04:02:23 INFO - PROCESS | 25987 | RSS: Main: 229031936 04:02:23 INFO - PROCESS | 25987 | 04:05:25 INFO - PROCESS | 25987 | Cycle 1(1): loaded http://localhost:37606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37606/tests/dromaeo/cssquery-mootools.html) 04:05:26 INFO - PROCESS | 25987 | RSS: Main: 174460928 04:05:26 INFO - PROCESS | 25987 | 04:08:28 INFO - PROCESS | 25987 | Cycle 1(1): loaded http://localhost:37606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37606/tests/dromaeo/cssquery-prototype.html) 04:08:28 INFO - PROCESS | 25987 | RSS: Main: 224350208 04:08:28 INFO - PROCESS | 25987 | 04:11:31 INFO - PROCESS | 25987 | Cycle 1(1): loaded http://localhost:37606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37606/tests/dromaeo/cssquery-yui.html) 04:11:32 INFO - PROCESS | 25987 | RSS: Main: 177778688 04:11:32 INFO - PROCESS | 25987 | 04:14:34 INFO - PROCESS | 25987 | Cycle 1(1): loaded http://localhost:37606/tests/dromaeo/cssquery-yui.html (next: http://localhost:37606/tests/dromaeo/cssquery-dojo.html) 04:14:34 INFO - PROCESS | 25987 | RSS: Main: 266469376 04:14:34 INFO - PROCESS | 25987 | 04:14:34 INFO - PROCESS | 25987 | __start_tp_report 04:14:34 INFO - PROCESS | 25987 | _x_x_mozilla_page_load 04:14:34 INFO - PROCESS | 25987 | _x_x_mozilla_page_load_details 04:14:34 INFO - PROCESS | 25987 | |i|pagename|runs| 04:14:34 INFO - PROCESS | 25987 | |0;dojo.html;3095.411871744369;3146.181992681902;3153.132888455674;3164.05078476457;3189.6012998375204;5426.565874730022;5519.69641669708;5520.889582208359;5522.30971128609;5533.612647114704;5532.059549876521;5563.499285064354;5567.415421380758;5576.721163941807;5581.190727344532;5023.6985780853265;5037.29477873098;5056.115179843531;5118.104331741949;5142.61430392722;4944.233643785219;4951.430585482662;4971.080350135237;5104.285400043997;5150.613703972198;4976.900461990758;5099.796008159669;5101.413337466183;5104.183330667094;5110.182370820669;5111.744412779365;5118.1555043417975;5121.974390128063;5126.769295381717;5154.098032844237;4868.05073010763;4881.170201065792;5001.674891132065;5023.899522009576;5099.59203263738;5365.678059316415;5403.13549832025;5403.918941215885;5430.321209848769;5439.782408703647;5784.334801497839;5806;5876.55925805562;5919.5264378850015;5924.526037916957;5735.4551317624755;5954.583179177459;5966.075258334965;5985.700714964234;5989.3711160327975;5415.187721841716;5455.918161227585;5492.752826122794;5516.503514683698;5572.136318870582;6074.271087469532;6076;6077.3314935357075;6078.544109191828;6086.69566521681;5846.590738648254;5852.970735146297;5853.824385268449;5858.882822343529;5866.472017518444;5620.606557541015;5639.407862174495;5823.5923485355615;5881.911771323434;5887.764489420375;5917.763289468373;5918.112283157561;5937.198478205473;5938.584299099108;5944.970275148597;5925.822225333247;5931.555133365015;5944.167816505606;5944.346121926585;5987.850303742442;4375.606195442362;4430.468343798765;4515.254982927846;4529.433820772403;4576.244919588297;4029.133736246721;4051.453053837753;4072.592740725963;4085.3463445849115;4096.754194748325;5520.779168833202;5534.142207957773;5536.944630553723;5538.113901775697;5538.501534861882;5712.914306285409;5763.8559036024435;5857.355690874;5871.9706401468575;5920.970395147997;5487.094629386186;5615.2700148980375;5617.157426386075;5629.493345598916;5646.887062258732;5172.379314482211;5179.2749015137915;5180.352455943007;5186.144286192812;5233.71214583194;5894.145348924382;5960.374160713236;6173;6180.783672571529;6182.783602573888;5759.596828221985;5773.04744717117;5813.04084825999;5881.97065513542;5910;6057.939420605738;6061.909071363845;6067.12026756109;6068.271807383142;6073;5583.302087239095;5721.542276617944;5771.422857714195;5780.855478613068;5783.8554036149435;5713.1715901193265;5826.796062137805;5828.70856457167;5868.178455016387;5996.100584912124;5777.537796976148;5815.76736930518;5822.7670893163795;5823.679697616502;5827.155062515827;5767.279090113736;5774.2782152230975;5788.971055144697;5801;5802.448767367094;5508.256385387921;5533.6126471148245;5632.380438151882;5690.260266165372;5707.172459993195;5827.94172058274;5831.212786273968;5833.708314584169;5834.329052159056;5842.328132264844;5491.643043202179;5687.402822703722;5694.743736531949;5702.7718891243885;5703.287089113861 04:14:34 INFO - PROCESS | 25987 | |1;ext.html;588.8557303460652;635.275785604411;643.3534298030479;645.5900503180479;661.0480907493211;34556.308873822505;38340.61659383406;44052.999999999956;44467;44539.33191002138;48547.51452485474;49038.75480622601;49164;49171;49382.50617493824;9078.86381704275;9261.166495015448;9272.860907086399;9291.953540232324;9297.30270229732;8383.62273697682;8609.913900861005;10860.782784344308;11120.833187502194;11125.888741112607;11270.887291127066;11341.603043893465;11341.886581134166;11353.716157096098;11374.203805733601;11070.225084244106;11136.387498687569;11142.665720028412;11153.776924461547;11154.498047587918;10940.781184376348;11003.22977391583;11006;11013.504392302286;11021.944890275578;45375.546244537465;45805.54194458046;45823;45843.54156458426;46017.53982460166;4070.3080476319096;4284.721493102938;4341.348797680342;4419.049904270565;4554.590086892195;34391.89122177148;34854.82572587146;35324.293514129575;36424.81787591072;36737;4220.810063547147;4277.636400905927;4380;4462.642988560908;4527.954720452786;373690;374136;374437;374939;376448;38324.233515329535;62212.377876221566;62511.6874415625;62520.06219906705;62564.37435625677;39567;41633.167336653096;41665.791671042054;41822;41837.79081104575;16419.343226270816;16526;16529.504114876574;16534.0906250155;16537.83462165387;12755;13072.346382680827;14454.060486068372;14562.490312839;14564.344604492824;9314.767130821783;9486.003969583233;9554.092361225672;9647.565859536338;9751.268654850914;3611.368010598135;3647.85408583659;3677.8344974476213;3687.539057617798;3741.494898188764;1052.7101315887573;1103.2112039891356;1104.861892263467;1166.7549814538872;1186.4008675618757;34022.48966265508;34248.48627270593;34571;34622.30755384878;34622.826885865914;1104.0560320925654;1110.4836251143256;1147.8278258261162;1151.205668089016;1218.5879537295536;17834.719412602186;17861.7320740189;18056.277748889897;18126.00920848072;18173.90956542612;163721;163962;164168;164858.1757091207;165312;63213.36786632075;63634;63933.68033159804;63946.68026659837;63954;1329.8537160912292;1358.7418390505773;1378.6622277541867;1413.3286688822727;1455.345094707407;33662.663373365955;35214.823925880206;35341.469877951335;35378;35609.109772254866;54367.45632543624;54878.725606371714;54976;54981.72509137429;55032.17451738307;424872;427308;427457;428170;430280;30313.090607281818;31199;31251.68748312488;31256.843715781277;32942.17644558905;50946.49053509418;51208.23187652114;51233.48766512287;51266.74366628143;52718;42635.573644264405;43179;43180.352294716235;43299.7835010823;44318.77840610905;43006.569934300256;43820;44194.11611767682;44413.04791232398;44656;42647.5735242656;43431.34852977271;43880.78059609682;43903;44097.77951110224;34389.312213756086;38072.23855522929;38540.80729596334;38962;39018.80490597529;29265.85367073151;29451.263718407212;29772.404551909272;29864.402711945204;29866.552001719556 04:14:34 INFO - PROCESS | 25987 | |2;jquery.html;394.10341473148566;429.8817825098098;430.9052008558116;432.97766163133247;453.0960733336991;17235.913820430895;20235.595288094228;20826.166953321866;21539.892300538515;21662.133514659396;18907.810921890778;19343.226270949144;19481.805181948177;20038.799612003877;20077.698834517494;5574.581906357019;5658.236138121362;5776.884462310752;5782.710864456782;5786.421357864222;6112.724927378279;6120.785772497963;6122.265328160627;6139.293981192153;6189.16446279751;5904.2324497815225;6074.544409169308;6131.325554189036;6133.907991380132;6137.478314343286;6116.602420842631;6175.382461753834;6178.567500274982;6189.195404597419;6192.411720886508;5411.945880541183;5500.037493438632;5532.972335138298;5579.804706835242;5615.354234263031;15053.322600483005;15239.390424383011;15269.61825954349;23224.76775232243;23838.523229535313;2531.1141100614823;2711.376383431802;2799.8180118292244;2816.816906901045;3143.400806077052;10260.948695256477;10891.183161262938;11201.991820736173;11271.549138034468;11332.206745527816;1986.523234423728;2019.676851703735;2049.846261530391;2147.0660262785736;2149.50561370884;75453;81438.59280703559;81992.59003704943;89004.55497722534;89185;10730.678079657466;11578.76842463146;11718.414079296;11817.409129543488;12132.5146994121;15824.129672867872;16150.75773863393;16488.09315487636;16493.34026638921;17135.314587416615;8249.422540422232;8538.914610853935;8584.442011269248;8633.525156116473;8914.28685705142;7505.474616776883;7870.606469676493;7971.641276142587;8199.262066414052;8396.496210227406;5095.566876815438;5203.427622961472;5213.713245771443;5227.3988491323225;5335.199720042025;2036.3178335257558;2077.781832907553;2112;2116.312198535482;2148.6239908016037;964.6961207219704;994.9751256218652;1032.5405194688292;1034.4827586206898;1071.4321409652896;19853.404397868086;20486.897565512078;20629.54188782622;20655.277065302642;21191.470213244793;1005.788784355279;1037.1391744851755;1066.9466526673634;1076.4671487613682;1094.7646256054986;10563.577456901792;11431.14266430021;11602.88397116018;11618;11728.76542469163;486880;493107;493244;494851;497678;89101.55449222842;93080;94630;95418.5229073864;96185;1031.4791030529684;1083.4528563075596;1104.3263609198382;1113.1762495753085;1113.5267511307661;18016.279348826425;18287.817121829143;18298.817011829713;18648.897242606607;19018.23927042903;33089.834550827094;40275;43080.78459607682;44759.55240447554;45406;50398.74800625973;57454;58986.705066474395;59099.40900590939;60988;9111.498867562348;9204.171624553823;9247.583858726239;9594.760130996781;9633;13208.471661133448;13573.728525429238;13589.932050339685;13857.792133118213;13865.584032479042;11416.315021098428;12128.818067729168;12258.877411225774;12261.938690306491;12392.442340094538;11152;11707.941460292644;11748.882511175121;11782.469788859693;11862.288262704265;12117.575884843987;12571.30857802793;12583.685407864876;12708.110432269652;12769.8084528734;8278.379121565786;8647.610857511301;8786.516741579018;8871.512066836385;8941.642334306554;8960.507172105597;11917;12136.271823690608;12525.812112818132;12620.55828046014 04:14:34 INFO - PROCESS | 25987 | |3;mootools.html;1580.7075690997167;1591.7453207486801;1746.9301227950882;1811.3026484803347;1868.1593283022635;8527.530985795778;8838.29293656506;9247.167754902057;9983.600655973762;9994.400335979837;9017.504037277948;9458.243340532757;9515.381500202482;9765.365251258663;9778.11996920277;2553.4637726077544;2582.535143674138;2583.573710337792;2583.837273227046;2584.2247325802277;2222.277759728087;2294.1740973249616;2538.9111381101666;2645.0610033438143;2658.8670566471696;2497.900083996638;2582.586786114222;2583.160472846323;2587.185036713439;2588;2535.733747956466;2546.898124075035;2595.6236345729953;2598.9610155847677;2599.2462185966046;2394.928152155438;2400.0399840063938;2410.4937963027787;2470.1354525915967;2470.8270421070533;9507.144357007834;9608.519574021271;9611.51942402884;9626.903730962671;9691.51542422876;5681.0910254359105;5836.620619659751;5836.649801011953;5839.328477225131;5846;3678.9580094085027;3755.5681096673957;3842.1931394407206;3861.4014827701753;3875.786831724254;1115.358668765463;1167.0838391862433;1187.2283016039557;1190.5951976328004;1194.814803705427;12906.290154041524;13229.536966206233;13339.666508337272;13679.931600341935;13809.585712428643;4969.304297398367;4969.378827646544;4983.401991761012;5017.247412888096;5144.331236939174;10652.041316281571;10667.306625069501;10671.306365086244;10681.679549613524;10696.572137114585;5708.343540492813;5712.057510510802;5720.77116915327;5721.342045664718;5721.542276617861;5220.895582088413;5333.386660534011;5349.1976203569775;5349.411564727877;5379.973100134474;3876.1278712290073;3910.804459777;3968.8412463501136;3991.5210174779213;3998.3602623580086;1120.4229821641861;1136.3068528197794;1144.2219290882113;1149.9195056346143;1238.8946939510063;928.2666693312208;935.5883411299006;957.9616815327448;988.2736188901152;990.0841721407669;6075.665838378844;6271.122042913996;6373.7131829066875;6583.3416658334745;6592.274849766522;985.5614251657944;1020.2807021050141;1028.8148133336072;1033.379972016799;1044.8276034454382;4208.242516347087;4210.126493710331;4256.616904478612;4284.635805956466;4369.825206991748;11770.646880593426;12078.69803254908;12145.210561313486;12192.024638028937;12227.572034978733;12072.879271207352;12146.696332591579;12149.453274602663;12168.756624867454;12195.146339756131;8529.82940341202;8813.735587932373;8911.688090916787;8997.235235005099;9006.144416280444;6264.906026409699;6507.934920650922;6557.817978960813;6590.242122155822;6708.329167083252;11219.382933938712;11227.438628068401;11227.71930701739;11324.547018119183;11468.541258349573;10996.28524145928;11624.825627615422;11676.474558645052;11679.591214307458;11683.474243659226;8643.697470588499;8788.42875213109;8806;8817.338699597683;8819.206271435602;9208;9378.484183369706;9382.859257111286;9386.43681379092;9460.148586626961;8246.83506329858;8451.788705282172;8477.576121194039;8504.574771261288;8533.701320453754;8004.199580041949;8200.671973121009;8266.256036956704;8323.751437284214;8338.541380224146;7758.61206939662;7809.648565814666;7831.647575858986;7833.5691536966015;7848.960755196187;5473.233747275464;5578.135389014709;5638.5489160867855;5656.462636049569;5681.176229446624;5373.516383525502;5462.8361149165585;5481.068218402801;5485.807996720096;5548.306461692288 04:14:35 INFO - PROCESS | 25987 | |4;prototype.html;345.157814931567;354.7091385064248;355.9377109005923;356.28209158545525;368.959414464409;5458.631175312142;5580.91628625571;5636.182753500745;5646.548276137909;5652.4630160134775;5466.617336786427;5502.5597952163835;5504.311961004874;5524.8342549723475;5525.364583072947;4211.452511173543;4384.320430333296;4388.42950416447;4399.494058183318;4403.361512580674;4330.913381732379;4332.263515202423;4337.891552711176;4338;4341.6309613682715;4280.208161490119;4303;4342.934855977162;4344.239758042346;4351.65186785058;4371.3661519079715;4372.978135109336;4384.364267181241;4387.824487020499;4390.604845563883;3678.8528458861615;3827.0432391902023;3838.1556057667267;3840.711946604016;3852.595477474853;5436.673799572039;5442.428545002757;5447.972760136174;5468.6171967962255;5501.944980550184;5011.6241281904;5012.370979431663;5016.849494515134;5018.874528136789;5020.497950204986;5614.9438505615235;5736.56975726818;5738.368779434259;5755.769769209269;5770.7691692332255;4207.305794543897;4219.936700949488;4242.172776308621;4242.893927651802;4244.405783190356;5325.520703136736;5773.971130144364;6064.514838812885;6100.72546735398;6109.77804439114;4185.581441855851;4283.400323954649;4299.581138224378;4302.827886884552;4320.200762858881;4363.149185908781;4366.847160349373;4367.558705627135;4371.978140109342;4379.496357918816;4704.071330754375;4836.685615434985;4860.9062960834235;4969.503049695001;4976.601871850244;5763.6541807491685;5763.884722305615;5765.394633563499;5769.74036168365;5779.711014449261;1521.2621878388973;1541.175471122944;1545.188775892643;1558.1430213382594;1561.8672412844808;994.3089552760762;999.9700008999741;1005.9638572270572;1047.533847437898;1055.4089709762557;5416.160495123262;5432.212329212242;5454.290942177491;5458.372287187024;5459.617826752169;5843;5886.087656413263;5886.470217680344;5899.970500147558;5913.704314784243;5337.599680024014;5501.862453438616;5527;5553.77784888608;5554.305711786027;3129.3101725068664;3151.558781770554;3156.4949608062598;3158.7630927680516;3159.9052028439182;5771.682557459296;6008.24896887889;6093.512518998469;6104.847378815565;6119.44924956756;5786.392428795;5940.881182376328;5959.463648271676;5992.610480318765;6037.154798328237;5935.703214839241;6008.8197354078575;6044.939550604526;6122.969385153046;6155.446009859134;5935.703214839327;5937.664025594207;5953.821385358447;5990.6705131218205;6003.549733769897;5622.578306626938;5867.501262392744;5885.057471264367;5934.943504095308;5972.313183983723;6193.947029004989;6200.472959798468;6204.565680402328;6237.7193026314835;6262.405071518198;4153.709240353146;4329.913401731885;4343.69594128408;4355.520892701737;4382.693211475166;5897.9115313271195;5929.940700593112;5975.89253588123;5994.970025149846;6000.399960003964;5799.3040835100055;5806.883862322815;5835.490738982278;5852.619579727304;5867.6772777497645;5623.606347555796;5805.113338165029;5820.214271073351;5841.970790146022;5884.676342801187;5777.942220577908;5784.421557844182;5788.077021104484;5793.15999180125;5800.390958949419;5667.376588575171;5866;5867.794627188028;5871.559633027455;5899.67551784656;5675.587875152961;5710.600257981901;5713.314402271754;5717.456841600041;5717.799877004451 04:14:35 INFO - PROCESS | 25987 | |5;yui.html;794.781435105346;811.6023148657156;845.0324378586521;882.1663527966073;910.490125529703;15301.2349382531;15476.380944762224;15745.448909288192;15863.444779432722;15898.284577194025;16093.275802588882;16212.432564860232;16232.431864884731;16233.83766162338;16915.238814253356;872.2106493623265;905.4024343933006;907.9591418386188;908.5684299957534;908.6547112097394;728.238990255182;746.9626518674045;869.9043105258417;892.901780804111;898.4564338575166;940.4592359393342;942.1520631431698;943.4669411782321;943.5188054092393;943.5423819447562;758.3743411685326;935.7988032572996;937.1284705224139;938.174406522256;938.258775567301;567.7473524281696;668.9397954184099;681.5161235522735;683.135833171039;687.9518433709642;16238.350465981346;16239.91880040604;16243.431479898147;16272.349106035745;16273.104979226138;14969;15452.227388630523;15540;15792.447264345808;16013.759793603105;13287.601371958857;13517.188968661912;13614;13794.517191898236;14267;4700.871790770225;4764.737939413331;4772.537118357932;4820.951790482085;4945.381827271591;87570.12429875747;87814;89092.5545372269;89129;89566.55216723874;11956.608280254743;12154.696132596755;12422.130450868352;12481.188722732993;12488.188267762567;22567.88716056442;22576.887115564645;22587.322380328616;22598.435039124153;22603.886980564992;9178.724638260863;9260.768480788034;9657.613695452103;9706.272029597809;9833;5208.869778255498;5232.843014709565;5290.523852853262;5296.311479507716;5523.944760552424;3930.3907894275862;4113.115680128787;4119.382092686121;4120.855770048034;4144.979275103605;701.5194591704699;713.6289129652655;714.2000958926036;718.60476737794;718.6191318601045;705.2172088981226;739.548875186136;778.9746658687368;825.1500954017372;843.1315744782884;10639.10563176238;10984.286021408583;11203.831942520868;11479.25384849982;11485.540578376938;652.0579343595058;674.1606699658956;683.7846078485261;726.0706295941098;731.5537522111508;5286.577073834084;5468.535174510132;5475.780968761284;5491.258680078138;5496.532794712414;73936.26063739293;75296.62351688207;95108;130399.34800325938;140982.2950885239;110663;117034;118263.40868295604;119468;123153.38423308005;97136.90007082756;102321.48839255756;102779;103872;104143.4792826031;10290.948545257226;10313.1233845124;10419.374837509773;10456.947715261374;10468.790624187626;57725.422745772004;58174.4182558169;58295;58870.70564647149;58917.410825892905;79736.60131699537;86690;86854.56572717096;88547;88711;13328.666783330107;13521.526746563823;14023.719525609635;14038.298085095908;14257.64355891111;15451.768223476432;15951.361945522513;16226.67546649084;16750.66498670044;16825.158742063093;15705.921470392575;15816.60458488547;15846.207689615703;16854.241559129623;17003.659926801643;14812.703745925237;14843.92578037103;15092.849071509145;15284.694306114037;15780.92109539445;14162.98955450876;14513.709725805636;14905.25473726331;15030.774538382151;15070.397184112513;12002.579909703118;12078.154529182873;12481.625551233477;12528.686782830502;12958.870411295766;12310.692232694255;12357.876421236033;12372.477529682748;12405;12721.93639031799 04:14:35 INFO - PROCESS | 25987 | __end_tp_report 04:14:35 INFO - PROCESS | 25987 | __start_cc_report 04:14:35 INFO - PROCESS | 25987 | _x_x_mozilla_cycle_collect,922 04:14:35 INFO - PROCESS | 25987 | __end_cc_report 04:14:35 INFO - PROCESS | 25987 | __startTimestamp1478780074990__endTimestamp 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | ------- Summary: start ------- 04:14:35 INFO - PROCESS | 25987 | Number of tests: 6 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | [#0] dojo.html Cycles:165 Average:5476.38 Median:5687.40 stddev:615.47 (10.8%) stddev-sans-first:588.34 04:14:35 INFO - PROCESS | 25987 | Values: 3095.4 3146.2 3153.1 3164.1 3189.6 5426.6 5519.7 5520.9 5522.3 5533.6 5532.1 5563.5 5567.4 5576.7 5581.2 5023.7 5037.3 5056.1 5118.1 5142.6 4944.2 4951.4 4971.1 5104.3 5150.6 4976.9 5099.8 5101.4 5104.2 5110.2 5111.7 5118.2 5122.0 5126.8 5154.1 4868.1 4881.2 5001.7 5023.9 5099.6 5365.7 5403.1 5403.9 5430.3 5439.8 5784.3 5806.0 5876.6 5919.5 5924.5 5735.5 5954.6 5966.1 5985.7 5989.4 5415.2 5455.9 5492.8 5516.5 5572.1 6074.3 6076.0 6077.3 6078.5 6086.7 5846.6 5853.0 5853.8 5858.9 5866.5 5620.6 5639.4 5823.6 5881.9 5887.8 5917.8 5918.1 5937.2 5938.6 5945.0 5925.8 5931.6 5944.2 5944.3 5987.9 4375.6 4430.5 4515.3 4529.4 4576.2 4029.1 4051.5 4072.6 4085.3 4096.8 5520.8 5534.1 5536.9 5538.1 5538.5 5712.9 5763.9 5857.4 5872.0 5921.0 5487.1 5615.3 5617.2 5629.5 5646.9 5172.4 5179.3 5180.4 5186.1 5233.7 5894.1 5960.4 6173.0 6180.8 6182.8 5759.6 5773.0 5813.0 5882.0 5910.0 6057.9 6061.9 6067.1 6068.3 6073.0 5583.3 5721.5 5771.4 5780.9 5783.9 5713.2 5826.8 5828.7 5868.2 5996.1 5777.5 5815.8 5822.8 5823.7 5827.2 5767.3 5774.3 5789.0 5801.0 5802.4 5508.3 5533.6 5632.4 5690.3 5707.2 5827.9 5831.2 5833.7 5834.3 5842.3 5491.6 5687.4 5694.7 5702.8 5703.3 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | [#1] ext.html Cycles:180 Average:50941.33 Median:38198.24 stddev:90334.07 (236.5%) stddev-sans-first:90508.37 04:14:35 INFO - PROCESS | 25987 | Values: 588.9 635.3 643.4 645.6 661.0 34556.3 38340.6 44053.0 44467.0 44539.3 48547.5 49038.8 49164.0 49171.0 49382.5 9078.9 9261.2 9272.9 9292.0 9297.3 8383.6 8609.9 10860.8 11120.8 11125.9 11270.9 11341.6 11341.9 11353.7 11374.2 11070.2 11136.4 11142.7 11153.8 11154.5 10940.8 11003.2 11006.0 11013.5 11021.9 45375.5 45805.5 45823.0 45843.5 46017.5 4070.3 4284.7 4341.3 4419.0 4554.6 34391.9 34854.8 35324.3 36424.8 36737.0 4220.8 4277.6 4380.0 4462.6 4528.0 373690.0 374136.0 374437.0 374939.0 376448.0 38324.2 62212.4 62511.7 62520.1 62564.4 39567.0 41633.2 41665.8 41822.0 41837.8 16419.3 16526.0 16529.5 16534.1 16537.8 12755.0 13072.3 14454.1 14562.5 14564.3 9314.8 9486.0 9554.1 9647.6 9751.3 3611.4 3647.9 3677.8 3687.5 3741.5 1052.7 1103.2 1104.9 1166.8 1186.4 34022.5 34248.5 34571.0 34622.3 34622.8 1104.1 1110.5 1147.8 1151.2 1218.6 17834.7 17861.7 18056.3 18126.0 18173.9 163721.0 163962.0 164168.0 164858.2 165312.0 63213.4 63634.0 63933.7 63946.7 63954.0 1329.9 1358.7 1378.7 1413.3 1455.3 33662.7 35214.8 35341.5 35378.0 35609.1 54367.5 54878.7 54976.0 54981.7 55032.2 424872.0 427308.0 427457.0 428170.0 430280.0 30313.1 31199.0 31251.7 31256.8 32942.2 50946.5 51208.2 51233.5 51266.7 52718.0 42635.6 43179.0 43180.4 43299.8 44318.8 43006.6 43820.0 44194.1 44413.0 44656.0 42647.6 43431.3 43880.8 43903.0 44097.8 34389.3 38072.2 38540.8 38962.0 39018.8 29265.9 29451.3 29772.4 29864.4 29866.6 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | [#2] jquery.html Cycles:180 Average:29398.57 Median:23531.65 stddev:81323.34 (345.6%) stddev-sans-first:81522.31 04:14:35 INFO - PROCESS | 25987 | Values: 394.1 429.9 430.9 433.0 453.1 17235.9 20235.6 20826.2 21539.9 21662.1 18907.8 19343.2 19481.8 20038.8 20077.7 5574.6 5658.2 5776.9 5782.7 5786.4 6112.7 6120.8 6122.3 6139.3 6189.2 5904.2 6074.5 6131.3 6133.9 6137.5 6116.6 6175.4 6178.6 6189.2 6192.4 5411.9 5500.0 5533.0 5579.8 5615.4 15053.3 15239.4 15269.6 23224.8 23838.5 2531.1 2711.4 2799.8 2816.8 3143.4 10260.9 10891.2 11202.0 11271.5 11332.2 1986.5 2019.7 2049.8 2147.1 2149.5 75453.0 81438.6 81992.6 89004.6 89185.0 10730.7 11578.8 11718.4 11817.4 12132.5 15824.1 16150.8 16488.1 16493.3 17135.3 8249.4 8538.9 8584.4 8633.5 8914.3 7505.5 7870.6 7971.6 8199.3 8396.5 5095.6 5203.4 5213.7 5227.4 5335.2 2036.3 2077.8 2112.0 2116.3 2148.6 964.7 995.0 1032.5 1034.5 1071.4 19853.4 20486.9 20629.5 20655.3 21191.5 1005.8 1037.1 1066.9 1076.5 1094.8 10563.6 11431.1 11602.9 11618.0 11728.8 486880.0 493107.0 493244.0 494851.0 497678.0 89101.6 93080.0 94630.0 95418.5 96185.0 1031.5 1083.5 1104.3 1113.2 1113.5 18016.3 18287.8 18298.8 18648.9 19018.2 33089.8 40275.0 43080.8 44759.6 45406.0 50398.7 57454.0 58986.7 59099.4 60988.0 9111.5 9204.2 9247.6 9594.8 9633.0 13208.5 13573.7 13589.9 13857.8 13865.6 11416.3 12128.8 12258.9 12261.9 12392.4 11152.0 11707.9 11748.9 11782.5 11862.3 12117.6 12571.3 12583.7 12708.1 12769.8 8278.4 8647.6 8786.5 8871.5 8941.6 8960.5 11917.0 12136.3 12525.8 12620.6 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | [#3] mootools.html Cycles:180 Average:6320.88 Median:4976.39 stddev:3642.09 (73.2%) stddev-sans-first:3634.88 04:14:35 INFO - PROCESS | 25987 | Values: 1580.7 1591.7 1746.9 1811.3 1868.2 8527.5 8838.3 9247.2 9983.6 9994.4 9017.5 9458.2 9515.4 9765.4 9778.1 2553.5 2582.5 2583.6 2583.8 2584.2 2222.3 2294.2 2538.9 2645.1 2658.9 2497.9 2582.6 2583.2 2587.2 2588.0 2535.7 2546.9 2595.6 2599.0 2599.2 2394.9 2400.0 2410.5 2470.1 2470.8 9507.1 9608.5 9611.5 9626.9 9691.5 5681.1 5836.6 5836.6 5839.3 5846.0 3679.0 3755.6 3842.2 3861.4 3875.8 1115.4 1167.1 1187.2 1190.6 1194.8 12906.3 13229.5 13339.7 13679.9 13809.6 4969.3 4969.4 4983.4 5017.2 5144.3 10652.0 10667.3 10671.3 10681.7 10696.6 5708.3 5712.1 5720.8 5721.3 5721.5 5220.9 5333.4 5349.2 5349.4 5380.0 3876.1 3910.8 3968.8 3991.5 3998.4 1120.4 1136.3 1144.2 1149.9 1238.9 928.3 935.6 958.0 988.3 990.1 6075.7 6271.1 6373.7 6583.3 6592.3 985.6 1020.3 1028.8 1033.4 1044.8 4208.2 4210.1 4256.6 4284.6 4369.8 11770.6 12078.7 12145.2 12192.0 12227.6 12072.9 12146.7 12149.5 12168.8 12195.1 8529.8 8813.7 8911.7 8997.2 9006.1 6264.9 6507.9 6557.8 6590.2 6708.3 11219.4 11227.4 11227.7 11324.5 11468.5 10996.3 11624.8 11676.5 11679.6 11683.5 8643.7 8788.4 8806.0 8817.3 8819.2 9208.0 9378.5 9382.9 9386.4 9460.1 8246.8 8451.8 8477.6 8504.6 8533.7 8004.2 8200.7 8266.3 8323.8 8338.5 7758.6 7809.6 7831.6 7833.6 7849.0 5473.2 5578.1 5638.5 5656.5 5681.2 5373.5 5462.8 5481.1 5485.8 5548.3 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | [#4] prototype.html Cycles:180 Average:4891.22 Median:5525.10 stddev:1416.41 (25.6%) stddev-sans-first:1378.67 04:14:35 INFO - PROCESS | 25987 | Values: 345.2 354.7 355.9 356.3 369.0 5458.6 5580.9 5636.2 5646.5 5652.5 5466.6 5502.6 5504.3 5524.8 5525.4 4211.5 4384.3 4388.4 4399.5 4403.4 4330.9 4332.3 4337.9 4338.0 4341.6 4280.2 4303.0 4342.9 4344.2 4351.7 4371.4 4373.0 4384.4 4387.8 4390.6 3678.9 3827.0 3838.2 3840.7 3852.6 5436.7 5442.4 5448.0 5468.6 5501.9 5011.6 5012.4 5016.8 5018.9 5020.5 5614.9 5736.6 5738.4 5755.8 5770.8 4207.3 4219.9 4242.2 4242.9 4244.4 5325.5 5774.0 6064.5 6100.7 6109.8 4185.6 4283.4 4299.6 4302.8 4320.2 4363.1 4366.8 4367.6 4372.0 4379.5 4704.1 4836.7 4860.9 4969.5 4976.6 5763.7 5763.9 5765.4 5769.7 5779.7 1521.3 1541.2 1545.2 1558.1 1561.9 994.3 1000.0 1006.0 1047.5 1055.4 5416.2 5432.2 5454.3 5458.4 5459.6 5843.0 5886.1 5886.5 5900.0 5913.7 5337.6 5501.9 5527.0 5553.8 5554.3 3129.3 3151.6 3156.5 3158.8 3159.9 5771.7 6008.2 6093.5 6104.8 6119.4 5786.4 5940.9 5959.5 5992.6 6037.2 5935.7 6008.8 6044.9 6123.0 6155.4 5935.7 5937.7 5953.8 5990.7 6003.5 5622.6 5867.5 5885.1 5934.9 5972.3 6193.9 6200.5 6204.6 6237.7 6262.4 4153.7 4329.9 4343.7 4355.5 4382.7 5897.9 5929.9 5975.9 5995.0 6000.4 5799.3 5806.9 5835.5 5852.6 5867.7 5623.6 5805.1 5820.2 5842.0 5884.7 5777.9 5784.4 5788.1 5793.2 5800.4 5667.4 5866.0 5867.8 5871.6 5899.7 5675.6 5710.6 5713.3 5717.5 5717.8 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - PROCESS | 25987 | [#5] yui.html Cycles:180 Average:22985.53 Median:13267.14 stddev:33069.14 (249.3%) stddev-sans-first:33119.93 04:14:35 INFO - PROCESS | 25987 | Values: 794.8 811.6 845.0 882.2 910.5 15301.2 15476.4 15745.4 15863.4 15898.3 16093.3 16212.4 16232.4 16233.8 16915.2 872.2 905.4 908.0 908.6 908.7 728.2 747.0 869.9 892.9 898.5 940.5 942.2 943.5 943.5 943.5 758.4 935.8 937.1 938.2 938.3 567.7 668.9 681.5 683.1 688.0 16238.4 16239.9 16243.4 16272.3 16273.1 14969.0 15452.2 15540.0 15792.4 16013.8 13287.6 13517.2 13614.0 13794.5 14267.0 4700.9 4764.7 4772.5 4821.0 4945.4 87570.1 87814.0 89092.6 89129.0 89566.6 11956.6 12154.7 12422.1 12481.2 12488.2 22567.9 22576.9 22587.3 22598.4 22603.9 9178.7 9260.8 9657.6 9706.3 9833.0 5208.9 5232.8 5290.5 5296.3 5523.9 3930.4 4113.1 4119.4 4120.9 4145.0 701.5 713.6 714.2 718.6 718.6 705.2 739.5 779.0 825.2 843.1 10639.1 10984.3 11203.8 11479.3 11485.5 652.1 674.2 683.8 726.1 731.6 5286.6 5468.5 5475.8 5491.3 5496.5 73936.3 75296.6 95108.0 130399.3 140982.3 110663.0 117034.0 118263.4 119468.0 123153.4 97136.9 102321.5 102779.0 103872.0 104143.5 10290.9 10313.1 10419.4 10456.9 10468.8 57725.4 58174.4 58295.0 58870.7 58917.4 79736.6 86690.0 86854.6 88547.0 88711.0 13328.7 13521.5 14023.7 14038.3 14257.6 15451.8 15951.4 16226.7 16750.7 16825.2 15705.9 15816.6 15846.2 16854.2 17003.7 14812.7 14843.9 15092.8 15284.7 15780.9 14163.0 14513.7 14905.3 15030.8 15070.4 12002.6 12078.2 12481.6 12528.7 12958.9 12310.7 12357.9 12372.5 12405.0 12721.9 04:14:35 INFO - PROCESS | 25987 | -------- Summary: end -------- 04:14:35 INFO - PROCESS | 25987 | 04:14:35 INFO - TEST-INFO | 25987: exit 0 04:14:35 INFO - TEST-OK | dromaeo_css | took 1114042ms 04:14:35 INFO - TEST-START | kraken 04:14:35 INFO - operating with platform_type : linux_ 04:14:35 INFO - Initialising browser for kraken test... 04:14:35 INFO - TEST-INFO | started process 26305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd3dPgj/profile http://localhost:37606/getInfo.html) 04:14:39 INFO - PROCESS | 26305 | __metrics Screen width/height:1600/1200 04:14:39 INFO - PROCESS | 26305 | colorDepth:24 04:14:39 INFO - PROCESS | 26305 | Browser inner width/height: 1024/697 04:14:39 INFO - PROCESS | 26305 | __metrics 04:14:40 INFO - PROCESS | 26305 | 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" 04:14:40 INFO - PROCESS | 26305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:40 INFO - PROCESS | 26305 | console.error: PushService: 04:14:40 INFO - PROCESS | 26305 | stateChangeProcessEnqueue: Error transitioning state 04:14:40 INFO - PROCESS | 26305 | UnknownError 04:14:41 INFO - TEST-INFO | 26305: exit 0 04:14:41 INFO - Browser initialized. 04:14:41 INFO - Running cycle 1/1 for kraken test... 04:14:41 INFO - TEST-INFO | started process 26397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd3dPgj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:53 INFO - PROCESS | 26397 | RSS: Main: 145678336 04:14:53 INFO - PROCESS | 26397 | 04:14:55 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37606/tests/kraken/driver.html?testName=audio-beat-detection) 04:14:56 INFO - PROCESS | 26397 | RSS: Main: 186986496 04:14:56 INFO - PROCESS | 26397 | 04:14:58 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37606/tests/kraken/driver.html?testName=audio-dft) 04:14:59 INFO - PROCESS | 26397 | RSS: Main: 176721920 04:14:59 INFO - PROCESS | 26397 | 04:15:02 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37606/tests/kraken/driver.html?testName=audio-fft) 04:15:02 INFO - PROCESS | 26397 | RSS: Main: 267931648 04:15:02 INFO - PROCESS | 26397 | 04:15:05 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37606/tests/kraken/driver.html?testName=audio-oscillator) 04:15:05 INFO - PROCESS | 26397 | RSS: Main: 174247936 04:15:05 INFO - PROCESS | 26397 | 04:15:07 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:08 INFO - PROCESS | 26397 | RSS: Main: 175759360 04:15:08 INFO - PROCESS | 26397 | 04:15:11 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37606/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:11 INFO - PROCESS | 26397 | RSS: Main: 211480576 04:15:11 INFO - PROCESS | 26397 | 04:15:15 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37606/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:15 INFO - PROCESS | 26397 | RSS: Main: 210804736 04:15:15 INFO - PROCESS | 26397 | 04:15:18 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37606/tests/kraken/driver.html?testName=json-parse-financial) 04:15:19 INFO - PROCESS | 26397 | RSS: Main: 210444288 04:15:19 INFO - PROCESS | 26397 | 04:15:20 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:21 INFO - PROCESS | 26397 | RSS: Main: 171892736 04:15:21 INFO - PROCESS | 26397 | 04:15:22 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:23 INFO - PROCESS | 26397 | RSS: Main: 180060160 04:15:23 INFO - PROCESS | 26397 | 04:15:25 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:26 INFO - PROCESS | 26397 | RSS: Main: 189259776 04:15:26 INFO - PROCESS | 26397 | 04:15:28 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:15:29 INFO - PROCESS | 26397 | RSS: Main: 197881856 04:15:29 INFO - PROCESS | 26397 | 04:15:32 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:15:32 INFO - PROCESS | 26397 | RSS: Main: 193490944 04:15:32 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | Cycle 1(1): loaded http://localhost:37606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37606/tests/kraken/driver.html?testName=ai-astar) 04:15:34 INFO - PROCESS | 26397 | RSS: Main: 246063104 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | __start_tp_report 04:15:34 INFO - PROCESS | 26397 | _x_x_mozilla_page_load 04:15:34 INFO - PROCESS | 26397 | _x_x_mozilla_page_load_details 04:15:34 INFO - PROCESS | 26397 | |i|pagename|runs| 04:15:34 INFO - PROCESS | 26397 | |0;ai-astar;108;111;109;111;111;111;110;109;110;111 04:15:34 INFO - PROCESS | 26397 | |1;audio-beat-detection;150;121;122;166;121;118;116;116;149;118 04:15:34 INFO - PROCESS | 26397 | |2;audio-dft;162;161;161;161;161;160;160;161;164;162 04:15:34 INFO - PROCESS | 26397 | |3;audio-fft;74;74;73;115;75;75;75;75;106;76 04:15:34 INFO - PROCESS | 26397 | |4;audio-oscillator;82;82;119;82;82;81;111;81;81;110 04:15:34 INFO - PROCESS | 26397 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;116;116;117 04:15:34 INFO - PROCESS | 26397 | |6;imaging-darkroom;146;148;146;146;147;148;146;147;145;146 04:15:34 INFO - PROCESS | 26397 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;95 04:15:34 INFO - PROCESS | 26397 | |8;json-parse-financial;50;51;50;50;49;51;55;49;50;49 04:15:34 INFO - PROCESS | 26397 | |9;json-stringify-tinderbox;59;59;59;59;60;59;60;59;60;59 04:15:34 INFO - PROCESS | 26397 | |10;stanford-crypto-aes;72;76;78;73;78;73;81;73;72;73 04:15:34 INFO - PROCESS | 26397 | |11;stanford-crypto-ccm;128;141;124;139;135;121;120;126;163;118 04:15:34 INFO - PROCESS | 26397 | |12;stanford-crypto-pbkdf2;157;157;154;157;161;158;153;158;154;153 04:15:34 INFO - PROCESS | 26397 | |13;stanford-crypto-sha256-iterative;61;63;63;61;65;66;62;61;61;60 04:15:34 INFO - PROCESS | 26397 | __end_tp_report 04:15:34 INFO - PROCESS | 26397 | __start_cc_report 04:15:34 INFO - PROCESS | 26397 | _x_x_mozilla_cycle_collect,1636 04:15:34 INFO - PROCESS | 26397 | __end_cc_report 04:15:34 INFO - PROCESS | 26397 | __startTimestamp1478780134522__endTimestamp 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | ------- Summary: start ------- 04:15:34 INFO - PROCESS | 26397 | Number of tests: 14 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.10 (1.0%) stddev-sans-first:0.87 04:15:34 INFO - PROCESS | 26397 | Values: 108.0 111.0 109.0 111.0 111.0 111.0 110.0 109.0 110.0 111.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:121.50 stddev:18.14 (14.9%) stddev-sans-first:17.69 04:15:34 INFO - PROCESS | 26397 | Values: 150.0 121.0 122.0 166.0 121.0 118.0 116.0 116.0 149.0 118.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 04:15:34 INFO - PROCESS | 26397 | Values: 162.0 161.0 161.0 161.0 161.0 160.0 160.0 161.0 164.0 162.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:15.30 (20.4%) stddev-sans-first:15.96 04:15:34 INFO - PROCESS | 26397 | Values: 74.0 74.0 73.0 115.0 75.0 75.0 75.0 75.0 106.0 76.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.50 stddev:15.52 (19.0%) stddev-sans-first:16.11 04:15:34 INFO - PROCESS | 26397 | Values: 82.0 82.0 119.0 82.0 82.0 81.0 111.0 81.0 81.0 110.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:15:34 INFO - PROCESS | 26397 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 117.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 04:15:34 INFO - PROCESS | 26397 | Values: 146.0 148.0 146.0 146.0 147.0 148.0 146.0 147.0 145.0 146.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:15:34 INFO - PROCESS | 26397 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.00 stddev:1.78 (3.6%) stddev-sans-first:1.88 04:15:34 INFO - PROCESS | 26397 | Values: 50.0 51.0 50.0 50.0 49.0 51.0 55.0 49.0 50.0 49.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:15:34 INFO - PROCESS | 26397 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 60.0 59.0 60.0 59.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.50 stddev:3.14 (4.2%) stddev-sans-first:3.15 04:15:34 INFO - PROCESS | 26397 | Values: 72.0 76.0 78.0 73.0 78.0 73.0 81.0 73.0 72.0 73.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:131.50 stddev:13.64 (10.4%) stddev-sans-first:14.41 04:15:34 INFO - PROCESS | 26397 | Values: 128.0 141.0 124.0 139.0 135.0 121.0 120.0 126.0 163.0 118.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.00 stddev:2.62 (1.7%) stddev-sans-first:2.76 04:15:34 INFO - PROCESS | 26397 | Values: 157.0 157.0 154.0 157.0 161.0 158.0 153.0 158.0 154.0 153.0 04:15:34 INFO - PROCESS | 26397 | 04:15:34 INFO - PROCESS | 26397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.95 (3.1%) stddev-sans-first:2.01 04:15:34 INFO - PROCESS | 26397 | Values: 61.0 63.0 63.0 61.0 65.0 66.0 62.0 61.0 61.0 60.0 04:15:34 INFO - PROCESS | 26397 | -------- Summary: end -------- 04:15:34 INFO - PROCESS | 26397 | 04:15:35 INFO - TEST-INFO | 26397: exit 0 04:15:35 INFO - TEST-OK | kraken | took 59948ms 04:15:35 INFO - SUITE-END | took 1173s 04:15:35 INFO - Completed test suite (00:19:34) 04:15:35 INFO - javascript benchmark 04:15:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.411871744369, 3146.181992681902, 3153.132888455674, 3164.05078476457, 3189.6012998375204, 5426.565874730022, 5519.69641669708, 5520.889582208359, 5522.30971128609, 5533.612647114704, 5532.059549876521, 5563.499285064354, 5567.415421380758, 5576.721163941807, 5581.190727344532, 5023.6985780853265, 5037.29477873098, 5056.115179843531, 5118.104331741949, 5142.61430392722, 4944.233643785219, 4951.430585482662, 4971.080350135237, 5104.285400043997, 5150.613703972198, 4976.900461990758, 5099.796008159669, 5101.413337466183, 5104.183330667094, 5110.182370820669, 5111.744412779365, 5118.1555043417975, 5121.974390128063, 5126.769295381717, 5154.098032844237, 4868.05073010763, 4881.170201065792, 5001.674891132065, 5023.899522009576, 5099.59203263738, 5365.678059316415, 5403.13549832025, 5403.918941215885, 5430.321209848769, 5439.782408703647, 5784.334801497839, 5806.0, 5876.55925805562, 5919.5264378850015, 5924.526037916957, 5735.4551317624755, 5954.583179177459, 5966.075258334965, 5985.700714964234, 5989.3711160327975, 5415.187721841716, 5455.918161227585, 5492.752826122794, 5516.503514683698, 5572.136318870582, 6074.271087469532, 6076.0, 6077.3314935357075, 6078.544109191828, 6086.69566521681, 5846.590738648254, 5852.970735146297, 5853.824385268449, 5858.882822343529, 5866.472017518444, 5620.606557541015, 5639.407862174495, 5823.5923485355615, 5881.911771323434, 5887.764489420375, 5917.763289468373, 5918.112283157561, 5937.198478205473, 5938.584299099108, 5944.970275148597, 5925.822225333247, 5931.555133365015, 5944.167816505606, 5944.346121926585, 5987.850303742442, 4375.606195442362, 4430.468343798765, 4515.254982927846, 4529.433820772403, 4576.244919588297, 4029.133736246721, 4051.453053837753, 4072.592740725963, 4085.3463445849115, 4096.754194748325, 5520.779168833202, 5534.142207957773, 5536.944630553723, 5538.113901775697, 5538.501534861882, 5712.914306285409, 5763.8559036024435, 5857.355690874, 5871.9706401468575, 5920.970395147997, 5487.094629386186, 5615.2700148980375, 5617.157426386075, 5629.493345598916, 5646.887062258732, 5172.379314482211, 5179.2749015137915, 5180.352455943007, 5186.144286192812, 5233.71214583194, 5894.145348924382, 5960.374160713236, 6173.0, 6180.783672571529, 6182.783602573888, 5759.596828221985, 5773.04744717117, 5813.04084825999, 5881.97065513542, 5910.0, 6057.939420605738, 6061.909071363845, 6067.12026756109, 6068.271807383142, 6073.0, 5583.302087239095, 5721.542276617944, 5771.422857714195, 5780.855478613068, 5783.8554036149435, 5713.1715901193265, 5826.796062137805, 5828.70856457167, 5868.178455016387, 5996.100584912124, 5777.537796976148, 5815.76736930518, 5822.7670893163795, 5823.679697616502, 5827.155062515827, 5767.279090113736, 5774.2782152230975, 5788.971055144697, 5801.0, 5802.448767367094, 5508.256385387921, 5533.6126471148245, 5632.380438151882, 5690.260266165372, 5707.172459993195, 5827.94172058274, 5831.212786273968, 5833.708314584169, 5834.329052159056, 5842.328132264844, 5491.643043202179, 5687.402822703722, 5694.743736531949, 5702.7718891243885, 5703.287089113861], "value": 5434.904773847208, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.8557303460652, 635.275785604411, 643.3534298030479, 645.5900503180479, 661.0480907493211, 34556.308873822505, 38340.61659383406, 44052.999999999956, 44467.0, 44539.33191002138, 48547.51452485474, 49038.75480622601, 49164.0, 49171.0, 49382.50617493824, 9078.86381704275, 9261.166495015448, 9272.860907086399, 9291.953540232324, 9297.30270229732, 8383.62273697682, 8609.913900861005, 10860.782784344308, 11120.833187502194, 11125.888741112607, 11270.887291127066, 11341.603043893465, 11341.886581134166, 11353.716157096098, 11374.203805733601, 11070.225084244106, 11136.387498687569, 11142.665720028412, 11153.776924461547, 11154.498047587918, 10940.781184376348, 11003.22977391583, 11006.0, 11013.504392302286, 11021.944890275578, 45375.546244537465, 45805.54194458046, 45823.0, 45843.54156458426, 46017.53982460166, 4070.3080476319096, 4284.721493102938, 4341.348797680342, 4419.049904270565, 4554.590086892195, 34391.89122177148, 34854.82572587146, 35324.293514129575, 36424.81787591072, 36737.0, 4220.810063547147, 4277.636400905927, 4380.0, 4462.642988560908, 4527.954720452786, 373690.0, 374136.0, 374437.0, 374939.0, 376448.0, 38324.233515329535, 62212.377876221566, 62511.6874415625, 62520.06219906705, 62564.37435625677, 39567.0, 41633.167336653096, 41665.791671042054, 41822.0, 41837.79081104575, 16419.343226270816, 16526.0, 16529.504114876574, 16534.0906250155, 16537.83462165387, 12755.0, 13072.346382680827, 14454.060486068372, 14562.490312839, 14564.344604492824, 9314.767130821783, 9486.003969583233, 9554.092361225672, 9647.565859536338, 9751.268654850914, 3611.368010598135, 3647.85408583659, 3677.8344974476213, 3687.539057617798, 3741.494898188764, 1052.7101315887573, 1103.2112039891356, 1104.861892263467, 1166.7549814538872, 1186.4008675618757, 34022.48966265508, 34248.48627270593, 34571.0, 34622.30755384878, 34622.826885865914, 1104.0560320925654, 1110.4836251143256, 1147.8278258261162, 1151.205668089016, 1218.5879537295536, 17834.719412602186, 17861.7320740189, 18056.277748889897, 18126.00920848072, 18173.90956542612, 163721.0, 163962.0, 164168.0, 164858.1757091207, 165312.0, 63213.36786632075, 63634.0, 63933.68033159804, 63946.68026659837, 63954.0, 1329.8537160912292, 1358.7418390505773, 1378.6622277541867, 1413.3286688822727, 1455.345094707407, 33662.663373365955, 35214.823925880206, 35341.469877951335, 35378.0, 35609.109772254866, 54367.45632543624, 54878.725606371714, 54976.0, 54981.72509137429, 55032.17451738307, 424872.0, 427308.0, 427457.0, 428170.0, 430280.0, 30313.090607281818, 31199.0, 31251.68748312488, 31256.843715781277, 32942.17644558905, 50946.49053509418, 51208.23187652114, 51233.48766512287, 51266.74366628143, 52718.0, 42635.573644264405, 43179.0, 43180.352294716235, 43299.7835010823, 44318.77840610905, 43006.569934300256, 43820.0, 44194.11611767682, 44413.04791232398, 44656.0, 42647.5735242656, 43431.34852977271, 43880.78059609682, 43903.0, 44097.77951110224, 34389.312213756086, 38072.23855522929, 38540.80729596334, 38962.0, 39018.80490597529, 29265.85367073151, 29451.263718407212, 29772.404551909272, 29864.402711945204, 29866.552001719556], "value": 19851.265323745727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.10341473148566, 429.8817825098098, 430.9052008558116, 432.97766163133247, 453.0960733336991, 17235.913820430895, 20235.595288094228, 20826.166953321866, 21539.892300538515, 21662.133514659396, 18907.810921890778, 19343.226270949144, 19481.805181948177, 20038.799612003877, 20077.698834517494, 5574.581906357019, 5658.236138121362, 5776.884462310752, 5782.710864456782, 5786.421357864222, 6112.724927378279, 6120.785772497963, 6122.265328160627, 6139.293981192153, 6189.16446279751, 5904.2324497815225, 6074.544409169308, 6131.325554189036, 6133.907991380132, 6137.478314343286, 6116.602420842631, 6175.382461753834, 6178.567500274982, 6189.195404597419, 6192.411720886508, 5411.945880541183, 5500.037493438632, 5532.972335138298, 5579.804706835242, 5615.354234263031, 15053.322600483005, 15239.390424383011, 15269.61825954349, 23224.76775232243, 23838.523229535313, 2531.1141100614823, 2711.376383431802, 2799.8180118292244, 2816.816906901045, 3143.400806077052, 10260.948695256477, 10891.183161262938, 11201.991820736173, 11271.549138034468, 11332.206745527816, 1986.523234423728, 2019.676851703735, 2049.846261530391, 2147.0660262785736, 2149.50561370884, 75453.0, 81438.59280703559, 81992.59003704943, 89004.55497722534, 89185.0, 10730.678079657466, 11578.76842463146, 11718.414079296, 11817.409129543488, 12132.5146994121, 15824.129672867872, 16150.75773863393, 16488.09315487636, 16493.34026638921, 17135.314587416615, 8249.422540422232, 8538.914610853935, 8584.442011269248, 8633.525156116473, 8914.28685705142, 7505.474616776883, 7870.606469676493, 7971.641276142587, 8199.262066414052, 8396.496210227406, 5095.566876815438, 5203.427622961472, 5213.713245771443, 5227.3988491323225, 5335.199720042025, 2036.3178335257558, 2077.781832907553, 2112.0, 2116.312198535482, 2148.6239908016037, 964.6961207219704, 994.9751256218652, 1032.5405194688292, 1034.4827586206898, 1071.4321409652896, 19853.404397868086, 20486.897565512078, 20629.54188782622, 20655.277065302642, 21191.470213244793, 1005.788784355279, 1037.1391744851755, 1066.9466526673634, 1076.4671487613682, 1094.7646256054986, 10563.577456901792, 11431.14266430021, 11602.88397116018, 11618.0, 11728.76542469163, 486880.0, 493107.0, 493244.0, 494851.0, 497678.0, 89101.55449222842, 93080.0, 94630.0, 95418.5229073864, 96185.0, 1031.4791030529684, 1083.4528563075596, 1104.3263609198382, 1113.1762495753085, 1113.5267511307661, 18016.279348826425, 18287.817121829143, 18298.817011829713, 18648.897242606607, 19018.23927042903, 33089.834550827094, 40275.0, 43080.78459607682, 44759.55240447554, 45406.0, 50398.74800625973, 57454.0, 58986.705066474395, 59099.40900590939, 60988.0, 9111.498867562348, 9204.171624553823, 9247.583858726239, 9594.760130996781, 9633.0, 13208.471661133448, 13573.728525429238, 13589.932050339685, 13857.792133118213, 13865.584032479042, 11416.315021098428, 12128.818067729168, 12258.877411225774, 12261.938690306491, 12392.442340094538, 11152.0, 11707.941460292644, 11748.882511175121, 11782.469788859693, 11862.288262704265, 12117.575884843987, 12571.30857802793, 12583.685407864876, 12708.110432269652, 12769.8084528734, 8278.379121565786, 8647.610857511301, 8786.516741579018, 8871.512066836385, 8941.642334306554, 8960.507172105597, 11917.0, 12136.271823690608, 12525.812112818132, 12620.55828046014], "value": 9590.13920158705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.7075690997167, 1591.7453207486801, 1746.9301227950882, 1811.3026484803347, 1868.1593283022635, 8527.530985795778, 8838.29293656506, 9247.167754902057, 9983.600655973762, 9994.400335979837, 9017.504037277948, 9458.243340532757, 9515.381500202482, 9765.365251258663, 9778.11996920277, 2553.4637726077544, 2582.535143674138, 2583.573710337792, 2583.837273227046, 2584.2247325802277, 2222.277759728087, 2294.1740973249616, 2538.9111381101666, 2645.0610033438143, 2658.8670566471696, 2497.900083996638, 2582.586786114222, 2583.160472846323, 2587.185036713439, 2588.0, 2535.733747956466, 2546.898124075035, 2595.6236345729953, 2598.9610155847677, 2599.2462185966046, 2394.928152155438, 2400.0399840063938, 2410.4937963027787, 2470.1354525915967, 2470.8270421070533, 9507.144357007834, 9608.519574021271, 9611.51942402884, 9626.903730962671, 9691.51542422876, 5681.0910254359105, 5836.620619659751, 5836.649801011953, 5839.328477225131, 5846.0, 3678.9580094085027, 3755.5681096673957, 3842.1931394407206, 3861.4014827701753, 3875.786831724254, 1115.358668765463, 1167.0838391862433, 1187.2283016039557, 1190.5951976328004, 1194.814803705427, 12906.290154041524, 13229.536966206233, 13339.666508337272, 13679.931600341935, 13809.585712428643, 4969.304297398367, 4969.378827646544, 4983.401991761012, 5017.247412888096, 5144.331236939174, 10652.041316281571, 10667.306625069501, 10671.306365086244, 10681.679549613524, 10696.572137114585, 5708.343540492813, 5712.057510510802, 5720.77116915327, 5721.342045664718, 5721.542276617861, 5220.895582088413, 5333.386660534011, 5349.1976203569775, 5349.411564727877, 5379.973100134474, 3876.1278712290073, 3910.804459777, 3968.8412463501136, 3991.5210174779213, 3998.3602623580086, 1120.4229821641861, 1136.3068528197794, 1144.2219290882113, 1149.9195056346143, 1238.8946939510063, 928.2666693312208, 935.5883411299006, 957.9616815327448, 988.2736188901152, 990.0841721407669, 6075.665838378844, 6271.122042913996, 6373.7131829066875, 6583.3416658334745, 6592.274849766522, 985.5614251657944, 1020.2807021050141, 1028.8148133336072, 1033.379972016799, 1044.8276034454382, 4208.242516347087, 4210.126493710331, 4256.616904478612, 4284.635805956466, 4369.825206991748, 11770.646880593426, 12078.69803254908, 12145.210561313486, 12192.024638028937, 12227.572034978733, 12072.879271207352, 12146.696332591579, 12149.453274602663, 12168.756624867454, 12195.146339756131, 8529.82940341202, 8813.735587932373, 8911.688090916787, 8997.235235005099, 9006.144416280444, 6264.906026409699, 6507.934920650922, 6557.817978960813, 6590.242122155822, 6708.329167083252, 11219.382933938712, 11227.438628068401, 11227.71930701739, 11324.547018119183, 11468.541258349573, 10996.28524145928, 11624.825627615422, 11676.474558645052, 11679.591214307458, 11683.474243659226, 8643.697470588499, 8788.42875213109, 8806.0, 8817.338699597683, 8819.206271435602, 9208.0, 9378.484183369706, 9382.859257111286, 9386.43681379092, 9460.148586626961, 8246.83506329858, 8451.788705282172, 8477.576121194039, 8504.574771261288, 8533.701320453754, 8004.199580041949, 8200.671973121009, 8266.256036956704, 8323.751437284214, 8338.541380224146, 7758.61206939662, 7809.648565814666, 7831.647575858986, 7833.5691536966015, 7848.960755196187, 5473.233747275464, 5578.135389014709, 5638.5489160867855, 5656.462636049569, 5681.176229446624, 5373.516383525502, 5462.8361149165585, 5481.068218402801, 5485.807996720096, 5548.306461692288], "value": 5010.184184143168, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.157814931567, 354.7091385064248, 355.9377109005923, 356.28209158545525, 368.959414464409, 5458.631175312142, 5580.91628625571, 5636.182753500745, 5646.548276137909, 5652.4630160134775, 5466.617336786427, 5502.5597952163835, 5504.311961004874, 5524.8342549723475, 5525.364583072947, 4211.452511173543, 4384.320430333296, 4388.42950416447, 4399.494058183318, 4403.361512580674, 4330.913381732379, 4332.263515202423, 4337.891552711176, 4338.0, 4341.6309613682715, 4280.208161490119, 4303.0, 4342.934855977162, 4344.239758042346, 4351.65186785058, 4371.3661519079715, 4372.978135109336, 4384.364267181241, 4387.824487020499, 4390.604845563883, 3678.8528458861615, 3827.0432391902023, 3838.1556057667267, 3840.711946604016, 3852.595477474853, 5436.673799572039, 5442.428545002757, 5447.972760136174, 5468.6171967962255, 5501.944980550184, 5011.6241281904, 5012.370979431663, 5016.849494515134, 5018.874528136789, 5020.497950204986, 5614.9438505615235, 5736.56975726818, 5738.368779434259, 5755.769769209269, 5770.7691692332255, 4207.305794543897, 4219.936700949488, 4242.172776308621, 4242.893927651802, 4244.405783190356, 5325.520703136736, 5773.971130144364, 6064.514838812885, 6100.72546735398, 6109.77804439114, 4185.581441855851, 4283.400323954649, 4299.581138224378, 4302.827886884552, 4320.200762858881, 4363.149185908781, 4366.847160349373, 4367.558705627135, 4371.978140109342, 4379.496357918816, 4704.071330754375, 4836.685615434985, 4860.9062960834235, 4969.503049695001, 4976.601871850244, 5763.6541807491685, 5763.884722305615, 5765.394633563499, 5769.74036168365, 5779.711014449261, 1521.2621878388973, 1541.175471122944, 1545.188775892643, 1558.1430213382594, 1561.8672412844808, 994.3089552760762, 999.9700008999741, 1005.9638572270572, 1047.533847437898, 1055.4089709762557, 5416.160495123262, 5432.212329212242, 5454.290942177491, 5458.372287187024, 5459.617826752169, 5843.0, 5886.087656413263, 5886.470217680344, 5899.970500147558, 5913.704314784243, 5337.599680024014, 5501.862453438616, 5527.0, 5553.77784888608, 5554.305711786027, 3129.3101725068664, 3151.558781770554, 3156.4949608062598, 3158.7630927680516, 3159.9052028439182, 5771.682557459296, 6008.24896887889, 6093.512518998469, 6104.847378815565, 6119.44924956756, 5786.392428795, 5940.881182376328, 5959.463648271676, 5992.610480318765, 6037.154798328237, 5935.703214839241, 6008.8197354078575, 6044.939550604526, 6122.969385153046, 6155.446009859134, 5935.703214839327, 5937.664025594207, 5953.821385358447, 5990.6705131218205, 6003.549733769897, 5622.578306626938, 5867.501262392744, 5885.057471264367, 5934.943504095308, 5972.313183983723, 6193.947029004989, 6200.472959798468, 6204.565680402328, 6237.7193026314835, 6262.405071518198, 4153.709240353146, 4329.913401731885, 4343.69594128408, 4355.520892701737, 4382.693211475166, 5897.9115313271195, 5929.940700593112, 5975.89253588123, 5994.970025149846, 6000.399960003964, 5799.3040835100055, 5806.883862322815, 5835.490738982278, 5852.619579727304, 5867.6772777497645, 5623.606347555796, 5805.113338165029, 5820.214271073351, 5841.970790146022, 5884.676342801187, 5777.942220577908, 5784.421557844182, 5788.077021104484, 5793.15999180125, 5800.390958949419, 5667.376588575171, 5866.0, 5867.794627188028, 5871.559633027455, 5899.67551784656, 5675.587875152961, 5710.600257981901, 5713.314402271754, 5717.456841600041, 5717.799877004451], "value": 4445.606000272115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.781435105346, 811.6023148657156, 845.0324378586521, 882.1663527966073, 910.490125529703, 15301.2349382531, 15476.380944762224, 15745.448909288192, 15863.444779432722, 15898.284577194025, 16093.275802588882, 16212.432564860232, 16232.431864884731, 16233.83766162338, 16915.238814253356, 872.2106493623265, 905.4024343933006, 907.9591418386188, 908.5684299957534, 908.6547112097394, 728.238990255182, 746.9626518674045, 869.9043105258417, 892.901780804111, 898.4564338575166, 940.4592359393342, 942.1520631431698, 943.4669411782321, 943.5188054092393, 943.5423819447562, 758.3743411685326, 935.7988032572996, 937.1284705224139, 938.174406522256, 938.258775567301, 567.7473524281696, 668.9397954184099, 681.5161235522735, 683.135833171039, 687.9518433709642, 16238.350465981346, 16239.91880040604, 16243.431479898147, 16272.349106035745, 16273.104979226138, 14969.0, 15452.227388630523, 15540.0, 15792.447264345808, 16013.759793603105, 13287.601371958857, 13517.188968661912, 13614.0, 13794.517191898236, 14267.0, 4700.871790770225, 4764.737939413331, 4772.537118357932, 4820.951790482085, 4945.381827271591, 87570.12429875747, 87814.0, 89092.5545372269, 89129.0, 89566.55216723874, 11956.608280254743, 12154.696132596755, 12422.130450868352, 12481.188722732993, 12488.188267762567, 22567.88716056442, 22576.887115564645, 22587.322380328616, 22598.435039124153, 22603.886980564992, 9178.724638260863, 9260.768480788034, 9657.613695452103, 9706.272029597809, 9833.0, 5208.869778255498, 5232.843014709565, 5290.523852853262, 5296.311479507716, 5523.944760552424, 3930.3907894275862, 4113.115680128787, 4119.382092686121, 4120.855770048034, 4144.979275103605, 701.5194591704699, 713.6289129652655, 714.2000958926036, 718.60476737794, 718.6191318601045, 705.2172088981226, 739.548875186136, 778.9746658687368, 825.1500954017372, 843.1315744782884, 10639.10563176238, 10984.286021408583, 11203.831942520868, 11479.25384849982, 11485.540578376938, 652.0579343595058, 674.1606699658956, 683.7846078485261, 726.0706295941098, 731.5537522111508, 5286.577073834084, 5468.535174510132, 5475.780968761284, 5491.258680078138, 5496.532794712414, 73936.26063739293, 75296.62351688207, 95108.0, 130399.34800325938, 140982.2950885239, 110663.0, 117034.0, 118263.40868295604, 119468.0, 123153.38423308005, 97136.90007082756, 102321.48839255756, 102779.0, 103872.0, 104143.4792826031, 10290.948545257226, 10313.1233845124, 10419.374837509773, 10456.947715261374, 10468.790624187626, 57725.422745772004, 58174.4182558169, 58295.0, 58870.70564647149, 58917.410825892905, 79736.60131699537, 86690.0, 86854.56572717096, 88547.0, 88711.0, 13328.666783330107, 13521.526746563823, 14023.719525609635, 14038.298085095908, 14257.64355891111, 15451.768223476432, 15951.361945522513, 16226.67546649084, 16750.66498670044, 16825.158742063093, 15705.921470392575, 15816.60458488547, 15846.207689615703, 16854.241559129623, 17003.659926801643, 14812.703745925237, 14843.92578037103, 15092.849071509145, 15284.694306114037, 15780.92109539445, 14162.98955450876, 14513.709725805636, 14905.25473726331, 15030.774538382151, 15070.397184112513, 12002.579909703118, 12078.154529182873, 12481.625551233477, 12528.686782830502, 12958.870411295766, 12310.692232694255, 12357.876421236033, 12372.477529682748, 12405.0, 12721.93639031799], "value": 8343.092808860029, "unit": "score"}], "name": "dromaeo_css", "value": 7597.304743315752, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 109.0, 111.0, 111.0, 111.0, 110.0, 109.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 122.0, 166.0, 121.0, 118.0, 116.0, 116.0, 149.0, 118.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 164.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 115.0, 75.0, 75.0, 75.0, 75.0, 106.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 119.0, 82.0, 82.0, 81.0, 111.0, 81.0, 81.0, 110.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 145.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 49.0, 51.0, 55.0, 49.0, 50.0, 49.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 78.0, 73.0, 78.0, 73.0, 81.0, 73.0, 72.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 141.0, 124.0, 139.0, 135.0, 121.0, 120.0, 126.0, 163.0, 118.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 154.0, 157.0, 161.0, 158.0, 153.0, 158.0, 154.0, 153.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 61.0, 65.0, 66.0, 62.0, 61.0, 61.0, 60.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1466.9, "alertThreshold": 2.0}]} 04:15:35 INFO - Return code: 0 04:15:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:15:35 INFO - # TBPL SUCCESS # 04:15:35 INFO - Running post-action listener: _resource_record_post_action 04:15:35 INFO - [mozharness: 2016-11-10 12:15:35.845069Z] Finished run-tests step (success) 04:15:35 INFO - Running post-run listener: _resource_record_post_run 04:15:35 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 369696768; Read time: 20; Write time: 253748 04:15:35 INFO - TinderboxPrint: CPU usage
12.9% 04:15:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 04:15:35 INFO - TinderboxPrint: I/O write bytes / time
369,696,768 / 253,748 04:15:35 INFO - TinderboxPrint: CPU idle
8,269.4 (87.1%) 04:15:35 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 04:15:35 INFO - TinderboxPrint: Swap in / out
0 / 0 04:15:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118767616; Read time: 0; Write time: 75916 04:15:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249778176; Read time: 12; Write time: 177784 04:15:36 INFO - Running post-run listener: _upload_blobber_files 04:15:36 INFO - Blob upload gear active. 04:15:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:15:36 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 04:15:36 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'] 04:15:36 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 04:15:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:15:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:37 INFO - (blobuploader) - INFO - Done attempting. 04:15:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:15:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:38 INFO - (blobuploader) - INFO - Done attempting. 04:15:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:41 INFO - (blobuploader) - INFO - Done attempting. 04:15:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:15:41 INFO - Return code: 0 04:15:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:15:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:15:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0ac385a937beda13440408064696b924fd6103981ca022a3ac4452fcbe51f984e5c541d34e55e1cef23350630e48d0141c2cf069d997e81273e562766d8757a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e491247768bf673e95894d74dc3e59662de3a391f52b1b7486d4b955591992cfa0b729653bb272ea8e9a10d57c6a3d4f1828837d2a12280475be39c6c68dd78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa417ffb0b6ee927922784cfcc7234642f5e7b63f2340956b90b0b9bdb6db45e928e6ef4a61558181dd84fd27750bbe03612864cc88b0f2959cc43cb683c534f"} 04:15:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:15:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:15:41 INFO - Contents: 04:15:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0ac385a937beda13440408064696b924fd6103981ca022a3ac4452fcbe51f984e5c541d34e55e1cef23350630e48d0141c2cf069d997e81273e562766d8757a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e491247768bf673e95894d74dc3e59662de3a391f52b1b7486d4b955591992cfa0b729653bb272ea8e9a10d57c6a3d4f1828837d2a12280475be39c6c68dd78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa417ffb0b6ee927922784cfcc7234642f5e7b63f2340956b90b0b9bdb6db45e928e6ef4a61558181dd84fd27750bbe03612864cc88b0f2959cc43cb683c534f"} 04:15:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:15:41 INFO - Copying logs to upload dir... 04:15:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:15:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.087993 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-10 04:15:41.526377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 04:15:41.530086) ========= 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=652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701 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/d0ac385a937beda13440408064696b924fd6103981ca022a3ac4452fcbe51f984e5c541d34e55e1cef23350630e48d0141c2cf069d997e81273e562766d8757a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e491247768bf673e95894d74dc3e59662de3a391f52b1b7486d4b955591992cfa0b729653bb272ea8e9a10d57c6a3d4f1828837d2a12280475be39c6c68dd78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa417ffb0b6ee927922784cfcc7234642f5e7b63f2340956b90b0b9bdb6db45e928e6ef4a61558181dd84fd27750bbe03612864cc88b0f2959cc43cb683c534f"} build_url:https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/JLFA9B6pTdGC03SJv7YAcw/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/d0ac385a937beda13440408064696b924fd6103981ca022a3ac4452fcbe51f984e5c541d34e55e1cef23350630e48d0141c2cf069d997e81273e562766d8757a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e491247768bf673e95894d74dc3e59662de3a391f52b1b7486d4b955591992cfa0b729653bb272ea8e9a10d57c6a3d4f1828837d2a12280475be39c6c68dd78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa417ffb0b6ee927922784cfcc7234642f5e7b63f2340956b90b0b9bdb6db45e928e6ef4a61558181dd84fd27750bbe03612864cc88b0f2959cc43cb683c534f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 04:15:41.559457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 04:15:41.560055) ========= 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=652eb03db935cfc1c15ebda0000001ad-1478778372.649980-1814172701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 04:15:41.643550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 04:15:41.644310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 04:15:41.645008) ========= ========= Total master_lag: 0.18 =========