builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1480168237.72 results: success (0) buildid: 20161126030519 builduid: 8e253127568746dfbe2e6b6c2d69a4ec revision: f5a6b2d38e89f33f43dd222726ec31eaef30656b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:37.721108) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:37.721824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:37.722116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:37.738071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:37.738339) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 05:50:38-- 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% 40.5M=0s 2016-11-26 05:50:38 (40.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.098879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.099222) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017220 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.148144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.148476) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f5a6b2d38e89f33f43dd222726ec31eaef30656b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f5a6b2d38e89f33f43dd222726ec31eaef30656b --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=31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 05:50:38,900 truncating revision to first 12 chars 2016-11-26 05:50:38,900 Setting DEBUG logging. 2016-11-26 05:50:38,900 attempt 1/10 2016-11-26 05:50:38,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f5a6b2d38e89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 05:50:39,225 unpacking tar archive at: mozilla-beta-f5a6b2d38e89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674624 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.837364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.837878) ========= script_repo_revision: f5a6b2d38e89f33f43dd222726ec31eaef30656b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.838328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.838622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 05:50:38.849187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-11-26 05:50:38.849706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:39 INFO - MultiFileLogger online at 20161126 05:50:39 in /builds/slave/test 05:50:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:50:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:39 INFO - {'append_to_log': False, 05:50:39 INFO - 'base_work_dir': '/builds/slave/test', 05:50:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:50:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:39 INFO - 'branch': 'Mozilla-Beta', 05:50:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:39 INFO - 'config_files': ('talos/linux_config.py',), 05:50:39 INFO - 'default_actions': ('clobber', 05:50:39 INFO - 'read-buildbot-config', 05:50:39 INFO - 'download-and-extract', 05:50:39 INFO - 'populate-webroot', 05:50:39 INFO - 'create-virtualenv', 05:50:39 INFO - 'install', 05:50:39 INFO - 'run-tests'), 05:50:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:39 INFO - 'download_minidump_stackwalk': True, 05:50:39 INFO - 'download_symbols': 'ondemand', 05:50:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:39 INFO - 'installer_path': 'installer.exe', 05:50:39 INFO - 'log_level': 'info', 05:50:39 INFO - 'log_name': 'talos', 05:50:39 INFO - 'log_to_console': True, 05:50:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:39 INFO - 'opt_config_files': (), 05:50:39 INFO - 'pip_index': False, 05:50:39 INFO - 'sps_profile': False, 05:50:39 INFO - 'sps_profile_interval': 0, 05:50:39 INFO - 'suite': 'dromaeojs', 05:50:39 INFO - 'system_bits': '32', 05:50:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:39 INFO - 'title': 'talos-linux64-ix-014', 05:50:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:39 INFO - 'use_talos_json': True, 05:50:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:39 INFO - 'work_dir': 'build'} 05:50:39 INFO - [mozharness: 2016-11-26 13:50:39.695142Z] Running clobber step. 05:50:39 INFO - Running pre-action listener: _resource_record_pre_action 05:50:39 INFO - Running main action method: clobber 05:50:39 INFO - rmtree: /builds/slave/test/build 05:50:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:40 INFO - Running post-action listener: _resource_record_post_action 05:50:40 INFO - [mozharness: 2016-11-26 13:50:40.159763Z] Finished clobber step (success) 05:50:40 INFO - [mozharness: 2016-11-26 13:50:40.159863Z] Running read-buildbot-config step. 05:50:40 INFO - Running pre-action listener: _resource_record_pre_action 05:50:40 INFO - Running main action method: read_buildbot_config 05:50:40 INFO - Using buildbot properties: 05:50:40 INFO - { 05:50:40 INFO - "project": "", 05:50:40 INFO - "product": "firefox", 05:50:40 INFO - "script_repo_revision": "production", 05:50:40 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:50:40 INFO - "repository": "", 05:50:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:50:40 INFO - "buildid": "20161126030519", 05:50:40 INFO - "pgo_build": "True", 05:50:40 INFO - "basedir": "/builds/slave/test", 05:50:40 INFO - "buildnumber": 478, 05:50:40 INFO - "slavename": "talos-linux64-ix-014", 05:50:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:50:40 INFO - "platform": "ubuntu64_hw", 05:50:40 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:50:40 INFO - "branch": "mozilla-beta", 05:50:40 INFO - "repo_path": "releases/mozilla-beta", 05:50:40 INFO - "revision": "f5a6b2d38e89f33f43dd222726ec31eaef30656b", 05:50:40 INFO - "stage_platform": "linux64-pgo", 05:50:40 INFO - "builduid": "8e253127568746dfbe2e6b6c2d69a4ec", 05:50:40 INFO - "slavebuilddir": "test" 05:50:40 INFO - } 05:50:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 05:50:40 INFO - Running post-action listener: _resource_record_post_action 05:50:40 INFO - [mozharness: 2016-11-26 13:50:40.162356Z] Finished read-buildbot-config step (success) 05:50:40 INFO - [mozharness: 2016-11-26 13:50:40.162445Z] Running download-and-extract step. 05:50:40 INFO - Running pre-action listener: _resource_record_pre_action 05:50:40 INFO - Running main action method: download_and_extract 05:50:40 INFO - mkdir: /builds/slave/test/build/tests 05:50: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')]} 05:50:40 INFO - trying https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:50:40 INFO - Downloading https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:50:40 INFO - Downloaded 1327 bytes. 05:50:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 05:50:40 INFO - Using the following test package requirements: 05:50:40 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 05:50:40 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:40 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 05:50:40 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'jsshell-linux-x86_64.zip'], 05:50:40 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:40 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 05:50:40 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 05:50:40 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 05:50:40 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:40 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 05:50:40 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:40 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 05:50:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:40 INFO - Fetch https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 05:50:41 INFO - Expected file size: 21964019 05:50:45 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 05:50:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:45 INFO - Fetch https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 05:50:46 INFO - Expected file size: 21964019 05:50:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 05:50:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:50 INFO - Fetch https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 05:50:51 INFO - Expected file size: 14414089 05:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:51 INFO - trying https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:50:51 INFO - Downloading https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:50:52 INFO - Downloaded 56970064 bytes. 05:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:50:52 INFO - mkdir: /builds/slave/test/properties 05:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:52 INFO - Contents: 05:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 05:50:53 INFO - Running post-action listener: _resource_record_post_action 05:50:53 INFO - Running post-action listener: set_extra_try_arguments 05:50:53 INFO - [mozharness: 2016-11-26 13:50:53.579022Z] Finished download-and-extract step (success) 05:50:53 INFO - [mozharness: 2016-11-26 13:50:53.579325Z] Running populate-webroot step. 05:50:53 INFO - Running pre-action listener: _resource_record_pre_action 05:50:53 INFO - Running main action method: populate_webroot 05:50:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:53 INFO - '--tppagecycles', 05:50:53 INFO - '7'], 05:50:53 INFO - 'tests': ['tsvgm']}}, 05:50:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['damp', 'tps']}, 05:50:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'tests': ['damp', 'tps']}, 05:50:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['dromaeo_dom']}, 05:50:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['basic_compositor_video']}, 05:50:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['a11yr', 05:50:53 INFO - 'ts_paint', 05:50:53 INFO - 'tpaint', 05:50:53 INFO - 'sessionrestore', 05:50:53 INFO - 'sessionrestore_no_auto_restore', 05:50:53 INFO - 'tabpaint']}, 05:50:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:53 INFO - 'ts_paint', 05:50:53 INFO - 'tpaint', 05:50:53 INFO - 'sessionrestore', 05:50:53 INFO - 'sessionrestore_no_auto_restore', 05:50:53 INFO - 'tabpaint']}, 05:50:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:53 INFO - 'ts_paint', 05:50:53 INFO - 'tpaint', 05:50:53 INFO - 'sessionrestore', 05:50:53 INFO - 'sessionrestore_no_auto_restore', 05:50:53 INFO - 'tabpaint']}, 05:50:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:53 INFO - 'ts_paint', 05:50:53 INFO - 'tpaint', 05:50:53 INFO - 'sessionrestore', 05:50:53 INFO - 'sessionrestore_no_auto_restore', 05:50:53 INFO - 'tabpaint']}, 05:50:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['a11yr', 05:50:53 INFO - 'ts_paint', 05:50:53 INFO - 'tpaint', 05:50:53 INFO - 'sessionrestore', 05:50:53 INFO - 'sessionrestore_no_auto_restore', 05:50:53 INFO - 'tabpaint']}, 05:50:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['a11yr', 05:50:53 INFO - 'ts_paint', 05:50:53 INFO - 'tpaint', 05:50:53 INFO - 'sessionrestore', 05:50:53 INFO - 'sessionrestore_no_auto_restore', 05:50:53 INFO - 'tabpaint']}, 05:50:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['tsvgx', 05:50:53 INFO - 'tsvgr_opacity', 05:50:53 INFO - 'tart', 05:50:53 INFO - 'tscrollx', 05:50:53 INFO - 'cart']}, 05:50:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:53 INFO - 'tsvgr_opacity', 05:50:53 INFO - 'tart', 05:50:53 INFO - 'tscrollx', 05:50:53 INFO - 'cart']}, 05:50:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'talos_options': ['--disable-e10s'], 05:50:53 INFO - 'tests': ['tp5o']}, 05:50:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'tests': ['tp5o']}, 05:50:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'talos_options': ['--disable-e10s', 05:50:53 INFO - '--xperf_path', 05:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:53 INFO - 'tests': ['tp5n']}, 05:50:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:53 INFO - 'talos_options': ['--xperf_path', 05:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:53 INFO - 'tests': ['tp5n']}}, 05:50:53 INFO - 'talos.zip': {'path': '', 05:50:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:53 INFO - Running post-action listener: _resource_record_post_action 05:50:53 INFO - [mozharness: 2016-11-26 13:50:53.599950Z] Finished populate-webroot step (success) 05:50:53 INFO - [mozharness: 2016-11-26 13:50:53.600067Z] Running create-virtualenv step. 05:50:53 INFO - Running pre-action listener: _resource_record_pre_action 05:50:53 INFO - Running main action method: create_virtualenv 05:50:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:53 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 05:50:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:53 INFO - Using real prefix '/usr' 05:50:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:56 INFO - Installing pip.................done. 05:50:56 INFO - Return code: 0 05:50:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:50:56 INFO - Using env: {'DISPLAY': ':0', 05:50:56 INFO - 'HOME': '/home/cltbld', 05:50:56 INFO - 'LANG': 'en_US.UTF-8', 05:50:56 INFO - 'LANGUAGE': 'en_US:en', 05:50:56 INFO - 'LOGNAME': 'cltbld', 05:50:56 INFO - 'MAIL': '/var/mail/cltbld', 05:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:56 INFO - 'MOZ_NO_REMOTE': '1', 05:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:56 INFO - 'NO_EM_RESTART': '1', 05:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:56 INFO - 'PWD': '/builds/slave/test', 05:50:56 INFO - 'SHELL': '/bin/bash', 05:50:56 INFO - 'SHLVL': '1', 05:50:56 INFO - 'TERM': 'linux', 05:50:56 INFO - 'TMOUT': '86400', 05:50:56 INFO - 'USER': 'cltbld', 05:50:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:56 INFO - '_': '/tools/buildbot/bin/python'} 05:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:56 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 05:50:56 INFO - Cleaning up... 05:50:56 INFO - Return code: 0 05:50:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:50:56 INFO - Using env: {'DISPLAY': ':0', 05:50:56 INFO - 'HOME': '/home/cltbld', 05:50:56 INFO - 'LANG': 'en_US.UTF-8', 05:50:56 INFO - 'LANGUAGE': 'en_US:en', 05:50:56 INFO - 'LOGNAME': 'cltbld', 05:50:56 INFO - 'MAIL': '/var/mail/cltbld', 05:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:56 INFO - 'MOZ_NO_REMOTE': '1', 05:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:56 INFO - 'NO_EM_RESTART': '1', 05:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:56 INFO - 'PWD': '/builds/slave/test', 05:50:56 INFO - 'SHELL': '/bin/bash', 05:50:56 INFO - 'SHLVL': '1', 05:50:56 INFO - 'TERM': 'linux', 05:50:56 INFO - 'TMOUT': '86400', 05:50:56 INFO - 'USER': 'cltbld', 05:50:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:56 INFO - '_': '/tools/buildbot/bin/python'} 05:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:56 INFO - Downloading/unpacking psutil>=3.1.1 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:58 INFO - Installing collected packages: psutil 05:50:58 INFO - Running setup.py install for psutil 05:50:58 INFO - building 'psutil._psutil_linux' extension 05:50:58 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 05:50:58 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 05:50:58 INFO - building 'psutil._psutil_posix' extension 05:50:58 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 05:50:59 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 05:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:59 INFO - Successfully installed psutil 05:50:59 INFO - Cleaning up... 05:50:59 INFO - Return code: 0 05:50:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:50:59 INFO - Using env: {'DISPLAY': ':0', 05:50:59 INFO - 'HOME': '/home/cltbld', 05:50:59 INFO - 'LANG': 'en_US.UTF-8', 05:50:59 INFO - 'LANGUAGE': 'en_US:en', 05:50:59 INFO - 'LOGNAME': 'cltbld', 05:50:59 INFO - 'MAIL': '/var/mail/cltbld', 05:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:59 INFO - 'MOZ_NO_REMOTE': '1', 05:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:59 INFO - 'NO_EM_RESTART': '1', 05:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:59 INFO - 'PWD': '/builds/slave/test', 05:50:59 INFO - 'SHELL': '/bin/bash', 05:50:59 INFO - 'SHLVL': '1', 05:50:59 INFO - 'TERM': 'linux', 05:50:59 INFO - 'TMOUT': '86400', 05:50:59 INFO - 'USER': 'cltbld', 05:50:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:59 INFO - '_': '/tools/buildbot/bin/python'} 05:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:01 INFO - Installing collected packages: mozsystemmonitor 05:51:01 INFO - Running setup.py install for mozsystemmonitor 05:51:01 INFO - Successfully installed mozsystemmonitor 05:51:01 INFO - Cleaning up... 05:51:01 INFO - Return code: 0 05:51:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:01 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:01 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 05:51:01 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 05:51:01 INFO - Using env: {'DISPLAY': ':0', 05:51:01 INFO - 'HOME': '/home/cltbld', 05:51:01 INFO - 'LANG': 'en_US.UTF-8', 05:51:01 INFO - 'LANGUAGE': 'en_US:en', 05:51:01 INFO - 'LOGNAME': 'cltbld', 05:51:01 INFO - 'MAIL': '/var/mail/cltbld', 05:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:01 INFO - 'MOZ_NO_REMOTE': '1', 05:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:01 INFO - 'NO_EM_RESTART': '1', 05:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:01 INFO - 'PWD': '/builds/slave/test', 05:51:01 INFO - 'SHELL': '/bin/bash', 05:51:01 INFO - 'SHLVL': '1', 05:51:01 INFO - 'TERM': 'linux', 05:51:01 INFO - 'TMOUT': '86400', 05:51:01 INFO - 'USER': 'cltbld', 05:51:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:01 INFO - '_': '/tools/buildbot/bin/python'} 05:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:01 INFO - Downloading/unpacking jsonschema==2.5.1 05:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:04 INFO - warning: no files found matching '*.txt' 05:51:04 INFO - no previously-included directories found matching 'build' 05:51:04 INFO - no previously-included directories found matching 'dist' 05:51:04 INFO - no previously-included directories found matching '.git*' 05:51:04 INFO - Installing collected packages: jsonschema, functools32 05:51:04 INFO - Running setup.py install for functools32 05:51:04 INFO - warning: no files found matching '*.txt' 05:51:04 INFO - no previously-included directories found matching 'build' 05:51:04 INFO - no previously-included directories found matching 'dist' 05:51:04 INFO - no previously-included directories found matching '.git*' 05:51:04 INFO - Successfully installed jsonschema functools32 05:51:04 INFO - Cleaning up... 05:51:04 INFO - Return code: 0 05:51:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:51:04 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')]} 05:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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')]} 05:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:04 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 05:51:04 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 05:51:04 INFO - Using env: {'DISPLAY': ':0', 05:51:04 INFO - 'HOME': '/home/cltbld', 05:51:04 INFO - 'LANG': 'en_US.UTF-8', 05:51:04 INFO - 'LANGUAGE': 'en_US:en', 05:51:04 INFO - 'LOGNAME': 'cltbld', 05:51:04 INFO - 'MAIL': '/var/mail/cltbld', 05:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:04 INFO - 'MOZ_NO_REMOTE': '1', 05:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:04 INFO - 'NO_EM_RESTART': '1', 05:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:04 INFO - 'PWD': '/builds/slave/test', 05:51:04 INFO - 'SHELL': '/bin/bash', 05:51:04 INFO - 'SHLVL': '1', 05:51:04 INFO - 'TERM': 'linux', 05:51:04 INFO - 'TMOUT': '86400', 05:51:04 INFO - 'USER': 'cltbld', 05:51:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:04 INFO - '_': '/tools/buildbot/bin/python'} 05:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:51:04 INFO - Cleaning up... 05:51:04 INFO - Return code: 0 05:51:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:04 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')]} 05:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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')]} 05:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:04 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 05:51:04 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 05:51:04 INFO - Using env: {'DISPLAY': ':0', 05:51:04 INFO - 'HOME': '/home/cltbld', 05:51:04 INFO - 'LANG': 'en_US.UTF-8', 05:51:04 INFO - 'LANGUAGE': 'en_US:en', 05:51:04 INFO - 'LOGNAME': 'cltbld', 05:51:04 INFO - 'MAIL': '/var/mail/cltbld', 05:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:04 INFO - 'MOZ_NO_REMOTE': '1', 05:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:04 INFO - 'NO_EM_RESTART': '1', 05:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:04 INFO - 'PWD': '/builds/slave/test', 05:51:04 INFO - 'SHELL': '/bin/bash', 05:51:04 INFO - 'SHLVL': '1', 05:51:04 INFO - 'TERM': 'linux', 05:51:04 INFO - 'TMOUT': '86400', 05:51:04 INFO - 'USER': 'cltbld', 05:51:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:04 INFO - '_': '/tools/buildbot/bin/python'} 05:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:04 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 05:51:04 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 05:51:04 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 05:51:04 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 05:51:04 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 05:51:04 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 05:51:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:07 INFO - Downloading docopt-0.6.1.tar.gz 05:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:07 INFO - Running setup.py install for blobuploader 05:51:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:07 INFO - Running setup.py install for requests 05:51:07 INFO - Running setup.py install for docopt 05:51:07 INFO - Successfully installed blobuploader requests docopt 05:51:07 INFO - Cleaning up... 05:51:08 INFO - Return code: 0 05:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:08 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:08 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 05:51:08 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 05:51:08 INFO - Using env: {'DISPLAY': ':0', 05:51:08 INFO - 'HOME': '/home/cltbld', 05:51:08 INFO - 'LANG': 'en_US.UTF-8', 05:51:08 INFO - 'LANGUAGE': 'en_US:en', 05:51:08 INFO - 'LOGNAME': 'cltbld', 05:51:08 INFO - 'MAIL': '/var/mail/cltbld', 05:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:08 INFO - 'MOZ_NO_REMOTE': '1', 05:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:08 INFO - 'NO_EM_RESTART': '1', 05:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:08 INFO - 'PWD': '/builds/slave/test', 05:51:08 INFO - 'SHELL': '/bin/bash', 05:51:08 INFO - 'SHLVL': '1', 05:51:08 INFO - 'TERM': 'linux', 05:51:08 INFO - 'TMOUT': '86400', 05:51:08 INFO - 'USER': 'cltbld', 05:51:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:08 INFO - '_': '/tools/buildbot/bin/python'} 05:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:08 INFO - Running setup.py (path:/tmp/pip-XjNh_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:08 INFO - Running setup.py (path:/tmp/pip-K4jxCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:08 INFO - Running setup.py (path:/tmp/pip-KEg1fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:08 INFO - Running setup.py (path:/tmp/pip-aaba2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:08 INFO - Running setup.py (path:/tmp/pip-2QZQOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:08 INFO - Running setup.py (path:/tmp/pip-WbaGBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:08 INFO - Running setup.py (path:/tmp/pip-s5LMGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:08 INFO - Running setup.py (path:/tmp/pip-EqZMi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:08 INFO - Running setup.py (path:/tmp/pip-jmTKqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:08 INFO - Running setup.py (path:/tmp/pip-BnPaHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:08 INFO - Running setup.py (path:/tmp/pip-kN8TeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:09 INFO - Running setup.py (path:/tmp/pip-Bq2Ddd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:09 INFO - Running setup.py (path:/tmp/pip-7ljbnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:09 INFO - Running setup.py (path:/tmp/pip-ckBsad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:09 INFO - Running setup.py (path:/tmp/pip-ukL8lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:09 INFO - Running setup.py (path:/tmp/pip-i26KHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:09 INFO - Running setup.py (path:/tmp/pip-9ok8DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:09 INFO - Running setup.py install for manifestparser 05:51:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:09 INFO - Running setup.py install for mozcrash 05:51:09 INFO - Running setup.py install for mozdebug 05:51:09 INFO - Running setup.py install for mozdevice 05:51:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:09 INFO - Running setup.py install for mozfile 05:51:09 INFO - Running setup.py install for mozhttpd 05:51:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for mozinfo 05:51:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for mozInstall 05:51:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for mozleak 05:51:10 INFO - Running setup.py install for mozlog 05:51:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for moznetwork 05:51:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for mozprocess 05:51:10 INFO - Running setup.py install for mozprofile 05:51:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for mozrunner 05:51:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:10 INFO - Running setup.py install for mozscreenshot 05:51:11 INFO - Running setup.py install for moztest 05:51:11 INFO - Running setup.py install for mozversion 05:51:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:11 INFO - Cleaning up... 05:51:11 INFO - Return code: 0 05:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:11 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:11 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 05:51:11 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 05:51:11 INFO - Using env: {'DISPLAY': ':0', 05:51:11 INFO - 'HOME': '/home/cltbld', 05:51:11 INFO - 'LANG': 'en_US.UTF-8', 05:51:11 INFO - 'LANGUAGE': 'en_US:en', 05:51:11 INFO - 'LOGNAME': 'cltbld', 05:51:11 INFO - 'MAIL': '/var/mail/cltbld', 05:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:11 INFO - 'MOZ_NO_REMOTE': '1', 05:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:11 INFO - 'NO_EM_RESTART': '1', 05:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:11 INFO - 'PWD': '/builds/slave/test', 05:51:11 INFO - 'SHELL': '/bin/bash', 05:51:11 INFO - 'SHLVL': '1', 05:51:11 INFO - 'TERM': 'linux', 05:51:11 INFO - 'TMOUT': '86400', 05:51:11 INFO - 'USER': 'cltbld', 05:51:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:11 INFO - '_': '/tools/buildbot/bin/python'} 05:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:11 INFO - Running setup.py (path:/tmp/pip-tXzSAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:11 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)) 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:11 INFO - Running setup.py (path:/tmp/pip-vVYast-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:11 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)) 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:11 INFO - Running setup.py (path:/tmp/pip-4myfic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:11 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)) 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:11 INFO - Running setup.py (path:/tmp/pip-PakP2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:11 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)) 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:11 INFO - Running setup.py (path:/tmp/pip-MdDnpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:11 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)) 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:11 INFO - Running setup.py (path:/tmp/pip-atjwsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:11 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)) 05:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:11 INFO - Running setup.py (path:/tmp/pip-V2NHE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:12 INFO - Running setup.py (path:/tmp/pip-fqAtUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:12 INFO - Running setup.py (path:/tmp/pip-ehRft8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:12 INFO - Running setup.py (path:/tmp/pip-TiR1m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:12 INFO - Running setup.py (path:/tmp/pip-VqRYZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:12 INFO - Running setup.py (path:/tmp/pip-tHqo3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:12 INFO - Running setup.py (path:/tmp/pip-nsU9lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:12 INFO - Running setup.py (path:/tmp/pip-gbtnOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:12 INFO - Running setup.py (path:/tmp/pip-u8VjJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:12 INFO - Running setup.py (path:/tmp/pip-T6oURx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:12 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)) 05:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:12 INFO - Running setup.py (path:/tmp/pip-ZZFezQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:12 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)) 05:51:12 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)) 05:51:12 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)) 05:51:12 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)) 05:51:12 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)) 05:51:12 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)) 05:51:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:12 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 05:51:12 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 05:51:12 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 05:51:12 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 05:51:12 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 05:51:12 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 05:51:14 INFO - Downloading blessings-1.6.tar.gz 05:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:14 INFO - Installing collected packages: blessings 05:51:14 INFO - Running setup.py install for blessings 05:51:14 INFO - Successfully installed blessings 05:51:14 INFO - Cleaning up... 05:51:14 INFO - Return code: 0 05:51:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:15 INFO - Reading from file tmpfile_stdout 05:51:15 INFO - Current package versions: 05:51:15 INFO - argparse == 1.2.1 05:51:15 INFO - blessings == 1.6 05:51:15 INFO - blobuploader == 1.2.4 05:51:15 INFO - docopt == 0.6.1 05:51:15 INFO - functools32 == 3.2.3-2 05:51:15 INFO - jsonschema == 2.5.1 05:51:15 INFO - manifestparser == 1.1 05:51:15 INFO - mozInstall == 1.12 05:51:15 INFO - mozcrash == 0.17 05:51:15 INFO - mozdebug == 0.1 05:51:15 INFO - mozdevice == 0.48 05:51:15 INFO - mozfile == 1.2 05:51:15 INFO - mozhttpd == 0.7 05:51:15 INFO - mozinfo == 0.9 05:51:15 INFO - mozleak == 0.1 05:51:15 INFO - mozlog == 3.4 05:51:15 INFO - moznetwork == 0.27 05:51:15 INFO - mozprocess == 0.23 05:51:15 INFO - mozprofile == 0.28 05:51:15 INFO - mozrunner == 6.12 05:51:15 INFO - mozscreenshot == 0.1 05:51:15 INFO - mozsystemmonitor == 0.3 05:51:15 INFO - moztest == 0.7 05:51:15 INFO - mozversion == 1.4 05:51:15 INFO - psutil == 3.1.1 05:51:15 INFO - requests == 1.2.3 05:51:15 INFO - wsgiref == 0.1.2 05:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:15 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')]} 05:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:15 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')]} 05:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:15 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:15 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 05:51:15 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 05:51:15 INFO - Using env: {'DISPLAY': ':0', 05:51:15 INFO - 'HOME': '/home/cltbld', 05:51:15 INFO - 'LANG': 'en_US.UTF-8', 05:51:15 INFO - 'LANGUAGE': 'en_US:en', 05:51:15 INFO - 'LOGNAME': 'cltbld', 05:51:15 INFO - 'MAIL': '/var/mail/cltbld', 05:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:15 INFO - 'MOZ_NO_REMOTE': '1', 05:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:15 INFO - 'NO_EM_RESTART': '1', 05:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:15 INFO - 'PWD': '/builds/slave/test', 05:51:15 INFO - 'SHELL': '/bin/bash', 05:51:15 INFO - 'SHLVL': '1', 05:51:15 INFO - 'TERM': 'linux', 05:51:15 INFO - 'TMOUT': '86400', 05:51:15 INFO - 'USER': 'cltbld', 05:51:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:15 INFO - '_': '/tools/buildbot/bin/python'} 05:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 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)) 05:51:15 INFO - Cleaning up... 05:51:15 INFO - Return code: 0 05:51:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:15 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')]} 05:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:15 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')]} 05:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:15 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 0x7f21b349cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1301ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', '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 05:51:15 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 05:51:15 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 05:51:15 INFO - Using env: {'DISPLAY': ':0', 05:51:15 INFO - 'HOME': '/home/cltbld', 05:51:15 INFO - 'LANG': 'en_US.UTF-8', 05:51:15 INFO - 'LANGUAGE': 'en_US:en', 05:51:15 INFO - 'LOGNAME': 'cltbld', 05:51:15 INFO - 'MAIL': '/var/mail/cltbld', 05:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:15 INFO - 'MOZ_NO_REMOTE': '1', 05:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:15 INFO - 'NO_EM_RESTART': '1', 05:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:15 INFO - 'PWD': '/builds/slave/test', 05:51:15 INFO - 'SHELL': '/bin/bash', 05:51:15 INFO - 'SHLVL': '1', 05:51:15 INFO - 'TERM': 'linux', 05:51:15 INFO - 'TMOUT': '86400', 05:51:15 INFO - 'USER': 'cltbld', 05:51:15 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:15 INFO - '_': '/tools/buildbot/bin/python'} 05:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:15 INFO - Cleaning up... 05:51:15 INFO - Return code: 0 05:51:15 INFO - Running post-action listener: _resource_record_post_action 05:51:15 INFO - Running post-action listener: _start_resource_monitoring 05:51:15 INFO - Starting resource monitoring. 05:51:15 INFO - [mozharness: 2016-11-26 13:51:15.638368Z] Finished create-virtualenv step (success) 05:51:15 INFO - [mozharness: 2016-11-26 13:51:15.638868Z] Running install step. 05:51:15 INFO - Running pre-action listener: _resource_record_pre_action 05:51:15 INFO - Running main action method: install 05:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:15 INFO - Reading from file tmpfile_stdout 05:51:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:15 INFO - Reading from file tmpfile_stdout 05:51:15 INFO - Output received: 05:51:15 INFO - Usage: mozinstall [options] installer 05:51:15 INFO - Options: 05:51:15 INFO - -h, --help show this help message and exit 05:51:15 INFO - -d DEST, --destination=DEST 05:51:15 INFO - Directory to install application into. [default: 05:51:15 INFO - "/builds/slave/test"] 05:51:15 INFO - --app=APP Application being installed. [default: firefox] 05:51:15 INFO - mkdir: /builds/slave/test/build/application 05:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:51:29 INFO - Reading from file tmpfile_stdout 05:51:29 INFO - Output received: 05:51:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:29 INFO - Running post-action listener: _resource_record_post_action 05:51:29 INFO - [mozharness: 2016-11-26 13:51:29.449558Z] Finished install step (success) 05:51:29 INFO - [mozharness: 2016-11-26 13:51:29.449803Z] Running run-tests step. 05:51:29 INFO - Running pre-action listener: _resource_record_pre_action 05:51:29 INFO - Running main action method: run_tests 05:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:29 INFO - Python 2.7.3 05:51:29 INFO - Return code: 0 05:51:29 INFO - grabbing minidump binary from tooltool 05:51:29 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')]} 05:51:29 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 0x12fef60>, '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 0x12ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13001d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:29 INFO - Return code: 0 05:51:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 05:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 05:51:29 INFO - Using env: {'DISPLAY': ':0', 05:51:29 INFO - 'HOME': '/home/cltbld', 05:51:29 INFO - 'LANG': 'en_US.UTF-8', 05:51:29 INFO - 'LANGUAGE': 'en_US:en', 05:51:29 INFO - 'LOGNAME': 'cltbld', 05:51:29 INFO - 'MAIL': '/var/mail/cltbld', 05:51:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:29 INFO - 'MOZ_NO_REMOTE': '1', 05:51:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:29 INFO - 'NO_EM_RESTART': '1', 05:51:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:29 INFO - 'PWD': '/builds/slave/test', 05:51:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:29 INFO - 'SHELL': '/bin/bash', 05:51:29 INFO - 'SHLVL': '1', 05:51:29 INFO - 'TERM': 'linux', 05:51:29 INFO - 'TMOUT': '86400', 05:51:29 INFO - 'USER': 'cltbld', 05:51:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773', 05:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:29 INFO - '_': '/tools/buildbot/bin/python'} 05:51:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 05:51:29 INFO - mozversion application_buildid: 20161126030519 05:51:29 INFO - mozversion application_changeset: f5a6b2d38e89f33f43dd222726ec31eaef30656b 05:51:29 INFO - mozversion application_display_name: Firefox 05:51:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:29 INFO - mozversion application_name: Firefox 05:51:29 INFO - mozversion application_remotingname: firefox 05:51:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:51:29 INFO - mozversion application_vendor: Mozilla 05:51:29 INFO - mozversion application_version: 51.0 05:51:29 INFO - mozversion platform_buildid: 20161126030519 05:51:29 INFO - mozversion platform_changeset: f5a6b2d38e89f33f43dd222726ec31eaef30656b 05:51:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:51:29 INFO - mozversion platform_version: 51.0 05:51:29 INFO - using testdate: 1480168289 05:51:29 INFO - actual date: 1480168289 05:51:29 INFO - starting webserver on 'localhost:57823' 05:51:29 INFO - SUITE-START | Running 2 tests 05:51:29 INFO - TEST-START | dromaeo_css 05:51:29 INFO - operating with platform_type : linux_ 05:51:29 INFO - Initialising browser for dromaeo_css test... 05:51:29 INFO - TEST-INFO | started process 5668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpueZ5Zb/profile http://localhost:57823/getInfo.html) 05:51:33 INFO - PROCESS | 5668 | __metrics Screen width/height:1600/1200 05:51:33 INFO - PROCESS | 5668 | colorDepth:24 05:51:33 INFO - PROCESS | 5668 | Browser inner width/height: 1024/697 05:51:33 INFO - PROCESS | 5668 | __metrics 05:51:34 INFO - PROCESS | 5668 | 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" 05:51:34 INFO - PROCESS | 5668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:34 INFO - PROCESS | 5668 | console.error: PushService: 05:51:34 INFO - PROCESS | 5668 | stateChangeProcessEnqueue: Error transitioning state 05:51:34 INFO - PROCESS | 5668 | UnknownError 05:51:34 INFO - TEST-INFO | 5668: exit 0 05:51:34 INFO - Browser initialized. 05:51:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:34 INFO - TEST-INFO | started process 5760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpueZ5Zb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:46 INFO - PROCESS | 5760 | RSS: Main: 142856192 05:51:46 INFO - PROCESS | 5760 | 05:52:37 INFO - PROCESS | 5760 | 1480168357876 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] 05:54:46 INFO - PROCESS | 5760 | Cycle 1(1): loaded http://localhost:57823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57823/tests/dromaeo/cssquery-ext.html) 05:54:47 INFO - PROCESS | 5760 | RSS: Main: 237715456 05:54:47 INFO - PROCESS | 5760 | 05:57:50 INFO - PROCESS | 5760 | Cycle 1(1): loaded http://localhost:57823/tests/dromaeo/cssquery-ext.html (next: http://localhost:57823/tests/dromaeo/cssquery-jquery.html) 05:57:50 INFO - PROCESS | 5760 | RSS: Main: 234430464 05:57:50 INFO - PROCESS | 5760 | 06:00:52 INFO - PROCESS | 5760 | Cycle 1(1): loaded http://localhost:57823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57823/tests/dromaeo/cssquery-mootools.html) 06:00:53 INFO - PROCESS | 5760 | RSS: Main: 219983872 06:00:53 INFO - PROCESS | 5760 | 06:03:55 INFO - PROCESS | 5760 | Cycle 1(1): loaded http://localhost:57823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57823/tests/dromaeo/cssquery-prototype.html) 06:03:55 INFO - PROCESS | 5760 | RSS: Main: 174723072 06:03:55 INFO - PROCESS | 5760 | 06:06:58 INFO - PROCESS | 5760 | Cycle 1(1): loaded http://localhost:57823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57823/tests/dromaeo/cssquery-yui.html) 06:06:58 INFO - PROCESS | 5760 | RSS: Main: 176193536 06:06:58 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | Cycle 1(1): loaded http://localhost:57823/tests/dromaeo/cssquery-yui.html (next: http://localhost:57823/tests/dromaeo/cssquery-dojo.html) 06:10:01 INFO - PROCESS | 5760 | RSS: Main: 244531200 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | __start_tp_report 06:10:01 INFO - PROCESS | 5760 | _x_x_mozilla_page_load 06:10:01 INFO - PROCESS | 5760 | _x_x_mozilla_page_load_details 06:10:01 INFO - PROCESS | 5760 | |i|pagename|runs| 06:10:01 INFO - PROCESS | 5760 | |0;dojo.html;3121.6254049514064;3163.0827060152556;3164.47786115291;3189.075168201222;3202.6156861176646;5526.364468086172;5610.523105536035;5613.186088017235;5621.0444224481835;5645.2096706461125;5511.118221084627;5569.860753481165;5585;5590.217369568264;5591.245181900453;5072.644914855961;5073.137566613666;5101.642884998052;5103.821366252182;5145.536901678848;4943.085529177096;5102.158143906251;5160.612954028444;5162.199859021857;5185.118529849935;4925.581325587312;4999.825006124786;5024.497550244964;5042;5097.898042039157;5111.948880511184;5140.820071297505;5148.124818780816;5208;5210.374755029383;5041.773120209599;5118.2578526113875;5162.92255616166;5174.534291913708;5200.843974680765;5393.298871146765;5451.04606693827;5476.698781567012;5502.642328248691;5560;5877.324107727623;5890.882182356372;5898.321693005317;5977.342492325841;5980.162777211194;6005.039193729026;6007.7383749412675;6019.578629495937;6024.036154215349;6026.909596356014;5385.67685938841;5441.972790136064;5554.638948468377;5611.2144299798065;5618.943810561842;6140.78507252253;6171.907421388593;6181.134641150243;6181.96909015452;6189.535784816157;5938.257717785277;5939.079442686304;5940.34656187819;5942.286925568873;5944.554158438134;5708.971455142698;5757.193992841006;5930.733117009659;5955.672438015864;6007.038873780174;6014.248218972629;6021.638701677914;6023.909641355383;6027.367126451747;6043.214382130383;5988.071848863433;6040.063790112539;6040.305364883006;6048;6068.6358818471035;4423.181711383404;4459.576340247671;4507.5943165115295;4537.6143027843;4637.675362724577;4048.1296521248073;4066.207089617496;4068.959310406917;4083.673306135502;4104.0970986382945;5690.487856092972;5706.115552089433;5707.3721890592005;5713.542916566665;5720.027595308808;5749.8562535936935;5828;5908.911366329508;5960.552958528041;5969.671668058299;5656.264685590847;5722.885542289131;5732.598718089694;5757.596968212269;5762.769489220468;5175.378954525406;5185.403678577012;5185.455527169668;5193;5193.039287731782;5926.111083337534;5986.042233242834;6160.907586386208;6200.0699895016105;6224;5864.618799778001;5865.618734782225;5879.323877753942;5984.19213406202;6021;6157.291911430064;6158.107074474086;6167.290761562478;6177.84555386119;6179.876402471836;5618.943810562006;5870.207521984477;5871.7651293949475;5872.324682661549;5879.235699359056;5700.287464066992;5890.764369425175;5926.703664816828;5941.554383421174;6015.097735339734;5810.970945145247;5845.386234445492;5847.239858818326;5851.122331650116;5866.384029676822;5861.706914654335;5863.208466857091;5867.20792692981;5869.6771677556435;5876.382979787061;5518.917216241679;5524.640898341595;5743.885122297447;5747.568932330176;5805.506531944832;5873.177755114202;5873.882522349614;5880.117982302518;5887.234659494238;5892.646441213541;5498.972505137449;5698.287714035746;5706.828795136153;5708.200851880657;5712.143178523089 06:10:01 INFO - PROCESS | 5760 | |1;ext.html;595.0508938243503;616.3928530397558;636.1157990393355;639.5203597302024;644.2076246217152;33773.324533509316;36823;44517.77741111294;45323.41368052119;45424.0915181697;46691.299630505484;47172.76413617936;47186;47273;47325.05349893009;9304.162625363715;9385.483798391086;9454.716358509255;9457.10157535033;9466.432014079142;8411.663533458654;8607.569621518931;10851.891481085167;11093.3898635575;11115.388653624048;11292.830607540893;11381.658550243465;11411.258268212581;11411.31532108072;11416.257943233662;11151.498182581803;11173;11225.887741122566;11228.775424491505;11228.831567526493;10965.780684386267;11035.337879727242;11047.944760276228;11050.668479945614;11059.557617695282;44640;45130.77434612839;45142;45196.77401612971;45649.08701825945;3750.6436888495823;3754.6245375462236;3831.5019047523924;4065.6340929316502;4456.153330867157;33100.83449582761;33692.6630733692;34094.147646309044;34203.65796342029;34339;4541.227991241497;4657.301404789275;4661.95338046622;4665.4168228971375;4750.667453278272;367094;368914;370480;371020;371609.9999999973;60051.69974150101;60346.396536034954;60430.39569604248;60442.39557604368;60453.697731511944;39989.40015899764;40896.18207635831;41171;42674;42808.57191428046;18264.36074737378;18480.260789568536;18494.35269765552;18494.722579161324;18494.907525462557;11974.161808673309;14650.413983440756;14684.632884177767;14699.55901322962;14701.779473307908;17742.733858992124;19506.656108529463;20667.379978600366;20777.688334674993;20804.687929681066;7295.379892709179;7366.1528924173335;7476.663550140257;7544.321011109027;7641.350485208708;1048.3605000949415;1053.5259133390005;1111.149970272742;1173.4015652017363;1182.343799191457;33804.49293260603;34424.311513769586;34453.655463445044;34661.82669086689;34782.47826282608;1108.684025052856;1160.7388337624136;1254.7051442910908;1268.866768989243;1308.7513372459202;15409.306581203873;17690.380836670654;17784.55538611545;19029.524261893563;20034.198632054846;585399;905542.4722876475;924655;925138;927574;60284.69857650771;60902;61027;61063.08405373923;61076;1311.5868501422021;1343.657367371314;1375.3467103125936;1405.7258834527374;1417.595985144229;31083.533746994264;34393;34524.82737586296;34561.82719086489;35374.29251415009;50703.746481268834;51401.228981564556;51414.74292628513;51496.48503514917;51547;445216;445890;448361;448416;450139;26919.59620605732;27528.724712752617;30043.844387222875;31153.8442307787;32633.18417039593;48317;48639;48716;48996.51003490062;49031.26453103135;41962.79018604887;42025.369619456345;42117;43359.783201083796;43772.56227437812;41258.38112428376;42089.36865947075;42280.788596056824;42336.576634233264;43071.138577227655;44003.33994990142;44276.77861610671;44705.10589788251;45005.32492012557;45406.545934540234;37651;39340.409893852186;39410;40057.79971100126;40144.598554015254;29362.55956160702;29684.554731679473;29688.85540227785;29799.255018624706;30184.396312073197 06:10:01 INFO - PROCESS | 5760 | |2;jquery.html;403.67100812837555;411.63158972719395;412.2353035119852;415.9292920203564;420.4093248985175;18275.451736447896;18711.438656840284;19615.31346402876;20625.896870515662;20638.48403789904;19832.206711731513;20089.397318080446;20153.193872245094;20267.189312427523;20324.593508129867;5533.142362933741;6001.939980600204;6020.789272375468;6026.789062382817;6038.516918646497;5818.854528636797;5868.41315868414;5936.554758393117;6011.338752737195;6019.849503762397;5884.529237660999;5885.352611212763;5890.676012819294;5891.64650120992;5898.262717160355;5685.886282274352;5883.323417806964;5884.823455296348;5887.0286402743495;5934.28788545373;5279.340082489689;5298.761555730001;5302.363716354023;5311.840644780663;5313.734313284321;20186;23236.65145022826;23258.185963491367;23476.76523234763;23494.53010939789;2551.527967326032;2580;2582.289870285668;2727.468143711977;2960.5263157894847;7182.281771822828;7371.26287371264;14510.854891451056;14814.259287035606;14988.925055374762;1843.4746097362188;1931.159945423745;1937.1089298922514;1939.0886283446757;1945.3191383015974;52472;69158.65420672914;81065.59467202685;83425.58287208524;85726;10487.632932847313;10715.35707857531;10917.890821091847;11089.112870970303;11194.140059662788;15778.76331855023;15817.209139543207;15822.76265856013;15823.683526329409;15862.92068539673;8592.441491303045;8802.647894084294;8825.602847871733;8881.111888811196;9075.183233509017;8525.488470691778;8563.871541926876;8592.52741099233;8986.14631610009;9038.909610903807;6595.241547222035;6785.796426107225;6837.897431538531;6889.623080037379;6914.757983470655;1905.2379048380758;1963.7318896674365;1972.260402349119;1976.9308074217333;2016.7983201679715;774.3340726974798;877.4998250996871;900.9369344145847;951.4148798489018;1110.6945589962663;20374.592508149755;20462.386128416172;20554.177832886817;20594;20872.58254834895;1020.5203554329453;1060.5651682810164;1070.6038765656756;1086.2016417932814;1140.5779861451317;11514.596989105341;11652.70868228284;11824.231424957523;11873.821892671616;12045.15683902136;505497;515502;518704;522781;524480;85924.57037714771;87750;87803;88901.55549222342;88984;1024.0680980307884;1041.7656027393775;1057.1648397765832;1060.204846365226;1060.7030031591166;18114;18303.45089647313;18644.829929253592;18824.341148059753;18893.622127557097;41587.58412415837;43150;43163;43458.348124778786;43865.12269754651;55304.44695553154;64041.67979160074;64565.03152452811;66065.33934660784;66336;8832.425892316978;9145.314101442551;9200.447973121634;9356.157945784911;9425.528723563932;10437.634682786065;11859.52561897549;12500.624931257373;13820.23988680592;13840.169589824643;11994.580189693319;12108.455119519818;12213.633590992284;12330.260184388966;12331.876681233072;10678.519466624177;11612.593559225725;12261.080418968435;12448.439820207932;12596.055295852664;11868.169228153947;11869.465874035517;12046.397680116135;12073.335966521574;12572.874271257537;9003.414778039407;9315.673951411669;9319.394239374418;9325.720228393158;9568.282378821477;9479.810403792024;11153.996140347408;11201.103911686883;11318.151138664798;11373.715657108638 06:10:01 INFO - PROCESS | 5760 | |3;mootools.html;1507.7059973305206;1557.1591340676034;1680.2438902493873;1771.433141394754;1818.2363407368903;9068.727938161857;9729.367591106573;9750.024997500246;9762.951185244081;9777.511124443785;8433.62048707808;8698.521581313025;9227.723168304945;9473.289503287264;9474.099960503758;2519.5842685956795;2546.5925451927696;2548.1845809341016;2548.885300161497;2557.7825884799813;2483.192962287255;2578.2136448383235;2579.445419234864;2579.88390522426;2580.7935365170833;2462.44594966133;2468.950620987579;2503.636972638966;2511.7739403453684;2512.472380800025;2444.4744379958306;2460.138951367025;2462.9014839406404;2464.236086813076;2467.605183170693;2411.722651895019;2412.9396765080837;2425.4421483058995;2425.866577338246;2447.278052974377;9080.909190908073;9170.03714609963;9180.586873590637;9570.47362395075;9658.517074146335;5556.888862222733;5697.202391665171;5699.487046165865;5702;5702.657840529581;3432.8970130896114;3528.6647768461953;3575.6245594212755;3603.6756691897854;3625.23869987303;1171.764915281893;1288.1626942487364;1290.1678417420806;1296.2416986063165;1317.7957416600443;13450.260235687034;13452.730945381038;13455.192688438725;13460.865391346157;13465.124766890121;4911.729854857946;5075.3148324975655;5224.257264935939;5263.499967503081;5280.234366016983;10571.471426428649;10650.201234907412;10660.20048496366;10669.03978641926;10669.46652667379;5668.801591944345;5702.401247868997;5711.171880077365;5712.171735098387;5734.913976290359;4428.070105277863;5008.1486147355035;5231.476852314738;5283.682979021271;5328.547073498718;4009.418634298069;4087.693422993287;4116.403121547359;4176.436181115571;4191.538930717618;1189.7025743564109;1201.411308458849;1201.4173126033866;1201.6154830454345;1213.490334059697;919.7240827751648;934.5374039850318;1001.5493028137222;1031.03083101884;1071.8338657508098;6535.967320163369;6578.375054369827;6757.493188010919;6794.150731158606;6851.931480685229;492.81765746673244;493.50156342094743;493.55086870947264;504.2411171187413;514.6911852888312;4479.126570318756;4674.368960190331;4679.695819771704;4681;4737.549932756383;11466.48400821965;11541.538338466367;11968.82046769299;12040.81938770919;12058.095642826824;11708.88291117095;11851.170418070653;11863.940680296715;11887.227330223508;11898.821517677241;8370.079291277954;8590.1839325264;8726.694565690043;8784.648614055493;8873.511956842436;6625.204975402982;6722.394984451423;6731.966340168267;6764.695588698422;6792.184937807495;10882;11048.668539943814;11162.609308674157;11172.497237624164;11189.104871610089;10775.94612026935;10914.181436392144;11063.280886742335;11177.66467005991;11209.663710088711;7671.156172821097;7861.331786798186;8263.545504997042;8364.247217750188;8397.118302578141;9317;9554.331196816434;9557.952210238904;9563.952180239054;9572.234221262142;8351.415400921876;8457.407981441485;8498.872516912375;8524.104968978168;8558.957205213934;7955.443118981616;7984.081830589556;7984.321332686786;8074.59627018635;8106.067802202822;7655.923440765521;7683.846323073619;7711.961440192763;7727.150013498623;7756.650950707119;5403.216533602685;5589.720513974366;5638.802641907513;5654.604177707521;5804.100364443518;5519.951209270226;5704.172894930295;5762.394948530344;5828.213191219131;5881.32364778056 06:10:01 INFO - PROCESS | 5760 | |4;prototype.html;342.5888933280064;348.3833614502331;353.57041194948135;354.3444627439236;362.78776915504443;5633.295838020247;5650.547956163502;5654.74553645086;5681.659100453976;5692.174634677975;5541.5843811714185;5546.389897111315;5611.635243709156;5628.887422251562;5640.858978525539;3866.903327416809;4185.455890734208;4271.765052922088;4336.544662810406;4351.6518678505645;4358.3244597087505;4364.694471387004;4366.454193225847;4375.474943006843;4394.516603173648;4344.500382456011;4365.825366985317;4367.585079417466;4384.912301753963;4408.735475871442;4190.8533201337805;4293.914121717579;4342.196693611692;4343.370211319357;4359.651227901776;3854.2291541691493;3859.2281543691374;3862.497875276224;3873.86441474547;3881.611838816124;5353.357597088336;5364.275822763955;5376.435474275223;5385.434529374398;5386.622936394454;4735.786889589976;4965.925511117336;5030.471800460972;5074.792465277616;5082.974585127087;5773.9398118997;5793.217915581385;5797.188393624854;5809.128630705386;5813.215215945836;4211.43145675333;4226.457343069788;4246.341817018367;4247.830086796555;4291.120320334355;5888.439563515672;6087.452129308339;6096.603720758181;6118.265808103011;6145.354737752561;4252.936205956913;4257.680673949466;4259.91372200087;4264.722793018444;4291.742495450283;4338.869833904988;4353.997161305835;4357.934630980538;4359.629431498358;4368.716033457815;4862.246351815475;4924.384451943507;4975.973101775881;5000.099982003201;5016.021875734197;5799.710014499343;5808.215890854681;5808.825735227865;5821.15593238978;5843.561732869966;1483;1505.744023515983;1516.6360073582482;1528.5185166672463;1529.9235038248266;921.8386782313203;953.6328513522344;964.0215181590692;969.1132613658424;985.4235272365603;4995.175795993693;4997.4263254424;4999.600031997505;5016.924746128811;5025.969676216367;5256.842294731164;5271.523973287485;5291.629585928948;5329.600279979017;5334.653247538898;5081.974590127025;5090.211017292326;5116.334876466036;5289.973550132225;5710.200571919934;3138.466460701686;3183.376477996192;3189.5168746532972;3200.51992201167;3200.5999250093737;6052.425019623129;6166.290876549254;6168.938310616836;6194.256689197235;6197.349278325801;5792.710364481759;6023.27720673522;6094.421030002142;6095.634261944298;6146.293176284695;6003.609765365237;6031.9698401508585;6146.569740118238;6184.381561843779;6251.343608921089;5973.790917317873;5977;6024.313192306161;6024.457798797954;6031.819045428644;5636.633618814764;5921.17103605487;5927.970360148344;5988.191594134736;5996.430339117776;6257.5932564383165;6280.811575652738;6281.246250449975;6284.371562843679;6293.213348331458;4101.646456669351;4328.285832837547;4340.088581397816;4357.150355680738;4380.145871555016;5927.8221653350465;5946.791862284799;5947.881042379042;5950.31571369298;5964.254468191476;5823.534117270693;5826.533877289891;5836.941630583639;5840.766369345349;5873.588848780715;5708.971455142698;5816.156657284755;5831.94168058314;5833.445822646841;5848.941510584839;5820.359760426265;5820.505257053198;5824.242848429677;5836.241288632451;5850.356460789395;5669.327548373322;5866.178734977192;5870.735816888336;5872.941270587239;5873.324567674772;5712.42875712442;5715.8571035724435;5721.399253078534;5721.5696075981;5728.109723791223 06:10:01 INFO - PROCESS | 5760 | |5;yui.html;831.5343407691693;842.4566154830135;868.6916144768607;882.1575395497299;898.7797989492575;16207.270672819723;17588.38440654574;17685.469435916944;17793.199306031245;17826.376076837314;15152.1666308353;15241;15305.923470382633;16382.26279817408;16469.094199819006;843.7047033538258;861.4314552395421;863.4603372891943;863.6890719341033;864.5633954852822;700.1598082301233;713.2902761752038;832.7210384521193;856.5973992223676;865.1737590600961;893.2853717026353;895.552223888056;897.3987428422972;897.4121950122681;897.6095398501673;894.0523045571682;895.3687650206589;895.6820328783285;896.188949001155;896.2068569316169;650.9446697030758;651.2575663743337;657.0079180437526;657.0374401501775;657.7960832142052;16243;16268.186590670419;16285.267162977694;16287.51137465878;16307.673846523003;16396.62673048527;16525.91737041319;16729.414470493473;17367;17377.783555151145;12923.289219092947;12989.805152922714;13076.934615326958;13225.140365876186;13331.933340333333;3887.0644813521226;3910.902227444308;3914.217156568669;3922.705797065203;4062.106336605942;89635.55182224112;90752.09247907503;90856;91991.08008919959;92456.53771731233;12956.546520871725;13192.604221873358;13228.206307621573;13262;13432.395542200624;24133.75866241315;24282.635760463607;24337.87831060869;24447.26658200257;25559.872200638878;8652.134786521423;8667.783305417415;8711.128887111237;8746.650133994695;8845.867311990325;5249.186376111708;5276.366835979707;5312.681239125664;5337.226102215157;5405.432429594836;3733.9439908401396;3872.1481274119647;3879.903002424962;3901.648851603369;3906.648401643866;630.19020558582;650.0282078292983;650.8893488106938;651.491836367634;669.223700507409;636.9585727335747;637.4549759955172;643.6620774093639;735.8381156145639;743.9702411903571;10054.245931555162;10396.532156052996;10614.73463163427;10897.455127243764;10925.235233533576;782.1552723059197;799.0850476204713;800.1518390506083;809.449574289477;822.8642274024838;5029.270755740397;5284.417195025431;5289.391719952255;5420.268263784417;5487.368952570426;72345.27654723491;97473;123271;133541;136455.31772341076;65482.34517654858;66487;67854;107656;114244.42877785557;99409.50295248622;100110.4994475023;102372.48813755883;103244.48377758064;106346.46826765817;9522.61909523639;9566.712998610054;9901.702948911545;9980.05183538028;10089.091981721387;44559.10881782282;48201.75899120482;57016.429835701114;57581.42418575928;58179;78015;79753.60123199347;80118.59940700492;80567.59716201382;82582;14035.719285614436;14206.360713767699;14427.567172984827;14766.63083422923;15201.087934723952;16759.245833937744;16781.750802277507;16997.745033824256;17230.741538876675;17799.73300400469;15751.68496630084;15851.789390144186;16662.50012499627;17139.228734706718;17160.313587456363;14238.644033899236;15140.848591513944;15845.920770396075;16679.49961501157;16693.332266709196;14699.044562103429;15111.244437778287;15683.372665093268;15971.680566388839;16197.352105915632;12481.687957801129;12790.418682768839;12887.097903147065;12927.5475358362;13322.933385333012;12636.87363126357;12682.239065656091;12751.298678572768;12825.871741282468;13095.214287142802 06:10:01 INFO - PROCESS | 5760 | __end_tp_report 06:10:01 INFO - PROCESS | 5760 | __start_cc_report 06:10:01 INFO - PROCESS | 5760 | _x_x_mozilla_cycle_collect,867 06:10:01 INFO - PROCESS | 5760 | __end_cc_report 06:10:01 INFO - PROCESS | 5760 | __startTimestamp1480169401594__endTimestamp 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | ------- Summary: start ------- 06:10:01 INFO - PROCESS | 5760 | Number of tests: 6 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | [#0] dojo.html Cycles:165 Average:5539.01 Median:5732.60 stddev:633.41 (11.0%) stddev-sans-first:606.30 06:10:01 INFO - PROCESS | 5760 | Values: 3121.6 3163.1 3164.5 3189.1 3202.6 5526.4 5610.5 5613.2 5621.0 5645.2 5511.1 5569.9 5585.0 5590.2 5591.2 5072.6 5073.1 5101.6 5103.8 5145.5 4943.1 5102.2 5160.6 5162.2 5185.1 4925.6 4999.8 5024.5 5042.0 5097.9 5111.9 5140.8 5148.1 5208.0 5210.4 5041.8 5118.3 5162.9 5174.5 5200.8 5393.3 5451.0 5476.7 5502.6 5560.0 5877.3 5890.9 5898.3 5977.3 5980.2 6005.0 6007.7 6019.6 6024.0 6026.9 5385.7 5442.0 5554.6 5611.2 5618.9 6140.8 6171.9 6181.1 6182.0 6189.5 5938.3 5939.1 5940.3 5942.3 5944.6 5709.0 5757.2 5930.7 5955.7 6007.0 6014.2 6021.6 6023.9 6027.4 6043.2 5988.1 6040.1 6040.3 6048.0 6068.6 4423.2 4459.6 4507.6 4537.6 4637.7 4048.1 4066.2 4069.0 4083.7 4104.1 5690.5 5706.1 5707.4 5713.5 5720.0 5749.9 5828.0 5908.9 5960.6 5969.7 5656.3 5722.9 5732.6 5757.6 5762.8 5175.4 5185.4 5185.5 5193.0 5193.0 5926.1 5986.0 6160.9 6200.1 6224.0 5864.6 5865.6 5879.3 5984.2 6021.0 6157.3 6158.1 6167.3 6177.8 6179.9 5618.9 5870.2 5871.8 5872.3 5879.2 5700.3 5890.8 5926.7 5941.6 6015.1 5811.0 5845.4 5847.2 5851.1 5866.4 5861.7 5863.2 5867.2 5869.7 5876.4 5518.9 5524.6 5743.9 5747.6 5805.5 5873.2 5873.9 5880.1 5887.2 5892.6 5499.0 5698.3 5706.8 5708.2 5712.1 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | [#1] ext.html Cycles:180 Average:70606.08 Median:39699.70 stddev:161940.32 (407.9%) stddev-sans-first:162309.29 06:10:01 INFO - PROCESS | 5760 | Values: 595.1 616.4 636.1 639.5 644.2 33773.3 36823.0 44517.8 45323.4 45424.1 46691.3 47172.8 47186.0 47273.0 47325.1 9304.2 9385.5 9454.7 9457.1 9466.4 8411.7 8607.6 10851.9 11093.4 11115.4 11292.8 11381.7 11411.3 11411.3 11416.3 11151.5 11173.0 11225.9 11228.8 11228.8 10965.8 11035.3 11047.9 11050.7 11059.6 44640.0 45130.8 45142.0 45196.8 45649.1 3750.6 3754.6 3831.5 4065.6 4456.2 33100.8 33692.7 34094.1 34203.7 34339.0 4541.2 4657.3 4662.0 4665.4 4750.7 367094.0 368914.0 370480.0 371020.0 371610.0 60051.7 60346.4 60430.4 60442.4 60453.7 39989.4 40896.2 41171.0 42674.0 42808.6 18264.4 18480.3 18494.4 18494.7 18494.9 11974.2 14650.4 14684.6 14699.6 14701.8 17742.7 19506.7 20667.4 20777.7 20804.7 7295.4 7366.2 7476.7 7544.3 7641.4 1048.4 1053.5 1111.1 1173.4 1182.3 33804.5 34424.3 34453.7 34661.8 34782.5 1108.7 1160.7 1254.7 1268.9 1308.8 15409.3 17690.4 17784.6 19029.5 20034.2 585399.0 905542.5 924655.0 925138.0 927574.0 60284.7 60902.0 61027.0 61063.1 61076.0 1311.6 1343.7 1375.3 1405.7 1417.6 31083.5 34393.0 34524.8 34561.8 35374.3 50703.7 51401.2 51414.7 51496.5 51547.0 445216.0 445890.0 448361.0 448416.0 450139.0 26919.6 27528.7 30043.8 31153.8 32633.2 48317.0 48639.0 48716.0 48996.5 49031.3 41962.8 42025.4 42117.0 43359.8 43772.6 41258.4 42089.4 42280.8 42336.6 43071.1 44003.3 44276.8 44705.1 45005.3 45406.5 37651.0 39340.4 39410.0 40057.8 40144.6 29362.6 29684.6 29688.9 29799.3 30184.4 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | [#2] jquery.html Cycles:180 Average:29976.97 Median:2654.88 stddev:85003.41 (3201.8%) stddev-sans-first:85212.87 06:10:01 INFO - PROCESS | 5760 | Values: 403.7 411.6 412.2 415.9 420.4 18275.5 18711.4 19615.3 20625.9 20638.5 19832.2 20089.4 20153.2 20267.2 20324.6 5533.1 6001.9 6020.8 6026.8 6038.5 5818.9 5868.4 5936.6 6011.3 6019.8 5884.5 5885.4 5890.7 5891.6 5898.3 5685.9 5883.3 5884.8 5887.0 5934.3 5279.3 5298.8 5302.4 5311.8 5313.7 20186.0 23236.7 23258.2 23476.8 23494.5 2551.5 2580.0 2582.3 2727.5 2960.5 7182.3 7371.3 14510.9 14814.3 14988.9 1843.5 1931.2 1937.1 1939.1 1945.3 52472.0 69158.7 81065.6 83425.6 85726.0 10487.6 10715.4 10917.9 11089.1 11194.1 15778.8 15817.2 15822.8 15823.7 15862.9 8592.4 8802.6 8825.6 8881.1 9075.2 8525.5 8563.9 8592.5 8986.1 9038.9 6595.2 6785.8 6837.9 6889.6 6914.8 1905.2 1963.7 1972.3 1976.9 2016.8 774.3 877.5 900.9 951.4 1110.7 20374.6 20462.4 20554.2 20594.0 20872.6 1020.5 1060.6 1070.6 1086.2 1140.6 11514.6 11652.7 11824.2 11873.8 12045.2 505497.0 515502.0 518704.0 522781.0 524480.0 85924.6 87750.0 87803.0 88901.6 88984.0 1024.1 1041.8 1057.2 1060.2 1060.7 18114.0 18303.5 18644.8 18824.3 18893.6 41587.6 43150.0 43163.0 43458.3 43865.1 55304.4 64041.7 64565.0 66065.3 66336.0 8832.4 9145.3 9200.4 9356.2 9425.5 10437.6 11859.5 12500.6 13820.2 13840.2 11994.6 12108.5 12213.6 12330.3 12331.9 10678.5 11612.6 12261.1 12448.4 12596.1 11868.2 11869.5 12046.4 12073.3 12572.9 9003.4 9315.7 9319.4 9325.7 9568.3 9479.8 11154.0 11201.1 11318.2 11373.7 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | [#3] mootools.html Cycles:180 Average:6255.40 Median:493.16 stddev:3587.13 (727.4%) stddev-sans-first:3579.45 06:10:01 INFO - PROCESS | 5760 | Values: 1507.7 1557.2 1680.2 1771.4 1818.2 9068.7 9729.4 9750.0 9763.0 9777.5 8433.6 8698.5 9227.7 9473.3 9474.1 2519.6 2546.6 2548.2 2548.9 2557.8 2483.2 2578.2 2579.4 2579.9 2580.8 2462.4 2469.0 2503.6 2511.8 2512.5 2444.5 2460.1 2462.9 2464.2 2467.6 2411.7 2412.9 2425.4 2425.9 2447.3 9080.9 9170.0 9180.6 9570.5 9658.5 5556.9 5697.2 5699.5 5702.0 5702.7 3432.9 3528.7 3575.6 3603.7 3625.2 1171.8 1288.2 1290.2 1296.2 1317.8 13450.3 13452.7 13455.2 13460.9 13465.1 4911.7 5075.3 5224.3 5263.5 5280.2 10571.5 10650.2 10660.2 10669.0 10669.5 5668.8 5702.4 5711.2 5712.2 5734.9 4428.1 5008.1 5231.5 5283.7 5328.5 4009.4 4087.7 4116.4 4176.4 4191.5 1189.7 1201.4 1201.4 1201.6 1213.5 919.7 934.5 1001.5 1031.0 1071.8 6536.0 6578.4 6757.5 6794.2 6851.9 492.8 493.5 493.6 504.2 514.7 4479.1 4674.4 4679.7 4681.0 4737.5 11466.5 11541.5 11968.8 12040.8 12058.1 11708.9 11851.2 11863.9 11887.2 11898.8 8370.1 8590.2 8726.7 8784.6 8873.5 6625.2 6722.4 6732.0 6764.7 6792.2 10882.0 11048.7 11162.6 11172.5 11189.1 10775.9 10914.2 11063.3 11177.7 11209.7 7671.2 7861.3 8263.5 8364.2 8397.1 9317.0 9554.3 9558.0 9564.0 9572.2 8351.4 8457.4 8498.9 8524.1 8559.0 7955.4 7984.1 7984.3 8074.6 8106.1 7655.9 7683.8 7712.0 7727.2 7756.7 5403.2 5589.7 5638.8 5654.6 5804.1 5520.0 5704.2 5762.4 5828.2 5881.3 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | [#4] prototype.html Cycles:180 Average:4876.85 Median:5579.01 stddev:1428.33 (25.6%) stddev-sans-first:1391.20 06:10:01 INFO - PROCESS | 5760 | Values: 342.6 348.4 353.6 354.3 362.8 5633.3 5650.5 5654.7 5681.7 5692.2 5541.6 5546.4 5611.6 5628.9 5640.9 3866.9 4185.5 4271.8 4336.5 4351.7 4358.3 4364.7 4366.5 4375.5 4394.5 4344.5 4365.8 4367.6 4384.9 4408.7 4190.9 4293.9 4342.2 4343.4 4359.7 3854.2 3859.2 3862.5 3873.9 3881.6 5353.4 5364.3 5376.4 5385.4 5386.6 4735.8 4965.9 5030.5 5074.8 5083.0 5773.9 5793.2 5797.2 5809.1 5813.2 4211.4 4226.5 4246.3 4247.8 4291.1 5888.4 6087.5 6096.6 6118.3 6145.4 4252.9 4257.7 4259.9 4264.7 4291.7 4338.9 4354.0 4357.9 4359.6 4368.7 4862.2 4924.4 4976.0 5000.1 5016.0 5799.7 5808.2 5808.8 5821.2 5843.6 1483.0 1505.7 1516.6 1528.5 1529.9 921.8 953.6 964.0 969.1 985.4 4995.2 4997.4 4999.6 5016.9 5026.0 5256.8 5271.5 5291.6 5329.6 5334.7 5082.0 5090.2 5116.3 5290.0 5710.2 3138.5 3183.4 3189.5 3200.5 3200.6 6052.4 6166.3 6168.9 6194.3 6197.3 5792.7 6023.3 6094.4 6095.6 6146.3 6003.6 6032.0 6146.6 6184.4 6251.3 5973.8 5977.0 6024.3 6024.5 6031.8 5636.6 5921.2 5928.0 5988.2 5996.4 6257.6 6280.8 6281.2 6284.4 6293.2 4101.6 4328.3 4340.1 4357.2 4380.1 5927.8 5946.8 5947.9 5950.3 5964.3 5823.5 5826.5 5836.9 5840.8 5873.6 5709.0 5816.2 5831.9 5833.4 5848.9 5820.4 5820.5 5824.2 5836.2 5850.4 5669.3 5866.2 5870.7 5872.9 5873.3 5712.4 5715.9 5721.4 5721.6 5728.1 06:10:01 INFO - PROCESS | 5760 | 06:10:01 INFO - PROCESS | 5760 | [#5] yui.html Cycles:180 Average:22238.62 Median:3908.78 stddev:31335.80 (801.7%) stddev-sans-first:31382.48 06:10:01 INFO - PROCESS | 5760 | Values: 831.5 842.5 868.7 882.2 898.8 16207.3 17588.4 17685.5 17793.2 17826.4 15152.2 15241.0 15305.9 16382.3 16469.1 843.7 861.4 863.5 863.7 864.6 700.2 713.3 832.7 856.6 865.2 893.3 895.6 897.4 897.4 897.6 894.1 895.4 895.7 896.2 896.2 650.9 651.3 657.0 657.0 657.8 16243.0 16268.2 16285.3 16287.5 16307.7 16396.6 16525.9 16729.4 17367.0 17377.8 12923.3 12989.8 13076.9 13225.1 13331.9 3887.1 3910.9 3914.2 3922.7 4062.1 89635.6 90752.1 90856.0 91991.1 92456.5 12956.5 13192.6 13228.2 13262.0 13432.4 24133.8 24282.6 24337.9 24447.3 25559.9 8652.1 8667.8 8711.1 8746.7 8845.9 5249.2 5276.4 5312.7 5337.2 5405.4 3733.9 3872.1 3879.9 3901.6 3906.6 630.2 650.0 650.9 651.5 669.2 637.0 637.5 643.7 735.8 744.0 10054.2 10396.5 10614.7 10897.5 10925.2 782.2 799.1 800.2 809.4 822.9 5029.3 5284.4 5289.4 5420.3 5487.4 72345.3 97473.0 123271.0 133541.0 136455.3 65482.3 66487.0 67854.0 107656.0 114244.4 99409.5 100110.5 102372.5 103244.5 106346.5 9522.6 9566.7 9901.7 9980.1 10089.1 44559.1 48201.8 57016.4 57581.4 58179.0 78015.0 79753.6 80118.6 80567.6 82582.0 14035.7 14206.4 14427.6 14766.6 15201.1 16759.2 16781.8 16997.7 17230.7 17799.7 15751.7 15851.8 16662.5 17139.2 17160.3 14238.6 15140.8 15845.9 16679.5 16693.3 14699.0 15111.2 15683.4 15971.7 16197.4 12481.7 12790.4 12887.1 12927.5 13322.9 12636.9 12682.2 12751.3 12825.9 13095.2 06:10:01 INFO - PROCESS | 5760 | -------- Summary: end -------- 06:10:01 INFO - PROCESS | 5760 | 06:10:02 INFO - TEST-INFO | 5760: exit 0 06:10:02 INFO - TEST-OK | dromaeo_css | took 1112567ms 06:10:02 INFO - TEST-START | kraken 06:10:02 INFO - operating with platform_type : linux_ 06:10:02 INFO - Initialising browser for kraken test... 06:10:02 INFO - TEST-INFO | started process 6066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegEIPH/profile http://localhost:57823/getInfo.html) 06:10:06 INFO - PROCESS | 6066 | __metrics Screen width/height:1600/1200 06:10:06 INFO - PROCESS | 6066 | colorDepth:24 06:10:06 INFO - PROCESS | 6066 | Browser inner width/height: 1024/697 06:10:06 INFO - PROCESS | 6066 | __metrics 06:10:06 INFO - PROCESS | 6066 | 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" 06:10:06 INFO - PROCESS | 6066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:10:07 INFO - PROCESS | 6066 | console.error: PushService: 06:10:07 INFO - PROCESS | 6066 | stateChangeProcessEnqueue: Error transitioning state 06:10:07 INFO - PROCESS | 6066 | UnknownError 06:10:07 INFO - TEST-INFO | 6066: exit 0 06:10:07 INFO - Browser initialized. 06:10:07 INFO - Running cycle 1/1 for kraken test... 06:10:07 INFO - TEST-INFO | started process 6164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegEIPH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:19 INFO - PROCESS | 6164 | RSS: Main: 142868480 06:10:19 INFO - PROCESS | 6164 | 06:10:21 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57823/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:22 INFO - PROCESS | 6164 | RSS: Main: 186691584 06:10:22 INFO - PROCESS | 6164 | 06:10:25 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57823/tests/kraken/driver.html?testName=audio-dft) 06:10:25 INFO - PROCESS | 6164 | RSS: Main: 174497792 06:10:25 INFO - PROCESS | 6164 | 06:10:28 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57823/tests/kraken/driver.html?testName=audio-fft) 06:10:29 INFO - PROCESS | 6164 | RSS: Main: 265555968 06:10:29 INFO - PROCESS | 6164 | 06:10:31 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57823/tests/kraken/driver.html?testName=audio-oscillator) 06:10:31 INFO - PROCESS | 6164 | RSS: Main: 171831296 06:10:31 INFO - PROCESS | 6164 | 06:10:33 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:34 INFO - PROCESS | 6164 | RSS: Main: 173617152 06:10:34 INFO - PROCESS | 6164 | 06:10:37 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57823/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:38 INFO - PROCESS | 6164 | RSS: Main: 209727488 06:10:38 INFO - PROCESS | 6164 | 06:10:41 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57823/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:42 INFO - PROCESS | 6164 | RSS: Main: 208715776 06:10:42 INFO - PROCESS | 6164 | 06:10:44 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57823/tests/kraken/driver.html?testName=json-parse-financial) 06:10:45 INFO - PROCESS | 6164 | RSS: Main: 207990784 06:10:45 INFO - PROCESS | 6164 | 06:10:46 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:47 INFO - PROCESS | 6164 | RSS: Main: 169086976 06:10:47 INFO - PROCESS | 6164 | 06:10:49 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:49 INFO - PROCESS | 6164 | RSS: Main: 177078272 06:10:49 INFO - PROCESS | 6164 | 06:10:51 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:52 INFO - PROCESS | 6164 | RSS: Main: 186875904 06:10:52 INFO - PROCESS | 6164 | 06:10:54 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:55 INFO - PROCESS | 6164 | RSS: Main: 187994112 06:10:55 INFO - PROCESS | 6164 | 06:10:58 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:58 INFO - PROCESS | 6164 | RSS: Main: 190791680 06:10:58 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | Cycle 1(1): loaded http://localhost:57823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57823/tests/kraken/driver.html?testName=ai-astar) 06:11:00 INFO - PROCESS | 6164 | RSS: Main: 239943680 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | __start_tp_report 06:11:00 INFO - PROCESS | 6164 | _x_x_mozilla_page_load 06:11:00 INFO - PROCESS | 6164 | _x_x_mozilla_page_load_details 06:11:00 INFO - PROCESS | 6164 | |i|pagename|runs| 06:11:00 INFO - PROCESS | 6164 | |0;ai-astar;109;113;110;108;109;111;110;109;110;110 06:11:00 INFO - PROCESS | 6164 | |1;audio-beat-detection;149;129;123;160;118;116;116;119;159;117 06:11:00 INFO - PROCESS | 6164 | |2;audio-dft;159;161;160;159;159;161;159;160;160;160 06:11:00 INFO - PROCESS | 6164 | |3;audio-fft;73;75;74;109;76;76;76;75;101;75 06:11:00 INFO - PROCESS | 6164 | |4;audio-oscillator;81;82;121;83;82;82;105;81;81;107 06:11:00 INFO - PROCESS | 6164 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 06:11:00 INFO - PROCESS | 6164 | |6;imaging-darkroom;147;146;146;145;146;145;146;145;145;146 06:11:00 INFO - PROCESS | 6164 | |7;imaging-desaturate;95;94;95;94;95;94;94;94;94;95 06:11:00 INFO - PROCESS | 6164 | |8;json-parse-financial;50;48;50;48;48;48;48;48;48;48 06:11:00 INFO - PROCESS | 6164 | |9;json-stringify-tinderbox;59;59;58;63;58;59;58;58;58;58 06:11:00 INFO - PROCESS | 6164 | |10;stanford-crypto-aes;73;73;74;72;73;74;74;80;72;81 06:11:00 INFO - PROCESS | 6164 | |11;stanford-crypto-ccm;122;125;125;119;128;125;119;120;160;122 06:11:00 INFO - PROCESS | 6164 | |12;stanford-crypto-pbkdf2;159;150;150;155;156;151;156;153;148;153 06:11:00 INFO - PROCESS | 6164 | |13;stanford-crypto-sha256-iterative;64;62;63;62;62;61;62;62;61;61 06:11:00 INFO - PROCESS | 6164 | __end_tp_report 06:11:00 INFO - PROCESS | 6164 | __start_cc_report 06:11:00 INFO - PROCESS | 6164 | _x_x_mozilla_cycle_collect,1636 06:11:00 INFO - PROCESS | 6164 | __end_cc_report 06:11:00 INFO - PROCESS | 6164 | __startTimestamp1480169460592__endTimestamp 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | ------- Summary: start ------- 06:11:00 INFO - PROCESS | 6164 | Number of tests: 14 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.37 (1.2%) stddev-sans-first:1.41 06:11:00 INFO - PROCESS | 6164 | Values: 109.0 113.0 110.0 108.0 109.0 111.0 110.0 109.0 110.0 110.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:126.00 stddev:18.18 (14.4%) stddev-sans-first:18.02 06:11:00 INFO - PROCESS | 6164 | Values: 149.0 129.0 123.0 160.0 118.0 116.0 116.0 119.0 159.0 117.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:11:00 INFO - PROCESS | 6164 | Values: 159.0 161.0 160.0 159.0 159.0 161.0 159.0 160.0 160.0 160.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:12.82 (17.1%) stddev-sans-first:13.27 06:11:00 INFO - PROCESS | 6164 | Values: 73.0 75.0 74.0 109.0 76.0 76.0 76.0 75.0 101.0 75.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.50 stddev:14.74 (18.1%) stddev-sans-first:15.23 06:11:00 INFO - PROCESS | 6164 | Values: 81.0 82.0 121.0 83.0 82.0 82.0 105.0 81.0 81.0 107.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:11:00 INFO - PROCESS | 6164 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 06:11:00 INFO - PROCESS | 6164 | Values: 147.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:11:00 INFO - PROCESS | 6164 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.00 stddev:0.84 (1.8%) stddev-sans-first:0.67 06:11:00 INFO - PROCESS | 6164 | Values: 50.0 48.0 50.0 48.0 48.0 48.0 48.0 48.0 48.0 48.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:1.55 (2.6%) stddev-sans-first:1.64 06:11:00 INFO - PROCESS | 6164 | Values: 59.0 59.0 58.0 63.0 58.0 59.0 58.0 58.0 58.0 58.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:3.20 (4.3%) stddev-sans-first:3.35 06:11:00 INFO - PROCESS | 6164 | Values: 73.0 73.0 74.0 72.0 73.0 74.0 74.0 80.0 72.0 81.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:125.00 stddev:12.14 (9.7%) stddev-sans-first:12.77 06:11:00 INFO - PROCESS | 6164 | Values: 122.0 125.0 125.0 119.0 128.0 125.0 119.0 120.0 160.0 122.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:3.41 (2.2%) stddev-sans-first:2.88 06:11:00 INFO - PROCESS | 6164 | Values: 159.0 150.0 150.0 155.0 156.0 151.0 156.0 153.0 148.0 153.0 06:11:00 INFO - PROCESS | 6164 | 06:11:00 INFO - PROCESS | 6164 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.67 06:11:00 INFO - PROCESS | 6164 | Values: 64.0 62.0 63.0 62.0 62.0 61.0 62.0 62.0 61.0 61.0 06:11:00 INFO - PROCESS | 6164 | -------- Summary: end -------- 06:11:00 INFO - PROCESS | 6164 | 06:11:01 INFO - TEST-INFO | 6164: exit 0 06:11:01 INFO - TEST-OK | kraken | took 59195ms 06:11:01 INFO - SUITE-END | took 1171s 06:11:01 INFO - Completed test suite (00:19:31) 06:11:01 INFO - javascript benchmark 06:11:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.6254049514064, 3163.0827060152556, 3164.47786115291, 3189.075168201222, 3202.6156861176646, 5526.364468086172, 5610.523105536035, 5613.186088017235, 5621.0444224481835, 5645.2096706461125, 5511.118221084627, 5569.860753481165, 5585.0, 5590.217369568264, 5591.245181900453, 5072.644914855961, 5073.137566613666, 5101.642884998052, 5103.821366252182, 5145.536901678848, 4943.085529177096, 5102.158143906251, 5160.612954028444, 5162.199859021857, 5185.118529849935, 4925.581325587312, 4999.825006124786, 5024.497550244964, 5042.0, 5097.898042039157, 5111.948880511184, 5140.820071297505, 5148.124818780816, 5208.0, 5210.374755029383, 5041.773120209599, 5118.2578526113875, 5162.92255616166, 5174.534291913708, 5200.843974680765, 5393.298871146765, 5451.04606693827, 5476.698781567012, 5502.642328248691, 5560.0, 5877.324107727623, 5890.882182356372, 5898.321693005317, 5977.342492325841, 5980.162777211194, 6005.039193729026, 6007.7383749412675, 6019.578629495937, 6024.036154215349, 6026.909596356014, 5385.67685938841, 5441.972790136064, 5554.638948468377, 5611.2144299798065, 5618.943810561842, 6140.78507252253, 6171.907421388593, 6181.134641150243, 6181.96909015452, 6189.535784816157, 5938.257717785277, 5939.079442686304, 5940.34656187819, 5942.286925568873, 5944.554158438134, 5708.971455142698, 5757.193992841006, 5930.733117009659, 5955.672438015864, 6007.038873780174, 6014.248218972629, 6021.638701677914, 6023.909641355383, 6027.367126451747, 6043.214382130383, 5988.071848863433, 6040.063790112539, 6040.305364883006, 6048.0, 6068.6358818471035, 4423.181711383404, 4459.576340247671, 4507.5943165115295, 4537.6143027843, 4637.675362724577, 4048.1296521248073, 4066.207089617496, 4068.959310406917, 4083.673306135502, 4104.0970986382945, 5690.487856092972, 5706.115552089433, 5707.3721890592005, 5713.542916566665, 5720.027595308808, 5749.8562535936935, 5828.0, 5908.911366329508, 5960.552958528041, 5969.671668058299, 5656.264685590847, 5722.885542289131, 5732.598718089694, 5757.596968212269, 5762.769489220468, 5175.378954525406, 5185.403678577012, 5185.455527169668, 5193.0, 5193.039287731782, 5926.111083337534, 5986.042233242834, 6160.907586386208, 6200.0699895016105, 6224.0, 5864.618799778001, 5865.618734782225, 5879.323877753942, 5984.19213406202, 6021.0, 6157.291911430064, 6158.107074474086, 6167.290761562478, 6177.84555386119, 6179.876402471836, 5618.943810562006, 5870.207521984477, 5871.7651293949475, 5872.324682661549, 5879.235699359056, 5700.287464066992, 5890.764369425175, 5926.703664816828, 5941.554383421174, 6015.097735339734, 5810.970945145247, 5845.386234445492, 5847.239858818326, 5851.122331650116, 5866.384029676822, 5861.706914654335, 5863.208466857091, 5867.20792692981, 5869.6771677556435, 5876.382979787061, 5518.917216241679, 5524.640898341595, 5743.885122297447, 5747.568932330176, 5805.506531944832, 5873.177755114202, 5873.882522349614, 5880.117982302518, 5887.234659494238, 5892.646441213541, 5498.972505137449, 5698.287714035746, 5706.828795136153, 5708.200851880657, 5712.143178523089], "value": 5495.564937131743, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.0508938243503, 616.3928530397558, 636.1157990393355, 639.5203597302024, 644.2076246217152, 33773.324533509316, 36823.0, 44517.77741111294, 45323.41368052119, 45424.0915181697, 46691.299630505484, 47172.76413617936, 47186.0, 47273.0, 47325.05349893009, 9304.162625363715, 9385.483798391086, 9454.716358509255, 9457.10157535033, 9466.432014079142, 8411.663533458654, 8607.569621518931, 10851.891481085167, 11093.3898635575, 11115.388653624048, 11292.830607540893, 11381.658550243465, 11411.258268212581, 11411.31532108072, 11416.257943233662, 11151.498182581803, 11173.0, 11225.887741122566, 11228.775424491505, 11228.831567526493, 10965.780684386267, 11035.337879727242, 11047.944760276228, 11050.668479945614, 11059.557617695282, 44640.0, 45130.77434612839, 45142.0, 45196.77401612971, 45649.08701825945, 3750.6436888495823, 3754.6245375462236, 3831.5019047523924, 4065.6340929316502, 4456.153330867157, 33100.83449582761, 33692.6630733692, 34094.147646309044, 34203.65796342029, 34339.0, 4541.227991241497, 4657.301404789275, 4661.95338046622, 4665.4168228971375, 4750.667453278272, 367094.0, 368914.0, 370480.0, 371020.0, 371609.9999999973, 60051.69974150101, 60346.396536034954, 60430.39569604248, 60442.39557604368, 60453.697731511944, 39989.40015899764, 40896.18207635831, 41171.0, 42674.0, 42808.57191428046, 18264.36074737378, 18480.260789568536, 18494.35269765552, 18494.722579161324, 18494.907525462557, 11974.161808673309, 14650.413983440756, 14684.632884177767, 14699.55901322962, 14701.779473307908, 17742.733858992124, 19506.656108529463, 20667.379978600366, 20777.688334674993, 20804.687929681066, 7295.379892709179, 7366.1528924173335, 7476.663550140257, 7544.321011109027, 7641.350485208708, 1048.3605000949415, 1053.5259133390005, 1111.149970272742, 1173.4015652017363, 1182.343799191457, 33804.49293260603, 34424.311513769586, 34453.655463445044, 34661.82669086689, 34782.47826282608, 1108.684025052856, 1160.7388337624136, 1254.7051442910908, 1268.866768989243, 1308.7513372459202, 15409.306581203873, 17690.380836670654, 17784.55538611545, 19029.524261893563, 20034.198632054846, 585399.0, 905542.4722876475, 924655.0, 925138.0, 927574.0, 60284.69857650771, 60902.0, 61027.0, 61063.08405373923, 61076.0, 1311.5868501422021, 1343.657367371314, 1375.3467103125936, 1405.7258834527374, 1417.595985144229, 31083.533746994264, 34393.0, 34524.82737586296, 34561.82719086489, 35374.29251415009, 50703.746481268834, 51401.228981564556, 51414.74292628513, 51496.48503514917, 51547.0, 445216.0, 445890.0, 448361.0, 448416.0, 450139.0, 26919.59620605732, 27528.724712752617, 30043.844387222875, 31153.8442307787, 32633.18417039593, 48317.0, 48639.0, 48716.0, 48996.51003490062, 49031.26453103135, 41962.79018604887, 42025.369619456345, 42117.0, 43359.783201083796, 43772.56227437812, 41258.38112428376, 42089.36865947075, 42280.788596056824, 42336.576634233264, 43071.138577227655, 44003.33994990142, 44276.77861610671, 44705.10589788251, 45005.32492012557, 45406.545934540234, 37651.0, 39340.409893852186, 39410.0, 40057.79971100126, 40144.598554015254, 29362.55956160702, 29684.554731679473, 29688.85540227785, 29799.255018624706, 30184.396312073197], "value": 21571.087770903425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.67100812837555, 411.63158972719395, 412.2353035119852, 415.9292920203564, 420.4093248985175, 18275.451736447896, 18711.438656840284, 19615.31346402876, 20625.896870515662, 20638.48403789904, 19832.206711731513, 20089.397318080446, 20153.193872245094, 20267.189312427523, 20324.593508129867, 5533.142362933741, 6001.939980600204, 6020.789272375468, 6026.789062382817, 6038.516918646497, 5818.854528636797, 5868.41315868414, 5936.554758393117, 6011.338752737195, 6019.849503762397, 5884.529237660999, 5885.352611212763, 5890.676012819294, 5891.64650120992, 5898.262717160355, 5685.886282274352, 5883.323417806964, 5884.823455296348, 5887.0286402743495, 5934.28788545373, 5279.340082489689, 5298.761555730001, 5302.363716354023, 5311.840644780663, 5313.734313284321, 20186.0, 23236.65145022826, 23258.185963491367, 23476.76523234763, 23494.53010939789, 2551.527967326032, 2580.0, 2582.289870285668, 2727.468143711977, 2960.5263157894847, 7182.281771822828, 7371.26287371264, 14510.854891451056, 14814.259287035606, 14988.925055374762, 1843.4746097362188, 1931.159945423745, 1937.1089298922514, 1939.0886283446757, 1945.3191383015974, 52472.0, 69158.65420672914, 81065.59467202685, 83425.58287208524, 85726.0, 10487.632932847313, 10715.35707857531, 10917.890821091847, 11089.112870970303, 11194.140059662788, 15778.76331855023, 15817.209139543207, 15822.76265856013, 15823.683526329409, 15862.92068539673, 8592.441491303045, 8802.647894084294, 8825.602847871733, 8881.111888811196, 9075.183233509017, 8525.488470691778, 8563.871541926876, 8592.52741099233, 8986.14631610009, 9038.909610903807, 6595.241547222035, 6785.796426107225, 6837.897431538531, 6889.623080037379, 6914.757983470655, 1905.2379048380758, 1963.7318896674365, 1972.260402349119, 1976.9308074217333, 2016.7983201679715, 774.3340726974798, 877.4998250996871, 900.9369344145847, 951.4148798489018, 1110.6945589962663, 20374.592508149755, 20462.386128416172, 20554.177832886817, 20594.0, 20872.58254834895, 1020.5203554329453, 1060.5651682810164, 1070.6038765656756, 1086.2016417932814, 1140.5779861451317, 11514.596989105341, 11652.70868228284, 11824.231424957523, 11873.821892671616, 12045.15683902136, 505497.0, 515502.0, 518704.0, 522781.0, 524480.0, 85924.57037714771, 87750.0, 87803.0, 88901.55549222342, 88984.0, 1024.0680980307884, 1041.7656027393775, 1057.1648397765832, 1060.204846365226, 1060.7030031591166, 18114.0, 18303.45089647313, 18644.829929253592, 18824.341148059753, 18893.622127557097, 41587.58412415837, 43150.0, 43163.0, 43458.348124778786, 43865.12269754651, 55304.44695553154, 64041.67979160074, 64565.03152452811, 66065.33934660784, 66336.0, 8832.425892316978, 9145.314101442551, 9200.447973121634, 9356.157945784911, 9425.528723563932, 10437.634682786065, 11859.52561897549, 12500.624931257373, 13820.23988680592, 13840.169589824643, 11994.580189693319, 12108.455119519818, 12213.633590992284, 12330.260184388966, 12331.876681233072, 10678.519466624177, 11612.593559225725, 12261.080418968435, 12448.439820207932, 12596.055295852664, 11868.169228153947, 11869.465874035517, 12046.397680116135, 12073.335966521574, 12572.874271257537, 9003.414778039407, 9315.673951411669, 9319.394239374418, 9325.720228393158, 9568.282378821477, 9479.810403792024, 11153.996140347408, 11201.103911686883, 11318.151138664798, 11373.715657108638], "value": 9596.778632343767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.7059973305206, 1557.1591340676034, 1680.2438902493873, 1771.433141394754, 1818.2363407368903, 9068.727938161857, 9729.367591106573, 9750.024997500246, 9762.951185244081, 9777.511124443785, 8433.62048707808, 8698.521581313025, 9227.723168304945, 9473.289503287264, 9474.099960503758, 2519.5842685956795, 2546.5925451927696, 2548.1845809341016, 2548.885300161497, 2557.7825884799813, 2483.192962287255, 2578.2136448383235, 2579.445419234864, 2579.88390522426, 2580.7935365170833, 2462.44594966133, 2468.950620987579, 2503.636972638966, 2511.7739403453684, 2512.472380800025, 2444.4744379958306, 2460.138951367025, 2462.9014839406404, 2464.236086813076, 2467.605183170693, 2411.722651895019, 2412.9396765080837, 2425.4421483058995, 2425.866577338246, 2447.278052974377, 9080.909190908073, 9170.03714609963, 9180.586873590637, 9570.47362395075, 9658.517074146335, 5556.888862222733, 5697.202391665171, 5699.487046165865, 5702.0, 5702.657840529581, 3432.8970130896114, 3528.6647768461953, 3575.6245594212755, 3603.6756691897854, 3625.23869987303, 1171.764915281893, 1288.1626942487364, 1290.1678417420806, 1296.2416986063165, 1317.7957416600443, 13450.260235687034, 13452.730945381038, 13455.192688438725, 13460.865391346157, 13465.124766890121, 4911.729854857946, 5075.3148324975655, 5224.257264935939, 5263.499967503081, 5280.234366016983, 10571.471426428649, 10650.201234907412, 10660.20048496366, 10669.03978641926, 10669.46652667379, 5668.801591944345, 5702.401247868997, 5711.171880077365, 5712.171735098387, 5734.913976290359, 4428.070105277863, 5008.1486147355035, 5231.476852314738, 5283.682979021271, 5328.547073498718, 4009.418634298069, 4087.693422993287, 4116.403121547359, 4176.436181115571, 4191.538930717618, 1189.7025743564109, 1201.411308458849, 1201.4173126033866, 1201.6154830454345, 1213.490334059697, 919.7240827751648, 934.5374039850318, 1001.5493028137222, 1031.03083101884, 1071.8338657508098, 6535.967320163369, 6578.375054369827, 6757.493188010919, 6794.150731158606, 6851.931480685229, 492.81765746673244, 493.50156342094743, 493.55086870947264, 504.2411171187413, 514.6911852888312, 4479.126570318756, 4674.368960190331, 4679.695819771704, 4681.0, 4737.549932756383, 11466.48400821965, 11541.538338466367, 11968.82046769299, 12040.81938770919, 12058.095642826824, 11708.88291117095, 11851.170418070653, 11863.940680296715, 11887.227330223508, 11898.821517677241, 8370.079291277954, 8590.1839325264, 8726.694565690043, 8784.648614055493, 8873.511956842436, 6625.204975402982, 6722.394984451423, 6731.966340168267, 6764.695588698422, 6792.184937807495, 10882.0, 11048.668539943814, 11162.609308674157, 11172.497237624164, 11189.104871610089, 10775.94612026935, 10914.181436392144, 11063.280886742335, 11177.66467005991, 11209.663710088711, 7671.156172821097, 7861.331786798186, 8263.545504997042, 8364.247217750188, 8397.118302578141, 9317.0, 9554.331196816434, 9557.952210238904, 9563.952180239054, 9572.234221262142, 8351.415400921876, 8457.407981441485, 8498.872516912375, 8524.104968978168, 8558.957205213934, 7955.443118981616, 7984.081830589556, 7984.321332686786, 8074.59627018635, 8106.067802202822, 7655.923440765521, 7683.846323073619, 7711.961440192763, 7727.150013498623, 7756.650950707119, 5403.216533602685, 5589.720513974366, 5638.802641907513, 5654.604177707521, 5804.100364443518, 5519.951209270226, 5704.172894930295, 5762.394948530344, 5828.213191219131, 5881.32364778056], "value": 4902.314729148101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5888933280064, 348.3833614502331, 353.57041194948135, 354.3444627439236, 362.78776915504443, 5633.295838020247, 5650.547956163502, 5654.74553645086, 5681.659100453976, 5692.174634677975, 5541.5843811714185, 5546.389897111315, 5611.635243709156, 5628.887422251562, 5640.858978525539, 3866.903327416809, 4185.455890734208, 4271.765052922088, 4336.544662810406, 4351.6518678505645, 4358.3244597087505, 4364.694471387004, 4366.454193225847, 4375.474943006843, 4394.516603173648, 4344.500382456011, 4365.825366985317, 4367.585079417466, 4384.912301753963, 4408.735475871442, 4190.8533201337805, 4293.914121717579, 4342.196693611692, 4343.370211319357, 4359.651227901776, 3854.2291541691493, 3859.2281543691374, 3862.497875276224, 3873.86441474547, 3881.611838816124, 5353.357597088336, 5364.275822763955, 5376.435474275223, 5385.434529374398, 5386.622936394454, 4735.786889589976, 4965.925511117336, 5030.471800460972, 5074.792465277616, 5082.974585127087, 5773.9398118997, 5793.217915581385, 5797.188393624854, 5809.128630705386, 5813.215215945836, 4211.43145675333, 4226.457343069788, 4246.341817018367, 4247.830086796555, 4291.120320334355, 5888.439563515672, 6087.452129308339, 6096.603720758181, 6118.265808103011, 6145.354737752561, 4252.936205956913, 4257.680673949466, 4259.91372200087, 4264.722793018444, 4291.742495450283, 4338.869833904988, 4353.997161305835, 4357.934630980538, 4359.629431498358, 4368.716033457815, 4862.246351815475, 4924.384451943507, 4975.973101775881, 5000.099982003201, 5016.021875734197, 5799.710014499343, 5808.215890854681, 5808.825735227865, 5821.15593238978, 5843.561732869966, 1483.0, 1505.744023515983, 1516.6360073582482, 1528.5185166672463, 1529.9235038248266, 921.8386782313203, 953.6328513522344, 964.0215181590692, 969.1132613658424, 985.4235272365603, 4995.175795993693, 4997.4263254424, 4999.600031997505, 5016.924746128811, 5025.969676216367, 5256.842294731164, 5271.523973287485, 5291.629585928948, 5329.600279979017, 5334.653247538898, 5081.974590127025, 5090.211017292326, 5116.334876466036, 5289.973550132225, 5710.200571919934, 3138.466460701686, 3183.376477996192, 3189.5168746532972, 3200.51992201167, 3200.5999250093737, 6052.425019623129, 6166.290876549254, 6168.938310616836, 6194.256689197235, 6197.349278325801, 5792.710364481759, 6023.27720673522, 6094.421030002142, 6095.634261944298, 6146.293176284695, 6003.609765365237, 6031.9698401508585, 6146.569740118238, 6184.381561843779, 6251.343608921089, 5973.790917317873, 5977.0, 6024.313192306161, 6024.457798797954, 6031.819045428644, 5636.633618814764, 5921.17103605487, 5927.970360148344, 5988.191594134736, 5996.430339117776, 6257.5932564383165, 6280.811575652738, 6281.246250449975, 6284.371562843679, 6293.213348331458, 4101.646456669351, 4328.285832837547, 4340.088581397816, 4357.150355680738, 4380.145871555016, 5927.8221653350465, 5946.791862284799, 5947.881042379042, 5950.31571369298, 5964.254468191476, 5823.534117270693, 5826.533877289891, 5836.941630583639, 5840.766369345349, 5873.588848780715, 5708.971455142698, 5816.156657284755, 5831.94168058314, 5833.445822646841, 5848.941510584839, 5820.359760426265, 5820.505257053198, 5824.242848429677, 5836.241288632451, 5850.356460789395, 5669.327548373322, 5866.178734977192, 5870.735816888336, 5872.941270587239, 5873.324567674772, 5712.42875712442, 5715.8571035724435, 5721.399253078534, 5721.5696075981, 5728.109723791223], "value": 4422.755494200527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.5343407691693, 842.4566154830135, 868.6916144768607, 882.1575395497299, 898.7797989492575, 16207.270672819723, 17588.38440654574, 17685.469435916944, 17793.199306031245, 17826.376076837314, 15152.1666308353, 15241.0, 15305.923470382633, 16382.26279817408, 16469.094199819006, 843.7047033538258, 861.4314552395421, 863.4603372891943, 863.6890719341033, 864.5633954852822, 700.1598082301233, 713.2902761752038, 832.7210384521193, 856.5973992223676, 865.1737590600961, 893.2853717026353, 895.552223888056, 897.3987428422972, 897.4121950122681, 897.6095398501673, 894.0523045571682, 895.3687650206589, 895.6820328783285, 896.188949001155, 896.2068569316169, 650.9446697030758, 651.2575663743337, 657.0079180437526, 657.0374401501775, 657.7960832142052, 16243.0, 16268.186590670419, 16285.267162977694, 16287.51137465878, 16307.673846523003, 16396.62673048527, 16525.91737041319, 16729.414470493473, 17367.0, 17377.783555151145, 12923.289219092947, 12989.805152922714, 13076.934615326958, 13225.140365876186, 13331.933340333333, 3887.0644813521226, 3910.902227444308, 3914.217156568669, 3922.705797065203, 4062.106336605942, 89635.55182224112, 90752.09247907503, 90856.0, 91991.08008919959, 92456.53771731233, 12956.546520871725, 13192.604221873358, 13228.206307621573, 13262.0, 13432.395542200624, 24133.75866241315, 24282.635760463607, 24337.87831060869, 24447.26658200257, 25559.872200638878, 8652.134786521423, 8667.783305417415, 8711.128887111237, 8746.650133994695, 8845.867311990325, 5249.186376111708, 5276.366835979707, 5312.681239125664, 5337.226102215157, 5405.432429594836, 3733.9439908401396, 3872.1481274119647, 3879.903002424962, 3901.648851603369, 3906.648401643866, 630.19020558582, 650.0282078292983, 650.8893488106938, 651.491836367634, 669.223700507409, 636.9585727335747, 637.4549759955172, 643.6620774093639, 735.8381156145639, 743.9702411903571, 10054.245931555162, 10396.532156052996, 10614.73463163427, 10897.455127243764, 10925.235233533576, 782.1552723059197, 799.0850476204713, 800.1518390506083, 809.449574289477, 822.8642274024838, 5029.270755740397, 5284.417195025431, 5289.391719952255, 5420.268263784417, 5487.368952570426, 72345.27654723491, 97473.0, 123271.0, 133541.0, 136455.31772341076, 65482.34517654858, 66487.0, 67854.0, 107656.0, 114244.42877785557, 99409.50295248622, 100110.4994475023, 102372.48813755883, 103244.48377758064, 106346.46826765817, 9522.61909523639, 9566.712998610054, 9901.702948911545, 9980.05183538028, 10089.091981721387, 44559.10881782282, 48201.75899120482, 57016.429835701114, 57581.42418575928, 58179.0, 78015.0, 79753.60123199347, 80118.59940700492, 80567.59716201382, 82582.0, 14035.719285614436, 14206.360713767699, 14427.567172984827, 14766.63083422923, 15201.087934723952, 16759.245833937744, 16781.750802277507, 16997.745033824256, 17230.741538876675, 17799.73300400469, 15751.68496630084, 15851.789390144186, 16662.50012499627, 17139.228734706718, 17160.313587456363, 14238.644033899236, 15140.848591513944, 15845.920770396075, 16679.49961501157, 16693.332266709196, 14699.044562103429, 15111.244437778287, 15683.372665093268, 15971.680566388839, 16197.352105915632, 12481.687957801129, 12790.418682768839, 12887.097903147065, 12927.5475358362, 13322.933385333012, 12636.87363126357, 12682.239065656091, 12751.298678572768, 12825.871741282468, 13095.214287142802], "value": 8219.19100469007, "unit": "score"}], "name": "dromaeo_css", "value": 7664.718095327724, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 110.0, 108.0, 109.0, 111.0, 110.0, 109.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 123.0, 160.0, 118.0, 116.0, 116.0, 119.0, 159.0, 117.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 159.0, 159.0, 161.0, 159.0, 160.0, 160.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 109.0, 76.0, 76.0, 76.0, 75.0, 101.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 83.0, 82.0, 82.0, 105.0, 81.0, 81.0, 107.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 50.0, 48.0, 48.0, 48.0, 48.0, 48.0, 48.0, 48.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 63.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 72.0, 73.0, 74.0, 74.0, 80.0, 72.0, 81.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 125.0, 119.0, 128.0, 125.0, 119.0, 120.0, 160.0, 122.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 150.0, 150.0, 155.0, 156.0, 151.0, 156.0, 153.0, 148.0, 153.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1452.3999999999996, "alertThreshold": 2.0}]} 06:11:01 INFO - Return code: 0 06:11:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:11:01 INFO - # TBPL SUCCESS # 06:11:01 INFO - Running post-action listener: _resource_record_post_action 06:11:01 INFO - [mozharness: 2016-11-26 14:11:01.895491Z] Finished run-tests step (success) 06:11:01 INFO - Running post-run listener: _resource_record_post_run 06:11:01 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1867776; Write bytes: 320626688; Read time: 484; Write time: 165476 06:11:01 INFO - TinderboxPrint: CPU usage
12.9% 06:11:01 INFO - TinderboxPrint: I/O read bytes / time
1,867,776 / 484 06:11:01 INFO - TinderboxPrint: I/O write bytes / time
320,626,688 / 165,476 06:11:01 INFO - TinderboxPrint: CPU idle
8,243.9 (87.1%) 06:11:01 INFO - TinderboxPrint: CPU user
1,182.8 (12.5%) 06:11:01 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:01 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100302848; Read time: 0; Write time: 59196 06:11:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 220323840; Read time: 0; Write time: 106280 06:11:02 INFO - Running post-run listener: _upload_blobber_files 06:11:02 INFO - Blob upload gear active. 06:11:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:11:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:11:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:03 INFO - (blobuploader) - INFO - Done attempting. 06:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:06 INFO - (blobuploader) - INFO - Done attempting. 06:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:07 INFO - (blobuploader) - INFO - Done attempting. 06:11:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:07 INFO - Return code: 0 06:11:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe76915e1aff36d17aecf2a9405100a1741928db27a7317e4d302238aaa60c6a8eae856c4964ad2c800f60994e8523c0cb72ecd066dd9f4b8021df0751333c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4be0a843699c8c6d2b7e9db8a621e202c375105ccfc16f1da6c1b1f7ea51be1546a16de5e44979ba5690fa79928ec9f58194ce9e6f60a7a0f1f94517f67b36b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89f0ebbab3ed17bff8694bde51777cacb4e757736564b0e0f6fd91398397216ecc421e1e0fda4a2627317e466852a2a635f4c77440b0d9307644a22a29c48246"} 06:11:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:07 INFO - Contents: 06:11:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe76915e1aff36d17aecf2a9405100a1741928db27a7317e4d302238aaa60c6a8eae856c4964ad2c800f60994e8523c0cb72ecd066dd9f4b8021df0751333c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4be0a843699c8c6d2b7e9db8a621e202c375105ccfc16f1da6c1b1f7ea51be1546a16de5e44979ba5690fa79928ec9f58194ce9e6f60a7a0f1f94517f67b36b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89f0ebbab3ed17bff8694bde51777cacb4e757736564b0e0f6fd91398397216ecc421e1e0fda4a2627317e466852a2a635f4c77440b0d9307644a22a29c48246"} 06:11:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:07 INFO - Copying logs to upload dir... 06:11:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.318960 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-11-26 06:11:07.183796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 06:11:07.186980) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe76915e1aff36d17aecf2a9405100a1741928db27a7317e4d302238aaa60c6a8eae856c4964ad2c800f60994e8523c0cb72ecd066dd9f4b8021df0751333c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4be0a843699c8c6d2b7e9db8a621e202c375105ccfc16f1da6c1b1f7ea51be1546a16de5e44979ba5690fa79928ec9f58194ce9e6f60a7a0f1f94517f67b36b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89f0ebbab3ed17bff8694bde51777cacb4e757736564b0e0f6fd91398397216ecc421e1e0fda4a2627317e466852a2a635f4c77440b0d9307644a22a29c48246"} build_url:https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/AZNJonSBTLiP9OrN4REmig/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fe76915e1aff36d17aecf2a9405100a1741928db27a7317e4d302238aaa60c6a8eae856c4964ad2c800f60994e8523c0cb72ecd066dd9f4b8021df0751333c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4be0a843699c8c6d2b7e9db8a621e202c375105ccfc16f1da6c1b1f7ea51be1546a16de5e44979ba5690fa79928ec9f58194ce9e6f60a7a0f1f94517f67b36b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89f0ebbab3ed17bff8694bde51777cacb4e757736564b0e0f6fd91398397216ecc421e1e0fda4a2627317e466852a2a635f4c77440b0d9307644a22a29c48246"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 06:11:07.211502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 06:11:07.211800) ========= 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=31acecf42b6a79ec49471d4a000001bb-1480163284.94901-735788773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 06:11:07.297030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 06:11:07.297352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 06:11:07.297698) ========= ========= Total master_lag: 0.17 =========