builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1474495804.93 results: success (0) buildid: 20160921134600 builduid: bdad7249ff614a889ff8473e5ce54914 revision: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:04.926418) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:04.926884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:04.927181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:04.942006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:04.942382) ========= 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=32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 15:10:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-09-21 15:10:05 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093395 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.050970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.051387) ========= 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=32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.102415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.103051) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 94d6bc5adab3d63533f5c5c33df14c7d3f763859 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 94d6bc5adab3d63533f5c5c33df14c7d3f763859 --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=32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 15:10:05,192 truncating revision to first 12 chars 2016-09-21 15:10:05,192 Setting DEBUG logging. 2016-09-21 15:10:05,192 attempt 1/10 2016-09-21 15:10:05,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/94d6bc5adab3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 15:10:05,546 unpacking tar archive at: fx-team-94d6bc5adab3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724150 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.841914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.842265) ========= script_repo_revision: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.842666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.842943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:10:05.852277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-21 15:10:05.852562) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:10:06 INFO - MultiFileLogger online at 20160921 15:10:06 in /builds/slave/test 15:10:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:10:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:06 INFO - {'append_to_log': False, 15:10:06 INFO - 'base_work_dir': '/builds/slave/test', 15:10:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:10:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:06 INFO - 'branch': 'Fx-Team-Non-PGO', 15:10:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:06 INFO - 'config_files': ('talos/linux_config.py',), 15:10:06 INFO - 'default_actions': ('clobber', 15:10:06 INFO - 'read-buildbot-config', 15:10:06 INFO - 'download-and-extract', 15:10:06 INFO - 'populate-webroot', 15:10:06 INFO - 'create-virtualenv', 15:10:06 INFO - 'install', 15:10:06 INFO - 'run-tests'), 15:10:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:06 INFO - 'download_minidump_stackwalk': True, 15:10:06 INFO - 'download_symbols': 'ondemand', 15:10:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:06 INFO - 'installer_path': 'installer.exe', 15:10:06 INFO - 'log_level': 'info', 15:10:06 INFO - 'log_name': 'talos', 15:10:06 INFO - 'log_to_console': True, 15:10:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:10:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:10:06 INFO - 'opt_config_files': (), 15:10:06 INFO - 'pip_index': False, 15:10:06 INFO - 'sps_profile': False, 15:10:06 INFO - 'sps_profile_interval': 0, 15:10:06 INFO - 'suite': 'dromaeojs', 15:10:06 INFO - 'system_bits': '32', 15:10:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:06 INFO - 'title': 'talos-linux64-ix-008', 15:10:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:06 INFO - 'use_talos_json': True, 15:10:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:06 INFO - 'work_dir': 'build'} 15:10:06 INFO - [mozharness: 2016-09-21 22:10:06.030518Z] Running clobber step. 15:10:06 INFO - Running pre-action listener: _resource_record_pre_action 15:10:06 INFO - Running main action method: clobber 15:10:06 INFO - rmtree: /builds/slave/test/build 15:10:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:06 INFO - Running post-action listener: _resource_record_post_action 15:10:06 INFO - [mozharness: 2016-09-21 22:10:06.483060Z] Finished clobber step (success) 15:10:06 INFO - [mozharness: 2016-09-21 22:10:06.483160Z] Running read-buildbot-config step. 15:10:06 INFO - Running pre-action listener: _resource_record_pre_action 15:10:06 INFO - Running main action method: read_buildbot_config 15:10:06 INFO - Using buildbot properties: 15:10:06 INFO - { 15:10:06 INFO - "project": "", 15:10:06 INFO - "product": "firefox", 15:10:06 INFO - "script_repo_revision": "production", 15:10:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:10:06 INFO - "repository": "", 15:10:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:10:06 INFO - "buildid": "20160921134600", 15:10:06 INFO - "pgo_build": "False", 15:10:06 INFO - "basedir": "/builds/slave/test", 15:10:06 INFO - "buildnumber": 2171, 15:10:06 INFO - "slavename": "talos-linux64-ix-008", 15:10:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:10:06 INFO - "platform": "ubuntu64_hw", 15:10:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:10:06 INFO - "branch": "fx-team", 15:10:06 INFO - "repo_path": "integration/fx-team", 15:10:06 INFO - "revision": "94d6bc5adab3d63533f5c5c33df14c7d3f763859", 15:10:06 INFO - "stage_platform": "linux64", 15:10:06 INFO - "builduid": "bdad7249ff614a889ff8473e5ce54914", 15:10:06 INFO - "slavebuilddir": "test" 15:10:06 INFO - } 15:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:10:06 INFO - Running post-action listener: _resource_record_post_action 15:10:06 INFO - [mozharness: 2016-09-21 22:10:06.485606Z] Finished read-buildbot-config step (success) 15:10:06 INFO - [mozharness: 2016-09-21 22:10:06.485695Z] Running download-and-extract step. 15:10:06 INFO - Running pre-action listener: _resource_record_pre_action 15:10:06 INFO - Running main action method: download_and_extract 15:10:06 INFO - mkdir: /builds/slave/test/build/tests 15:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:06 INFO - trying https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:10:07 INFO - Downloaded 1361 bytes. 15:10:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:10:07 INFO - Using the following test package requirements: 15:10:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:10:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:10:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:10:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'jsshell-linux-x86_64.zip'], 15:10:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:10:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:10:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:10:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:10:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:10:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:10:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:10:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:10:07 INFO - Expected file size: 20370891 15:10:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:10:12 INFO - Expected file size: 20370891 15:10:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:10:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:10:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:10:17 INFO - Expected file size: 14414059 15:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:18 INFO - trying https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:10:18 INFO - Downloading https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:10:19 INFO - Downloaded 55598176 bytes. 15:10:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:10:19 INFO - mkdir: /builds/slave/test/properties 15:10:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:19 INFO - Contents: 15:10:19 INFO - build_url:https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:10:19 INFO - Running post-action listener: _resource_record_post_action 15:10:19 INFO - Running post-action listener: set_extra_try_arguments 15:10:19 INFO - [mozharness: 2016-09-21 22:10:19.828996Z] Finished download-and-extract step (success) 15:10:19 INFO - [mozharness: 2016-09-21 22:10:19.829299Z] Running populate-webroot step. 15:10:19 INFO - Running pre-action listener: _resource_record_pre_action 15:10:19 INFO - Running main action method: populate_webroot 15:10:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:19 INFO - '--tppagecycles', 15:10:19 INFO - '7'], 15:10:19 INFO - 'tests': ['tsvgm']}}, 15:10:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['damp', 'tps']}, 15:10:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'tests': ['damp', 'tps']}, 15:10:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['dromaeo_dom']}, 15:10:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['basic_compositor_video']}, 15:10:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:10:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['a11yr', 15:10:19 INFO - 'ts_paint', 15:10:19 INFO - 'tpaint', 15:10:19 INFO - 'sessionrestore', 15:10:19 INFO - 'sessionrestore_no_auto_restore', 15:10:19 INFO - 'tabpaint']}, 15:10:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:19 INFO - 'ts_paint', 15:10:19 INFO - 'tpaint', 15:10:19 INFO - 'sessionrestore', 15:10:19 INFO - 'sessionrestore_no_auto_restore', 15:10:19 INFO - 'tabpaint']}, 15:10:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:10:19 INFO - 'ts_paint', 15:10:19 INFO - 'tpaint', 15:10:19 INFO - 'sessionrestore', 15:10:19 INFO - 'sessionrestore_no_auto_restore', 15:10:19 INFO - 'tabpaint']}, 15:10:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:10:19 INFO - 'ts_paint', 15:10:19 INFO - 'tpaint', 15:10:19 INFO - 'sessionrestore', 15:10:19 INFO - 'sessionrestore_no_auto_restore', 15:10:19 INFO - 'tabpaint']}, 15:10:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['a11yr', 15:10:19 INFO - 'ts_paint', 15:10:19 INFO - 'tpaint', 15:10:19 INFO - 'sessionrestore', 15:10:19 INFO - 'sessionrestore_no_auto_restore', 15:10:19 INFO - 'tabpaint']}, 15:10:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['a11yr', 15:10:19 INFO - 'ts_paint', 15:10:19 INFO - 'tpaint', 15:10:19 INFO - 'sessionrestore', 15:10:19 INFO - 'sessionrestore_no_auto_restore', 15:10:19 INFO - 'tabpaint']}, 15:10:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['tsvgx', 15:10:19 INFO - 'tsvgr_opacity', 15:10:19 INFO - 'tart', 15:10:19 INFO - 'tscrollx', 15:10:19 INFO - 'cart']}, 15:10:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:19 INFO - 'tsvgr_opacity', 15:10:19 INFO - 'tart', 15:10:19 INFO - 'tscrollx', 15:10:19 INFO - 'cart']}, 15:10:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'talos_options': ['--disable-e10s'], 15:10:19 INFO - 'tests': ['tp5o']}, 15:10:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'tests': ['tp5o']}, 15:10:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'talos_options': ['--disable-e10s', 15:10:19 INFO - '--xperf_path', 15:10:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:19 INFO - 'tests': ['tp5n']}, 15:10:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:19 INFO - 'talos_options': ['--xperf_path', 15:10:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:19 INFO - 'tests': ['tp5n']}}, 15:10:19 INFO - 'talos.zip': {'path': '', 15:10:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:19 INFO - Running post-action listener: _resource_record_post_action 15:10:19 INFO - [mozharness: 2016-09-21 22:10:19.852110Z] Finished populate-webroot step (success) 15:10:19 INFO - [mozharness: 2016-09-21 22:10:19.852204Z] Running create-virtualenv step. 15:10:19 INFO - Running pre-action listener: _resource_record_pre_action 15:10:19 INFO - Running main action method: create_virtualenv 15:10:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:19 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 15:10:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:19 INFO - Using real prefix '/usr' 15:10:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:22 INFO - Installing pip.................done. 15:10:22 INFO - Return code: 0 15:10:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:10:22 INFO - Using env: {'DISPLAY': ':0', 15:10:22 INFO - 'HOME': '/home/cltbld', 15:10:22 INFO - 'LANG': 'en_US.UTF-8', 15:10:22 INFO - 'LANGUAGE': 'en_US:en', 15:10:22 INFO - 'LOGNAME': 'cltbld', 15:10:22 INFO - 'MAIL': '/var/mail/cltbld', 15:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:22 INFO - 'MOZ_NO_REMOTE': '1', 15:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:22 INFO - 'NO_EM_RESTART': '1', 15:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:22 INFO - 'PWD': '/builds/slave/test', 15:10:22 INFO - 'SHELL': '/bin/bash', 15:10:22 INFO - 'SHLVL': '1', 15:10:22 INFO - 'TERM': 'linux', 15:10:22 INFO - 'TMOUT': '86400', 15:10:22 INFO - 'USER': 'cltbld', 15:10:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:22 INFO - '_': '/tools/buildbot/bin/python'} 15:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:22 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 15:10:22 INFO - Cleaning up... 15:10:22 INFO - Return code: 0 15:10:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:10:22 INFO - Using env: {'DISPLAY': ':0', 15:10:22 INFO - 'HOME': '/home/cltbld', 15:10:22 INFO - 'LANG': 'en_US.UTF-8', 15:10:22 INFO - 'LANGUAGE': 'en_US:en', 15:10:22 INFO - 'LOGNAME': 'cltbld', 15:10:22 INFO - 'MAIL': '/var/mail/cltbld', 15:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:22 INFO - 'MOZ_NO_REMOTE': '1', 15:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:22 INFO - 'NO_EM_RESTART': '1', 15:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:22 INFO - 'PWD': '/builds/slave/test', 15:10:22 INFO - 'SHELL': '/bin/bash', 15:10:22 INFO - 'SHLVL': '1', 15:10:22 INFO - 'TERM': 'linux', 15:10:22 INFO - 'TMOUT': '86400', 15:10:22 INFO - 'USER': 'cltbld', 15:10:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:22 INFO - '_': '/tools/buildbot/bin/python'} 15:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:22 INFO - Downloading/unpacking psutil>=3.1.1 15:10:22 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 15:10:22 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 15:10:22 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 15:10:22 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 15:10:22 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 15:10:22 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 15:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:24 INFO - Installing collected packages: psutil 15:10:24 INFO - Running setup.py install for psutil 15:10:24 INFO - building 'psutil._psutil_linux' extension 15:10:24 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 15:10:25 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 15:10:25 INFO - building 'psutil._psutil_posix' extension 15:10:25 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 15:10:25 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 15:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:25 INFO - Successfully installed psutil 15:10:25 INFO - Cleaning up... 15:10:25 INFO - Return code: 0 15:10:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:10:25 INFO - Using env: {'DISPLAY': ':0', 15:10:25 INFO - 'HOME': '/home/cltbld', 15:10:25 INFO - 'LANG': 'en_US.UTF-8', 15:10:25 INFO - 'LANGUAGE': 'en_US:en', 15:10:25 INFO - 'LOGNAME': 'cltbld', 15:10:25 INFO - 'MAIL': '/var/mail/cltbld', 15:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:25 INFO - 'MOZ_NO_REMOTE': '1', 15:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:25 INFO - 'NO_EM_RESTART': '1', 15:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:25 INFO - 'PWD': '/builds/slave/test', 15:10:25 INFO - 'SHELL': '/bin/bash', 15:10:25 INFO - 'SHLVL': '1', 15:10:25 INFO - 'TERM': 'linux', 15:10:25 INFO - 'TMOUT': '86400', 15:10:25 INFO - 'USER': 'cltbld', 15:10:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:25 INFO - '_': '/tools/buildbot/bin/python'} 15:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:10:25 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 15:10:25 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 15:10:25 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 15:10:25 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 15:10:25 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 15:10:25 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 15:10:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:10:27 INFO - Installing collected packages: mozsystemmonitor 15:10:27 INFO - Running setup.py install for mozsystemmonitor 15:10:27 INFO - Successfully installed mozsystemmonitor 15:10:27 INFO - Cleaning up... 15:10:27 INFO - Return code: 0 15:10:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:10:27 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')]} 15:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:27 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')]} 15:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:27 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:27 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 15:10:27 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 15:10:27 INFO - Using env: {'DISPLAY': ':0', 15:10:27 INFO - 'HOME': '/home/cltbld', 15:10:27 INFO - 'LANG': 'en_US.UTF-8', 15:10:27 INFO - 'LANGUAGE': 'en_US:en', 15:10:27 INFO - 'LOGNAME': 'cltbld', 15:10:27 INFO - 'MAIL': '/var/mail/cltbld', 15:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:27 INFO - 'MOZ_NO_REMOTE': '1', 15:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:27 INFO - 'NO_EM_RESTART': '1', 15:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:27 INFO - 'PWD': '/builds/slave/test', 15:10:27 INFO - 'SHELL': '/bin/bash', 15:10:27 INFO - 'SHLVL': '1', 15:10:27 INFO - 'TERM': 'linux', 15:10:27 INFO - 'TMOUT': '86400', 15:10:27 INFO - 'USER': 'cltbld', 15:10:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:27 INFO - '_': '/tools/buildbot/bin/python'} 15:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:27 INFO - Downloading/unpacking jsonschema==2.5.1 15:10:27 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 15:10:27 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 15:10:27 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 15:10:27 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 15:10:27 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 15:10:27 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 15:10:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:29 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:30 INFO - warning: no files found matching '*.txt' 15:10:30 INFO - no previously-included directories found matching 'build' 15:10:30 INFO - no previously-included directories found matching 'dist' 15:10:30 INFO - no previously-included directories found matching '.git*' 15:10:30 INFO - Installing collected packages: jsonschema, functools32 15:10:30 INFO - Running setup.py install for functools32 15:10:30 INFO - warning: no files found matching '*.txt' 15:10:30 INFO - no previously-included directories found matching 'build' 15:10:30 INFO - no previously-included directories found matching 'dist' 15:10:30 INFO - no previously-included directories found matching '.git*' 15:10:30 INFO - Successfully installed jsonschema functools32 15:10:30 INFO - Cleaning up... 15:10:30 INFO - Return code: 0 15:10:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:10:30 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')]} 15:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:30 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')]} 15:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:30 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:30 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 15:10:30 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 15:10:30 INFO - Using env: {'DISPLAY': ':0', 15:10:30 INFO - 'HOME': '/home/cltbld', 15:10:30 INFO - 'LANG': 'en_US.UTF-8', 15:10:30 INFO - 'LANGUAGE': 'en_US:en', 15:10:30 INFO - 'LOGNAME': 'cltbld', 15:10:30 INFO - 'MAIL': '/var/mail/cltbld', 15:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:30 INFO - 'MOZ_NO_REMOTE': '1', 15:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:30 INFO - 'NO_EM_RESTART': '1', 15:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:30 INFO - 'PWD': '/builds/slave/test', 15:10:30 INFO - 'SHELL': '/bin/bash', 15:10:30 INFO - 'SHLVL': '1', 15:10:30 INFO - 'TERM': 'linux', 15:10:30 INFO - 'TMOUT': '86400', 15:10:30 INFO - 'USER': 'cltbld', 15:10:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:30 INFO - '_': '/tools/buildbot/bin/python'} 15:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:10:30 INFO - Cleaning up... 15:10:30 INFO - Return code: 0 15:10:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:30 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')]} 15:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:30 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')]} 15:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:30 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:30 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 15:10:30 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 15:10:30 INFO - Using env: {'DISPLAY': ':0', 15:10:30 INFO - 'HOME': '/home/cltbld', 15:10:30 INFO - 'LANG': 'en_US.UTF-8', 15:10:30 INFO - 'LANGUAGE': 'en_US:en', 15:10:30 INFO - 'LOGNAME': 'cltbld', 15:10:30 INFO - 'MAIL': '/var/mail/cltbld', 15:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:30 INFO - 'MOZ_NO_REMOTE': '1', 15:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:30 INFO - 'NO_EM_RESTART': '1', 15:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:30 INFO - 'PWD': '/builds/slave/test', 15:10:30 INFO - 'SHELL': '/bin/bash', 15:10:30 INFO - 'SHLVL': '1', 15:10:30 INFO - 'TERM': 'linux', 15:10:30 INFO - 'TMOUT': '86400', 15:10:30 INFO - 'USER': 'cltbld', 15:10:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:30 INFO - '_': '/tools/buildbot/bin/python'} 15:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:30 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:30 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 15:10:30 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 15:10:30 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 15:10:30 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 15:10:30 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 15:10:30 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 15:10:32 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 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 15:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:33 INFO - Downloading docopt-0.6.1.tar.gz 15:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:33 INFO - Running setup.py install for blobuploader 15:10:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:33 INFO - Running setup.py install for requests 15:10:33 INFO - Running setup.py install for docopt 15:10:33 INFO - Successfully installed blobuploader requests docopt 15:10:33 INFO - Cleaning up... 15:10:33 INFO - Return code: 0 15:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:33 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:33 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 15:10:33 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 15:10:33 INFO - Using env: {'DISPLAY': ':0', 15:10:33 INFO - 'HOME': '/home/cltbld', 15:10:33 INFO - 'LANG': 'en_US.UTF-8', 15:10:33 INFO - 'LANGUAGE': 'en_US:en', 15:10:33 INFO - 'LOGNAME': 'cltbld', 15:10:33 INFO - 'MAIL': '/var/mail/cltbld', 15:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:33 INFO - 'MOZ_NO_REMOTE': '1', 15:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:33 INFO - 'NO_EM_RESTART': '1', 15:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:33 INFO - 'PWD': '/builds/slave/test', 15:10:33 INFO - 'SHELL': '/bin/bash', 15:10:33 INFO - 'SHLVL': '1', 15:10:33 INFO - 'TERM': 'linux', 15:10:33 INFO - 'TMOUT': '86400', 15:10:33 INFO - 'USER': 'cltbld', 15:10:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:33 INFO - '_': '/tools/buildbot/bin/python'} 15:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:34 INFO - Running setup.py (path:/tmp/pip-afgSzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:34 INFO - Running setup.py (path:/tmp/pip-ALABJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:34 INFO - Running setup.py (path:/tmp/pip-B0eM2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:34 INFO - Running setup.py (path:/tmp/pip-oV95qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:34 INFO - Running setup.py (path:/tmp/pip-J7CFqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:34 INFO - Running setup.py (path:/tmp/pip-0AzJlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:34 INFO - Running setup.py (path:/tmp/pip-kS83Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:34 INFO - Running setup.py (path:/tmp/pip-f1mBan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:34 INFO - Running setup.py (path:/tmp/pip-643Hwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:34 INFO - Running setup.py (path:/tmp/pip-1WqzzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:34 INFO - Running setup.py (path:/tmp/pip-XTvY07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:34 INFO - Running setup.py (path:/tmp/pip-BvItfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:35 INFO - Running setup.py (path:/tmp/pip-qu20RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:35 INFO - Running setup.py (path:/tmp/pip-GQtGOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:35 INFO - Running setup.py (path:/tmp/pip-KKOtpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:35 INFO - Running setup.py (path:/tmp/pip-95BVgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:35 INFO - Running setup.py (path:/tmp/pip-75Y_U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:35 INFO - Running setup.py install for manifestparser 15:10:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:35 INFO - Running setup.py install for mozcrash 15:10:35 INFO - Running setup.py install for mozdebug 15:10:35 INFO - Running setup.py install for mozdevice 15:10:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:35 INFO - Running setup.py install for mozfile 15:10:35 INFO - Running setup.py install for mozhttpd 15:10:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for mozinfo 15:10:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for mozInstall 15:10:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for mozleak 15:10:36 INFO - Running setup.py install for mozlog 15:10:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for moznetwork 15:10:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for mozprocess 15:10:36 INFO - Running setup.py install for mozprofile 15:10:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for mozrunner 15:10:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:36 INFO - Running setup.py install for mozscreenshot 15:10:36 INFO - Running setup.py install for moztest 15:10:37 INFO - Running setup.py install for mozversion 15:10:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:37 INFO - Cleaning up... 15:10:37 INFO - Return code: 0 15:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:37 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:37 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 15:10:37 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 15:10:37 INFO - Using env: {'DISPLAY': ':0', 15:10:37 INFO - 'HOME': '/home/cltbld', 15:10:37 INFO - 'LANG': 'en_US.UTF-8', 15:10:37 INFO - 'LANGUAGE': 'en_US:en', 15:10:37 INFO - 'LOGNAME': 'cltbld', 15:10:37 INFO - 'MAIL': '/var/mail/cltbld', 15:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:37 INFO - 'MOZ_NO_REMOTE': '1', 15:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:37 INFO - 'NO_EM_RESTART': '1', 15:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:37 INFO - 'PWD': '/builds/slave/test', 15:10:37 INFO - 'SHELL': '/bin/bash', 15:10:37 INFO - 'SHLVL': '1', 15:10:37 INFO - 'TERM': 'linux', 15:10:37 INFO - 'TMOUT': '86400', 15:10:37 INFO - 'USER': 'cltbld', 15:10:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:37 INFO - '_': '/tools/buildbot/bin/python'} 15:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:37 INFO - Running setup.py (path:/tmp/pip-NARpb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:37 INFO - Running setup.py (path:/tmp/pip-4T2Q9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:37 INFO - Running setup.py (path:/tmp/pip-A81IwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:37 INFO - Running setup.py (path:/tmp/pip-4o0DMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:37 INFO - Running setup.py (path:/tmp/pip-6cxgcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:37 INFO - Running setup.py (path:/tmp/pip-8P5jHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:37 INFO - Running setup.py (path:/tmp/pip-qxvGMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:37 INFO - Running setup.py (path:/tmp/pip-1IIrba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:37 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)) 15:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:37 INFO - Running setup.py (path:/tmp/pip-RB7581-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:38 INFO - Running setup.py (path:/tmp/pip-rXMBPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:38 INFO - Running setup.py (path:/tmp/pip-BJMrxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:38 INFO - Running setup.py (path:/tmp/pip-jaXLus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:38 INFO - Running setup.py (path:/tmp/pip-4OGGin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:38 INFO - Running setup.py (path:/tmp/pip-yHe9mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:38 INFO - Running setup.py (path:/tmp/pip-pMxHIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:38 INFO - Running setup.py (path:/tmp/pip-l1w1W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:38 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)) 15:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:38 INFO - Running setup.py (path:/tmp/pip-C5hfP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:38 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)) 15:10:38 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)) 15:10:38 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)) 15:10:38 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)) 15:10:38 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)) 15:10:38 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)) 15:10:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:38 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 15:10:38 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 15:10:38 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 15:10:38 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 15:10:38 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 15:10:38 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 15:10:41 INFO - Downloading blessings-1.6.tar.gz 15:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:41 INFO - Installing collected packages: blessings 15:10:41 INFO - Running setup.py install for blessings 15:10:41 INFO - Successfully installed blessings 15:10:41 INFO - Cleaning up... 15:10:41 INFO - Return code: 0 15:10:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:41 INFO - Reading from file tmpfile_stdout 15:10:41 INFO - Current package versions: 15:10:41 INFO - argparse == 1.2.1 15:10:41 INFO - blessings == 1.6 15:10:41 INFO - blobuploader == 1.2.4 15:10:41 INFO - docopt == 0.6.1 15:10:41 INFO - functools32 == 3.2.3-2 15:10:41 INFO - jsonschema == 2.5.1 15:10:41 INFO - manifestparser == 1.1 15:10:41 INFO - mozInstall == 1.12 15:10:41 INFO - mozcrash == 0.17 15:10:41 INFO - mozdebug == 0.1 15:10:41 INFO - mozdevice == 0.48 15:10:41 INFO - mozfile == 1.2 15:10:41 INFO - mozhttpd == 0.7 15:10:41 INFO - mozinfo == 0.9 15:10:41 INFO - mozleak == 0.1 15:10:41 INFO - mozlog == 3.4 15:10:41 INFO - moznetwork == 0.27 15:10:41 INFO - mozprocess == 0.23 15:10:41 INFO - mozprofile == 0.28 15:10:41 INFO - mozrunner == 6.12 15:10:41 INFO - mozscreenshot == 0.1 15:10:41 INFO - mozsystemmonitor == 0.3 15:10:41 INFO - moztest == 0.7 15:10:41 INFO - mozversion == 1.4 15:10:41 INFO - psutil == 3.1.1 15:10:41 INFO - requests == 1.2.3 15:10:41 INFO - wsgiref == 0.1.2 15:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:41 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')]} 15:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:41 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')]} 15:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:41 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:41 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 15:10:41 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 15:10:41 INFO - Using env: {'DISPLAY': ':0', 15:10:41 INFO - 'HOME': '/home/cltbld', 15:10:41 INFO - 'LANG': 'en_US.UTF-8', 15:10:41 INFO - 'LANGUAGE': 'en_US:en', 15:10:41 INFO - 'LOGNAME': 'cltbld', 15:10:41 INFO - 'MAIL': '/var/mail/cltbld', 15:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:41 INFO - 'MOZ_NO_REMOTE': '1', 15:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:41 INFO - 'NO_EM_RESTART': '1', 15:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:41 INFO - 'PWD': '/builds/slave/test', 15:10:41 INFO - 'SHELL': '/bin/bash', 15:10:41 INFO - 'SHLVL': '1', 15:10:41 INFO - 'TERM': 'linux', 15:10:41 INFO - 'TMOUT': '86400', 15:10:41 INFO - 'USER': 'cltbld', 15:10:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:41 INFO - '_': '/tools/buildbot/bin/python'} 15:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 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)) 15:10:42 INFO - Cleaning up... 15:10:42 INFO - Return code: 0 15:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10:42 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')]} 15:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:42 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')]} 15:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:42 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 0x7f569f2bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, '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': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', '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 15:10:42 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 15:10:42 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 15:10:42 INFO - Using env: {'DISPLAY': ':0', 15:10:42 INFO - 'HOME': '/home/cltbld', 15:10:42 INFO - 'LANG': 'en_US.UTF-8', 15:10:42 INFO - 'LANGUAGE': 'en_US:en', 15:10:42 INFO - 'LOGNAME': 'cltbld', 15:10:42 INFO - 'MAIL': '/var/mail/cltbld', 15:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:42 INFO - 'MOZ_NO_REMOTE': '1', 15:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:42 INFO - 'NO_EM_RESTART': '1', 15:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:42 INFO - 'PWD': '/builds/slave/test', 15:10:42 INFO - 'SHELL': '/bin/bash', 15:10:42 INFO - 'SHLVL': '1', 15:10:42 INFO - 'TERM': 'linux', 15:10:42 INFO - 'TMOUT': '86400', 15:10:42 INFO - 'USER': 'cltbld', 15:10:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:42 INFO - '_': '/tools/buildbot/bin/python'} 15:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:10:42 INFO - Cleaning up... 15:10:42 INFO - Return code: 0 15:10:42 INFO - Running post-action listener: _resource_record_post_action 15:10:42 INFO - Running post-action listener: _start_resource_monitoring 15:10:42 INFO - Starting resource monitoring. 15:10:42 INFO - [mozharness: 2016-09-21 22:10:42.453712Z] Finished create-virtualenv step (success) 15:10:42 INFO - [mozharness: 2016-09-21 22:10:42.454164Z] Running install step. 15:10:42 INFO - Running pre-action listener: _resource_record_pre_action 15:10:42 INFO - Running main action method: install 15:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:42 INFO - Reading from file tmpfile_stdout 15:10:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:10:42 INFO - Reading from file tmpfile_stdout 15:10:42 INFO - Output received: 15:10:42 INFO - Usage: mozinstall [options] installer 15:10:42 INFO - Options: 15:10:42 INFO - -h, --help show this help message and exit 15:10:42 INFO - -d DEST, --destination=DEST 15:10:42 INFO - Directory to install application into. [default: 15:10:42 INFO - "/builds/slave/test"] 15:10:42 INFO - --app=APP Application being installed. [default: firefox] 15:10:42 INFO - mkdir: /builds/slave/test/build/application 15:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:10:58 INFO - Reading from file tmpfile_stdout 15:10:58 INFO - Output received: 15:10:58 INFO - /builds/slave/test/build/application/firefox/firefox 15:10:58 INFO - Running post-action listener: _resource_record_post_action 15:10:58 INFO - [mozharness: 2016-09-21 22:10:58.806841Z] Finished install step (success) 15:10:58 INFO - [mozharness: 2016-09-21 22:10:58.807084Z] Running run-tests step. 15:10:58 INFO - Running pre-action listener: _resource_record_pre_action 15:10:58 INFO - Running main action method: run_tests 15:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:10:58 INFO - Python 2.7.3 15:10:58 INFO - Return code: 0 15:10:58 INFO - grabbing minidump binary from tooltool 15:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:58 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 0x1626f60>, '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 0x1627d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16281d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:10:58 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 15:10:58 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 15:10:58 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 15:10:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:10:58 INFO - Return code: 0 15:10:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:10:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:10:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:10:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:10:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 15:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 15:10:58 INFO - Using env: {'DISPLAY': ':0', 15:10:58 INFO - 'HOME': '/home/cltbld', 15:10:58 INFO - 'LANG': 'en_US.UTF-8', 15:10:58 INFO - 'LANGUAGE': 'en_US:en', 15:10:58 INFO - 'LOGNAME': 'cltbld', 15:10:58 INFO - 'MAIL': '/var/mail/cltbld', 15:10:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:10:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:58 INFO - 'MOZ_NO_REMOTE': '1', 15:10:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:58 INFO - 'NO_EM_RESTART': '1', 15:10:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:58 INFO - 'PWD': '/builds/slave/test', 15:10:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:10:58 INFO - 'SHELL': '/bin/bash', 15:10:58 INFO - 'SHLVL': '1', 15:10:58 INFO - 'TERM': 'linux', 15:10:58 INFO - 'TMOUT': '86400', 15:10:58 INFO - 'USER': 'cltbld', 15:10:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933', 15:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:58 INFO - '_': '/tools/buildbot/bin/python'} 15:10:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 15:10:59 INFO - mozversion application_buildid: 20160921134600 15:10:59 INFO - mozversion application_changeset: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 15:10:59 INFO - mozversion application_display_name: Nightly 15:10:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:10:59 INFO - mozversion application_name: Firefox 15:10:59 INFO - mozversion application_remotingname: firefox 15:10:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:10:59 INFO - mozversion application_vendor: Mozilla 15:10:59 INFO - mozversion application_version: 52.0a1 15:10:59 INFO - mozversion platform_buildid: 20160921134600 15:10:59 INFO - mozversion platform_changeset: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 15:10:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:10:59 INFO - mozversion platform_version: 52.0a1 15:10:59 INFO - using testdate: 1474495859 15:10:59 INFO - actual date: 1474495859 15:10:59 INFO - starting webserver on 'localhost:49139' 15:10:59 INFO - SUITE-START | Running 2 tests 15:10:59 INFO - TEST-START | dromaeo_css 15:10:59 INFO - operating with platform_type : linux_ 15:10:59 INFO - Initialising browser for dromaeo_css test... 15:10:59 INFO - TEST-INFO | started process 15640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9WQ0J/profile http://localhost:49139/getInfo.html) 15:11:03 INFO - PROCESS | 15640 | __metrics Screen width/height:1600/1200 15:11:03 INFO - PROCESS | 15640 | colorDepth:24 15:11:03 INFO - PROCESS | 15640 | Browser inner width/height: 1024/697 15:11:03 INFO - PROCESS | 15640 | __metrics 15:11:04 INFO - PROCESS | 15640 | 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" 15:11:04 INFO - PROCESS | 15640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:11:04 INFO - PROCESS | 15640 | console.error: PushService: 15:11:04 INFO - PROCESS | 15640 | stateChangeProcessEnqueue: Error transitioning state 15:11:04 INFO - PROCESS | 15640 | UnknownError 15:11:05 INFO - TEST-INFO | 15640: exit 0 15:11:05 INFO - Browser initialized. 15:11:05 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:05 INFO - TEST-INFO | started process 15722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9WQ0J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:17 INFO - PROCESS | 15722 | RSS: Main: 175562752 15:11:17 INFO - PROCESS | 15722 | 15:12:08 INFO - PROCESS | 15722 | 1474495928605 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] 15:14:21 INFO - PROCESS | 15722 | Cycle 1(1): loaded http://localhost:49139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49139/tests/dromaeo/cssquery-ext.html) 15:14:23 INFO - PROCESS | 15722 | RSS: Main: 292712448 15:14:23 INFO - PROCESS | 15722 | 15:17:25 INFO - PROCESS | 15722 | Cycle 1(1): loaded http://localhost:49139/tests/dromaeo/cssquery-ext.html (next: http://localhost:49139/tests/dromaeo/cssquery-jquery.html) 15:17:26 INFO - PROCESS | 15722 | RSS: Main: 275484672 15:17:26 INFO - PROCESS | 15722 | 15:20:28 INFO - PROCESS | 15722 | Cycle 1(1): loaded http://localhost:49139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49139/tests/dromaeo/cssquery-mootools.html) 15:20:29 INFO - PROCESS | 15722 | RSS: Main: 219086848 15:20:29 INFO - PROCESS | 15722 | 15:23:31 INFO - PROCESS | 15722 | Cycle 1(1): loaded http://localhost:49139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49139/tests/dromaeo/cssquery-prototype.html) 15:23:32 INFO - PROCESS | 15722 | RSS: Main: 219619328 15:23:32 INFO - PROCESS | 15722 | 15:26:35 INFO - PROCESS | 15722 | Cycle 1(1): loaded http://localhost:49139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49139/tests/dromaeo/cssquery-yui.html) 15:26:35 INFO - PROCESS | 15722 | RSS: Main: 219336704 15:26:35 INFO - PROCESS | 15722 | 15:29:38 INFO - PROCESS | 15722 | Cycle 1(1): loaded http://localhost:49139/tests/dromaeo/cssquery-yui.html (next: http://localhost:49139/tests/dromaeo/cssquery-dojo.html) 15:29:39 INFO - PROCESS | 15722 | RSS: Main: 283238400 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | __start_tp_report 15:29:39 INFO - PROCESS | 15722 | _x_x_mozilla_page_load 15:29:39 INFO - PROCESS | 15722 | _x_x_mozilla_page_load_details 15:29:39 INFO - PROCESS | 15722 | |i|pagename|runs| 15:29:39 INFO - PROCESS | 15722 | |0;dojo.html;2573.4209802794376;2575.9824869176664;2623.540880345939;2629.539830529658;2639.036751585672;4541.114482675879;4590.311453282009;4653.581177694007;4675.485696573374;4685.203515402377;4626.884327891796;4631.536846315375;4662.11419830232;4684.85945421637;4766.237402015669;4264.78676066197;4284.207421626993;4316.870493885172;4352.695311328208;4370.912581748363;4327.978360108195;4348.260795664744;4394.560543945612;4399.38408622793;4431.357453169288;4362.760048197348;4413.095315460339;4424.977875110604;4452.643788496929;4474.284114541674;4222.366645003243;4259.51015633203;4262.062346283813;4269.807858646368;4294.012377153273;4213.873583792491;4225.19721252961;4232.492100947875;4305.698601097924;4305.698601097924;4601.102784956935;4623.144718227139;4624.190766615862;4641.559051890099;4686.6485013624115;4793.161196790547;4844.806207751686;4921.286413470027;4942.357493525855;4952.8761780955765;5010.974945125251;5024.19612861944;5028.270900719412;5032.924506132411;5064.164412871872;4673.8597842064455;4695.882602934886;4695.882602934954;4696.436427628638;4720.622350211975;4903.681260718042;4965.131102057126;5037.168867136881;5123.769430375642;5157.716325602128;4893.168161412497;4900.877478063006;4903.681260718042;4937.21004639256;4944.085344211332;4975.154223781966;4978.278149668277;4980.427250866197;4980.90038199234;5049.823256186016;4806.639502037361;4860.416749990024;4918.6556941014505;4930.1865192243595;4981.950180498148;4926.852194434101;4967.552920237196;4992.450830408652;4995.925061124086;5005.749712514433;4203.747775133502;4205.76868272248;4209.284421648327;4255.234057869551;4264.552222016644;3681.116532032293;3686.9815650921573;3689.446583012516;3746.4380342948775;3776.263628592398;4223.387608796768;4270.380794784739;4274.764887931132;4283.336082907154;4356.695031347838;4971.403431588233;4976.253561965734;4979.57673597741;5027;5041.395032596112;4312.698111132253;4328.242557552416;4330.761808100522;4400.69195156336;4401.449818772653;4390.824367025283;4431.889202769892;4464.575865292792;4501.954980450154;4509.143262780061;4745.549172828576;4748.572628463455;4788.760561971818;4803.3995750531185;4866.95133048665;5012.874678133076;5026.44709082008;5027.698338099725;5031.6226283029655;5081.3902331718955;4794.2089555223;4817.9518204817505;4819.95180048209;4821.276808478756;4872.780724867319;4734.905301894012;4761.833335833229;4895.877603059952;4917.508249175054;5000.574951129195;5000.549950504472;5008.198688209869;5020.146575082318;5056.82301119459;5080.695158290367;4785.234362501983;4829.2997515359375;4833.154198015403;4858.58702010333;4892.31507588945;4772.212584923449;4818.253170758538;4850.151223535938;4855.465898751064;4923.0153969205585;4761.357216775829;4787.569118779187;4793.352897358952;4851.393575803025;4877.29279254499;4889.193283108248;4904.117258893433;4904.901901961869;4908.435529914105;4964.3298154748645;4680.555347242007;4736.052789442194;4763.904721905473;4805.639577031807;4872.269159625943 15:29:39 INFO - PROCESS | 15722 | |1;ext.html;543.9428859969703;550.2296784501697;553.6954674928788;560.4675558219691;564.8079652918007;24843.875780621092;25332.493350132987;27924.860375698117;38187.236255274875;39086.413703794395;38642.420363694495;39012.414813777745;39046.21907561847;39046.60953390465;39100.21799564014;7498.287662672037;7646.847063058735;7649.617519124049;7651.196624354418;7655;7144.499885008052;7370.557766533998;7388.963055184717;7542.886856697154;7561.584112873789;9201;9459;9473.810523789554;9765.414075155513;9773.51132443375;9501.23990080792;9551.188149007343;9554.378965367297;9571.473568953705;9572.904270957306;7091.645417729144;7331.083614548182;9457.10157535033;9516.38143520669;9525.904740952641;30800.845995769876;31203.843980780177;31258.531122033186;33966.1508462288;33976.49035264473;2843.985780071107;3121.6566177720433;3326.866925322984;3490.7556867133503;3634.545681789776;27462;27592.862035689894;28385.222331671725;28470.430591388056;28484;3510.947335789965;3550.6626870447526;3578.4632305154437;3600.0999750062483;3631.872884449058;276992;277380;277547;279170;279494.99999999796;45469.317960230626;52455;52735;52758.472415275355;52982.73508632509;45228.77385613051;54092;55542;55809.162862557096;60604.69697651572;14502.492412765714;14579.92710036443;14653.706925861423;14678.706425871424;14689.77965330521;10425.895741042645;10463.267571270091;10474.214433917487;10475;10488.68533943983;14990.625234369229;15360.846391536164;15367.465482938987;17004.704364910827;17098.743518847226;5516.3380394352935;6660.6336651484635;6674.72938260249;6700.966495167493;6804.21751498584;743.3569961982846;856.7515420528101;876.0669886570909;889.4307643108416;984.2568860510269;24639.26082217536;26489.470210596064;27098.32254193661;27517.86241068782;27561.31096722598;887.3344991256557;941.6751220828803;956.8564715292762;1004.347174336687;1031.7059638003284;13489.2580908051;14524.346404411615;14681.41274349014;14811.777823332659;14916.477923272634;391518;396247;396783;396959;397524;46623;47313;47586.76206618945;48069.75965120152;48771.512284877404;1083.712816103733;1140.669205930271;1175.160873233387;1179.1745777955293;1181.7163880668577;27225.72774272232;28073.859630701714;28780.280492987844;29218.415631687672;29324.266893326985;41068;41618.375724363555;41682;41706.165876682906;41763.582364177186;319695;321896;358092;362775;368925;33919.15202119967;33956.830215848764;33969;34207.48688769621;34634;41063.43329937564;41572;42592.78703606462;44883;45933.08133837238;34957;34995.65004349924;36497.27005459823;36776.816115919246;37049.6295037057;35450.82274588611;35730.821345893106;35826.64173358233;36029.63970360263;36065.63934360623;34530.65469345274;34559.4816077754;35124.473132903535;35447.468287975185;35647;30369.848150759106;32670.34659306848;32841.67158328386;32910.83544582262;32940;24558.63162052535;24874;25076.74923250744;25142.62286065674;25475.61786573166 15:29:39 INFO - PROCESS | 15722 | |2;jquery.html;346.286649502026;359.9100224943764;366.86426022371717;373.415604578834;376.16866724538767;12215.20601160924;15482.148481833494;15696.293666785008;16314.673706525862;17118;14930.178840163786;15019.92490037551;15198.316075776589;16139;16944.491665250032;4880.4143502779625;5074.898502029957;5075.187969924795;5127.307813445174;5351.170568561879;3332.0836769888233;5322.866928326784;5370.194470829368;5370.624056316059;5376.865578360533;3435.2442462658173;5080.974595127019;5337.2527846101575;5354.384245811742;5446.645968012067;5363.758630861621;5424.783008679668;5437.728113594305;5442.2380866678695;5901.852453688649;5297.894042119175;5300.761465734051;5301.231321458406;5301.893962120775;5302.337207849019;12015.098867584966;12218.755624887452;18773.7183942241;19646.312379066807;19740.901295493575;1671.0475029233342;1719.759233707282;1788.0076557510577;1911.8183772541586;2325.616273314901;8906.02033776284;8960.596773145224;9061.365704400694;9424.575894084783;9550.570224339921;1718.4415065103892;1721.5954250751063;1737.37454516374;1746.9825301746946;1800.6848801459691;69188.96216556756;69953.3004669957;70717.29282707158;70841;72355.27644723591;9761.951190244145;9976.102150806317;10084;10136.138428233535;10147.137493313152;13432.529861454803;13438.798418023738;13448.260345681081;13465.663358415923;13470.326483675777;7144.607046612487;7213;7268.45486588508;7401.777946661608;7413.258674132651;7020.297970202939;7081.362677359062;7282.563046217244;7288.70845166198;7349.338559529561;4037.8788636340955;4142.233686767958;4152.875413737593;4239.830406783756;4268.914621707549;1621.8702503799905;1686.1400685650406;1695.440504633468;1696.414736915762;1710.512503936397;797.7726347990795;810.4569938141459;814.7840822182127;830.6635812495949;913.8081002989313;15510.224488775517;16000.75998860018;16610.50168494947;16732.581685457717;17183.742243866353;802.9277365037058;836.7206491764082;846.1834329871704;870.3863776038005;909.0999910089097;8738.257248133852;9292.907070929205;9535;9584.616615335448;9697.175740062032;416927;418899;419438;419528;428907;79312;80667.59666201631;81740;82482.58758706169;83215.58392208;902;913.356083960806;947.327397547735;950.6435086842434;959.52023988006;15544.06735595868;15756.133412662413;16185.75721364157;16367.634564445809;16560.420385286456;39155.804220978716;39232.80383598064;39359.60640393674;39551.20897581975;39566.802165988986;50709.74645126751;52031.73984130055;52095.73952130215;52641.7367913158;53755.46244537661;6525.804225873231;7163.4269258460245;7267.418606511361;7269.382102521345;7314.305141011595;9168.266538677024;11499;11530.365829879438;11701.824472633087;11840.644780656594;10409.11522520564;10514.211434142317;10655.200859935381;10865.456727163451;10977;9848.950755246178;10110.898891010997;10230.079292863678;10514;10790.352578845295;10473.266871318934;10583.417912014913;10620.309679870783;10954.616588419367;11043.668689939315;6660.067590537232;6672.799816005528;6727.629980350932;6885.104936358442;7330.743423980135;8354.874676879974;10623.89376106229;10900.182486313399;11395.14536409756;11407.714807129889 15:29:39 INFO - PROCESS | 15722 | |3;mootools.html;1211.8969887559556;1244.1353259484656;1325.8408990921089;1384.9307534623267;1645.4652238022645;6405.871882562352;7432.145303290124;7640.159582445934;7661.23387661235;7663.731769388072;7425.777226683194;7488.550686958786;7495.550266983984;7496.100467943855;7501.39988800896;2081.968770468448;2089.6447603907295;2106.631339515586;2109.177420805887;2117.5129720164373;2089.8850563219016;2113.5350222951;2119.703241546185;2119.9894000529976;2126.36209137259;2060.721802556651;2102.211670623516;2102.9474263143393;2113.2075471698113;2113.355426594888;2058.9073491692834;2059.155746144089;2063.6285468615642;2064.040221297089;2066.917323307066;2032.4512381657019;2070.5858828234414;2087.3007542473288;2095.402810199086;2108.652072408066;7062.364387205176;7394.482386232966;7477.289657482531;7490.3633191178815;7496.7750967471065;4306.590873866978;4454.997625534229;4496.865094047183;4497.392851964975;4509.323601459774;2900.5214139666928;3003.0690485949426;3078.1381213260324;3084.98457507711;3096.179512429208;1009.8737657792776;1013.8276492996134;1023.9436830974294;1030.9175265978704;1032.0866033560278;9734.172595329406;9943.502824858728;10120.443375614339;10137;10146.441945692985;3986.6013398660484;4087.938680919729;4113.85601503946;4120.7733574653685;4140.171965606891;8646.3947523674;8647.481151130953;8651.394402391898;8655.740327790176;8671.869921951176;4554.749488778083;4575.336576196433;4580.564846339593;4586.128635559233;4589.816407343669;3202.3595280943905;3484.6689564491335;4090.427340172378;4119.176164767058;4123.381492776108;3534.964650353515;3631.5279013728573;3649.1059690375496;3690.6493883081066;3713.4615480755137;1176.817593273044;1187.631834131422;1192.3203773848995;1197.167968262067;1203.2239205712267;776.1423626892202;800.9719659811879;806.1293802693077;807.1726480357563;822.284612387215;4656.604188644003;4781.282807578891;4839.104765618372;4965.776540055706;5076.36545431821;394.7710328009805;395.566854294547;397.7573680055164;397.7712815131253;399.6602887545563;3079.153232860981;3140.2149462634343;3155.66865479126;3169.8098114113227;3264.3634491274447;9103.408278461879;9329.486878221627;9404.106609872051;9413.199878010446;9440.24478041755;9389.812203755886;9405.811883762286;9405.858912116324;9424.104710052534;9430.858537121949;7130.181803640038;7155.499115062;7205.351518363268;7209.639518024078;7209.711611535585;4855.295982082507;5011.471501192172;5139.511746384088;5159.509846564571;5361.597880159082;8569.871451928351;8650.394472386872;8722.825543488967;8756.299496040428;8764.386492945432;7760.961195193988;8436.915630843612;8815.338849586178;8923.821523569362;8966.148215919477;5576;6374.840628984312;6418.326075762165;6582.473402127723;6591.802245932629;6627.37039981201;7055.400290975119;7120.2167761547225;7120.643967801693;7126.109236345457;6485.416312531895;6521.282658907611;6527.9673601633585;6535.738570457129;6606.4384527315715;6317.589356691984;6323.36766323364;6336.429721325103;6404.551681382259;6422.903656445251;5748;5811.941880581309;5846.912296315644;5849.795257165979;5932.822015339547;4371.453568303962;4417;4467.5755803198645;4474.105178964285;4501.3473046407435;4433.512313645432;4464.464264288306;4540.636749060133;4564.977175114103;4669.276262179367 15:29:39 INFO - PROCESS | 15722 | |4;prototype.html;295.13819646631833;296.0969044414536;300.7654029856712;309.9070278916325;311.08230719377843;4854.732989685566;4901.485344038873;4914;4914.189158788796;4918.532739389757;4531.43357080365;4688.71867687939;4696.389469368977;4705;4850.466448690641;3649.4525821126845;3649.799261040642;3651.7808931464197;3797.1076796952693;3826.349520581508;3804.2011177652726;3809.8666546670734;3822.7515211511163;3822.808859557025;3835.846566137351;3667.0212819091316;3783.3190025795348;3785.9621403785886;3788.1666033472593;3828.9042773930596;3770.245950809849;3775.18833450808;3814.8855534334016;3821.789801560913;3824;3359.3785149747373;3373.224158443572;3379.2734562069027;3384.3908096542614;3390.9321813563593;4724.4330680318235;4728.125296820065;4739.312799644067;4742.834000809989;4763.857084287477;4220.78896055199;4284.5715428457215;4324.740515569076;4334.934975975363;4339.284018137004;4952.653314268003;4976.402831660188;4992.1529034257555;5000.599832047033;5004.5495905368325;3631.654992775682;3638.490026638942;3640.381135207021;3649.288388764192;3652.3425783358985;5114.693118412907;5197.688138711652;5228.712420816853;5286.577073834084;5287.180487024518;3711.498947642088;3717.3494638438165;3717.7769333839515;3726.124360775216;3753.9249215015548;3767.981160094182;3769.1142581493327;3793.336166170909;3800.042977866401;3801.9924719949236;4239.957600424018;4271.466066741657;4273.273543497613;4286.54991225923;4288.52826189119;4868.9756551217015;4953.23224900141;4986.880575755289;5015.122353588107;5032.370953630796;1308.9280089594972;1316.5523721934587;1321.3921596065918;1325.4168166006925;1326.774448343784;827.6565225431378;851.6806197675871;866.8873046503915;894.9015608283083;923.7829110159107;4425.137098265872;4434.733915965053;4437.755923424243;4460.3532487789735;4463.419755431773;5183.885464625124;5189.42916279209;5190.377154741455;5202.323697919246;5222.634415590948;4346.239408103569;4488.214562451623;4512.81948722054;4520.9375796687755;4580.221362368406;2779.3885345224016;2804.2288370697815;2809.3819359740824;2811.959574957279;2815.591739197846;5068.41713202979;5072.365954255718;5076.416212135578;5084.949150508522;5101.336826212643;5090.541851233407;5361.544268737123;5406.91889621656;5411.213225189031;5432.6468779529205;5059.72171530562;5073.828856964397;5080.161773307437;5087.92368114486;5090.887281778095;5253.684778913124;5258.211268309784;5315.574754019592;5326.6537675050995;5345.1447768356875;4874.5856602189215;5074.340335756476;5135.204043373283;5136.5617627064485;5150.871228219325;5016.971520838147;5044.873878153076;5049.6465247432325;5053.469385714447;5056.381957773478;3759.0077259052746;3795.2978698940783;3796.3925771876366;3815.694744420495;3840.4815349927403;5055.16589762685;5169.844904652867;5229.346331708536;5233.3196684432305;5275.340582427197;5011.899762004812;5040.294358789845;5054;5065.265536497113;5074.147936003406;5063.544281014726;5068.113080211022;5077.619178561697;5092.898142037213;5096.311997880239;4744;4948.752562371939;4957.950420495749;4999.425066117443;5027.673201241908;4864.464908860094;4982.2775697524385;5023.497650234947;5146.099432599205;5152.381714194321;4993.902560924493;5020.6234532410945;5025.522575355335;5028.949710502849;5055.090083784954 15:29:39 INFO - PROCESS | 15722 | |5;yui.html;604.0245004318026;624.0202881476084;639.7409049335018;644.5837063563114;660.0268166817574;12936;13936.860631393683;14062.64843378916;14112.082714623555;14239.78640320396;13544.525941592046;13649.522266720667;13696.246706431168;13699.178049317048;13700.040997130205;590.5570821883588;607.6020206764576;732.2677322677323;753.3897542990168;759.582229773625;733.2740586819037;748.6144635512716;752.4807882561042;760.1941941541955;760.4068826315482;804.3364224514769;804.7263930263709;804.9798755031112;805.2832978649008;805.7059173401695;626.8307556959641;642.7075680565332;795.8647030004884;796.1401686178913;796.4862663581986;563.3493315220926;573.4208449466028;575.726529898295;577.7486793244952;579.5218944370869;13079.41142648583;13086.41111149991;13111.737765244738;13113.86886131136;13124.343782810916;12216.938915305456;12703;12714.809277860839;12864.678383040406;13351.866481335159;11721.648350549498;11847.348395838226;11960.58137965167;12030.69923251917;12649.241045537297;3947.624975627311;4065.6950728695465;4068.6338229559483;4071.1043570414463;4096.365063415145;66162.66918665424;67038.32961670369;67178.66410667964;67204.3279567203;67223.3277667222;9852.45811480361;10189.490525473697;10228.386296822215;10262.682335087247;10392.740181495372;19503.122359493856;19548.609027819362;19565.51086222856;19578;19640.803591963897;6750.831229219309;6840.144981877265;6914.412274956584;6981.755638552728;7133.179684336368;3787.7348585598743;3790.962090379116;3795.9240815184094;3820.312343778091;3885.4171874218528;2797.3705916169106;2895.4353900989527;2901.82589044658;2904.477194105039;2904.520754075596;482.7562081148997;495.6158976792942;499.8800287930943;503.36827281761157;515.520565873741;438.5723919178775;476.8783960090224;486.3312944701036;488.12381774714476;498.24018371983016;7571.318581327707;7691.653875575613;7816.57008864518;7866.056073271129;7995.68017279314;433.2310149484627;488.1061481452015;511.53194826733863;522.4931816138339;531.8324727710759;3676.2647470506004;3677.8344974476213;3918.392649139388;3956.9604303956594;4046.59534046593;101994;104321;104648;106547.93452065536;109761;51278.230826537634;83068.58465707753;86887.56556217179;87357.56321218354;87428;75733.621331893;80595;81049.59475202704;82270;83889.16110838935;6904.930950690429;6919.169699636076;6929.3070692930305;6983.476239282176;7209.279072092749;46858.548437898346;47030.294545582525;48742.26886596633;49152;49701;63136.684316578125;66093;71245.28754712387;71250.64374678301;71795.28204718095;9681.128698417177;9753.366031207948;9760.072793084646;9846.655367062118;10129.949350253497;10557.419341936267;10644.574217031543;10812;11080.722981925193;11400.258983166068;9742.512874356113;9792.167665748206;10176.694699159038;10387.896121038693;10395.272330936761;8642.567871606268;8863.689770857989;8889.822203556021;8959.865602015845;8981.326400519856;9621.807563848544;9798.608055677692;9965.381425172456;10204.948975255076;10441.582336706446;7789.532628042336;8139.1453897339925;8301.83396332082;8365.74902752894;8416.98996120445;7424.030387844905;7701.730439434593;7793.610319484116;7829.45193836426;7982.92017079845 15:29:39 INFO - PROCESS | 15722 | __end_tp_report 15:29:39 INFO - PROCESS | 15722 | __start_cc_report 15:29:39 INFO - PROCESS | 15722 | _x_x_mozilla_cycle_collect,1026 15:29:39 INFO - PROCESS | 15722 | __end_cc_report 15:29:39 INFO - PROCESS | 15722 | __startTimestamp1474496979169__endTimestamp 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | ------- Summary: start ------- 15:29:39 INFO - PROCESS | 15722 | Number of tests: 6 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | [#0] dojo.html Cycles:165 Average:4618.24 Median:4766.24 stddev:477.01 (10.0%) stddev-sans-first:450.70 15:29:39 INFO - PROCESS | 15722 | Values: 2573.4 2576.0 2623.5 2629.5 2639.0 4541.1 4590.3 4653.6 4675.5 4685.2 4626.9 4631.5 4662.1 4684.9 4766.2 4264.8 4284.2 4316.9 4352.7 4370.9 4328.0 4348.3 4394.6 4399.4 4431.4 4362.8 4413.1 4425.0 4452.6 4474.3 4222.4 4259.5 4262.1 4269.8 4294.0 4213.9 4225.2 4232.5 4305.7 4305.7 4601.1 4623.1 4624.2 4641.6 4686.6 4793.2 4844.8 4921.3 4942.4 4952.9 5011.0 5024.2 5028.3 5032.9 5064.2 4673.9 4695.9 4695.9 4696.4 4720.6 4903.7 4965.1 5037.2 5123.8 5157.7 4893.2 4900.9 4903.7 4937.2 4944.1 4975.2 4978.3 4980.4 4980.9 5049.8 4806.6 4860.4 4918.7 4930.2 4982.0 4926.9 4967.6 4992.5 4995.9 5005.7 4203.7 4205.8 4209.3 4255.2 4264.6 3681.1 3687.0 3689.4 3746.4 3776.3 4223.4 4270.4 4274.8 4283.3 4356.7 4971.4 4976.3 4979.6 5027.0 5041.4 4312.7 4328.2 4330.8 4400.7 4401.4 4390.8 4431.9 4464.6 4502.0 4509.1 4745.5 4748.6 4788.8 4803.4 4867.0 5012.9 5026.4 5027.7 5031.6 5081.4 4794.2 4818.0 4820.0 4821.3 4872.8 4734.9 4761.8 4895.9 4917.5 5000.6 5000.5 5008.2 5020.1 5056.8 5080.7 4785.2 4829.3 4833.2 4858.6 4892.3 4772.2 4818.3 4850.2 4855.5 4923.0 4761.4 4787.6 4793.4 4851.4 4877.3 4889.2 4904.1 4904.9 4908.4 4964.3 4680.6 4736.1 4763.9 4805.6 4872.3 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | [#1] ext.html Cycles:180 Average:48813.30 Median:19814.87 stddev:90595.60 (457.2%) stddev-sans-first:90777.25 15:29:39 INFO - PROCESS | 15722 | Values: 543.9 550.2 553.7 560.5 564.8 24843.9 25332.5 27924.9 38187.2 39086.4 38642.4 39012.4 39046.2 39046.6 39100.2 7498.3 7646.8 7649.6 7651.2 7655.0 7144.5 7370.6 7389.0 7542.9 7561.6 9201.0 9459.0 9473.8 9765.4 9773.5 9501.2 9551.2 9554.4 9571.5 9572.9 7091.6 7331.1 9457.1 9516.4 9525.9 30800.8 31203.8 31258.5 33966.2 33976.5 2844.0 3121.7 3326.9 3490.8 3634.5 27462.0 27592.9 28385.2 28470.4 28484.0 3510.9 3550.7 3578.5 3600.1 3631.9 276992.0 277380.0 277547.0 279170.0 279495.0 45469.3 52455.0 52735.0 52758.5 52982.7 45228.8 54092.0 55542.0 55809.2 60604.7 14502.5 14579.9 14653.7 14678.7 14689.8 10425.9 10463.3 10474.2 10475.0 10488.7 14990.6 15360.8 15367.5 17004.7 17098.7 5516.3 6660.6 6674.7 6701.0 6804.2 743.4 856.8 876.1 889.4 984.3 24639.3 26489.5 27098.3 27517.9 27561.3 887.3 941.7 956.9 1004.3 1031.7 13489.3 14524.3 14681.4 14811.8 14916.5 391518.0 396247.0 396783.0 396959.0 397524.0 46623.0 47313.0 47586.8 48069.8 48771.5 1083.7 1140.7 1175.2 1179.2 1181.7 27225.7 28073.9 28780.3 29218.4 29324.3 41068.0 41618.4 41682.0 41706.2 41763.6 319695.0 321896.0 358092.0 362775.0 368925.0 33919.2 33956.8 33969.0 34207.5 34634.0 41063.4 41572.0 42592.8 44883.0 45933.1 34957.0 34995.7 36497.3 36776.8 37049.6 35450.8 35730.8 35826.6 36029.6 36065.6 34530.7 34559.5 35124.5 35447.5 35647.0 30369.8 32670.3 32841.7 32910.8 32940.0 24558.6 24874.0 25076.7 25142.6 25475.6 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | [#2] jquery.html Cycles:180 Average:25182.86 Median:216587.96 stddev:69477.15 (32.1%) stddev-sans-first:69647.02 15:29:39 INFO - PROCESS | 15722 | Values: 346.3 359.9 366.9 373.4 376.2 12215.2 15482.1 15696.3 16314.7 17118.0 14930.2 15019.9 15198.3 16139.0 16944.5 4880.4 5074.9 5075.2 5127.3 5351.2 3332.1 5322.9 5370.2 5370.6 5376.9 3435.2 5081.0 5337.3 5354.4 5446.6 5363.8 5424.8 5437.7 5442.2 5901.9 5297.9 5300.8 5301.2 5301.9 5302.3 12015.1 12218.8 18773.7 19646.3 19740.9 1671.0 1719.8 1788.0 1911.8 2325.6 8906.0 8960.6 9061.4 9424.6 9550.6 1718.4 1721.6 1737.4 1747.0 1800.7 69189.0 69953.3 70717.3 70841.0 72355.3 9762.0 9976.1 10084.0 10136.1 10147.1 13432.5 13438.8 13448.3 13465.7 13470.3 7144.6 7213.0 7268.5 7401.8 7413.3 7020.3 7081.4 7282.6 7288.7 7349.3 4037.9 4142.2 4152.9 4239.8 4268.9 1621.9 1686.1 1695.4 1696.4 1710.5 797.8 810.5 814.8 830.7 913.8 15510.2 16000.8 16610.5 16732.6 17183.7 802.9 836.7 846.2 870.4 909.1 8738.3 9292.9 9535.0 9584.6 9697.2 416927.0 418899.0 419438.0 419528.0 428907.0 79312.0 80667.6 81740.0 82482.6 83215.6 902.0 913.4 947.3 950.6 959.5 15544.1 15756.1 16185.8 16367.6 16560.4 39155.8 39232.8 39359.6 39551.2 39566.8 50709.7 52031.7 52095.7 52641.7 53755.5 6525.8 7163.4 7267.4 7269.4 7314.3 9168.3 11499.0 11530.4 11701.8 11840.6 10409.1 10514.2 10655.2 10865.5 10977.0 9849.0 10110.9 10230.1 10514.0 10790.4 10473.3 10583.4 10620.3 10954.6 11043.7 6660.1 6672.8 6727.6 6885.1 7330.7 8354.9 10623.9 10900.2 11395.1 11407.7 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | [#3] mootools.html Cycles:180 Average:4919.39 Median:4587.97 stddev:2765.89 (60.3%) stddev-sans-first:2759.61 15:29:39 INFO - PROCESS | 15722 | Values: 1211.9 1244.1 1325.8 1384.9 1645.5 6405.9 7432.1 7640.2 7661.2 7663.7 7425.8 7488.6 7495.6 7496.1 7501.4 2082.0 2089.6 2106.6 2109.2 2117.5 2089.9 2113.5 2119.7 2120.0 2126.4 2060.7 2102.2 2102.9 2113.2 2113.4 2058.9 2059.2 2063.6 2064.0 2066.9 2032.5 2070.6 2087.3 2095.4 2108.7 7062.4 7394.5 7477.3 7490.4 7496.8 4306.6 4455.0 4496.9 4497.4 4509.3 2900.5 3003.1 3078.1 3085.0 3096.2 1009.9 1013.8 1023.9 1030.9 1032.1 9734.2 9943.5 10120.4 10137.0 10146.4 3986.6 4087.9 4113.9 4120.8 4140.2 8646.4 8647.5 8651.4 8655.7 8671.9 4554.7 4575.3 4580.6 4586.1 4589.8 3202.4 3484.7 4090.4 4119.2 4123.4 3535.0 3631.5 3649.1 3690.6 3713.5 1176.8 1187.6 1192.3 1197.2 1203.2 776.1 801.0 806.1 807.2 822.3 4656.6 4781.3 4839.1 4965.8 5076.4 394.8 395.6 397.8 397.8 399.7 3079.2 3140.2 3155.7 3169.8 3264.4 9103.4 9329.5 9404.1 9413.2 9440.2 9389.8 9405.8 9405.9 9424.1 9430.9 7130.2 7155.5 7205.4 7209.6 7209.7 4855.3 5011.5 5139.5 5159.5 5361.6 8569.9 8650.4 8722.8 8756.3 8764.4 7761.0 8436.9 8815.3 8923.8 8966.1 5576.0 6374.8 6418.3 6582.5 6591.8 6627.4 7055.4 7120.2 7120.6 7126.1 6485.4 6521.3 6528.0 6535.7 6606.4 6317.6 6323.4 6336.4 6404.6 6422.9 5748.0 5811.9 5846.9 5849.8 5932.8 4371.5 4417.0 4467.6 4474.1 4501.3 4433.5 4464.5 4540.6 4565.0 4669.3 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | [#4] prototype.html Cycles:180 Average:4227.53 Median:4852.60 stddev:1219.15 (25.1%) stddev-sans-first:1186.30 15:29:39 INFO - PROCESS | 15722 | Values: 295.1 296.1 300.8 309.9 311.1 4854.7 4901.5 4914.0 4914.2 4918.5 4531.4 4688.7 4696.4 4705.0 4850.5 3649.5 3649.8 3651.8 3797.1 3826.3 3804.2 3809.9 3822.8 3822.8 3835.8 3667.0 3783.3 3786.0 3788.2 3828.9 3770.2 3775.2 3814.9 3821.8 3824.0 3359.4 3373.2 3379.3 3384.4 3390.9 4724.4 4728.1 4739.3 4742.8 4763.9 4220.8 4284.6 4324.7 4334.9 4339.3 4952.7 4976.4 4992.2 5000.6 5004.5 3631.7 3638.5 3640.4 3649.3 3652.3 5114.7 5197.7 5228.7 5286.6 5287.2 3711.5 3717.3 3717.8 3726.1 3753.9 3768.0 3769.1 3793.3 3800.0 3802.0 4240.0 4271.5 4273.3 4286.5 4288.5 4869.0 4953.2 4986.9 5015.1 5032.4 1308.9 1316.6 1321.4 1325.4 1326.8 827.7 851.7 866.9 894.9 923.8 4425.1 4434.7 4437.8 4460.4 4463.4 5183.9 5189.4 5190.4 5202.3 5222.6 4346.2 4488.2 4512.8 4520.9 4580.2 2779.4 2804.2 2809.4 2812.0 2815.6 5068.4 5072.4 5076.4 5084.9 5101.3 5090.5 5361.5 5406.9 5411.2 5432.6 5059.7 5073.8 5080.2 5087.9 5090.9 5253.7 5258.2 5315.6 5326.7 5345.1 4874.6 5074.3 5135.2 5136.6 5150.9 5017.0 5044.9 5049.6 5053.5 5056.4 3759.0 3795.3 3796.4 3815.7 3840.5 5055.2 5169.8 5229.3 5233.3 5275.3 5011.9 5040.3 5054.0 5065.3 5074.1 5063.5 5068.1 5077.6 5092.9 5096.3 4744.0 4948.8 4958.0 4999.4 5027.7 4864.5 4982.3 5023.5 5146.1 5152.4 4993.9 5020.6 5025.5 5028.9 5055.1 15:29:39 INFO - PROCESS | 15722 | 15:29:39 INFO - PROCESS | 15722 | [#5] yui.html Cycles:180 Average:18114.70 Median:547.59 stddev:26970.51 (4925.3%) stddev-sans-first:27014.13 15:29:39 INFO - PROCESS | 15722 | Values: 604.0 624.0 639.7 644.6 660.0 12936.0 13936.9 14062.6 14112.1 14239.8 13544.5 13649.5 13696.2 13699.2 13700.0 590.6 607.6 732.3 753.4 759.6 733.3 748.6 752.5 760.2 760.4 804.3 804.7 805.0 805.3 805.7 626.8 642.7 795.9 796.1 796.5 563.3 573.4 575.7 577.7 579.5 13079.4 13086.4 13111.7 13113.9 13124.3 12216.9 12703.0 12714.8 12864.7 13351.9 11721.6 11847.3 11960.6 12030.7 12649.2 3947.6 4065.7 4068.6 4071.1 4096.4 66162.7 67038.3 67178.7 67204.3 67223.3 9852.5 10189.5 10228.4 10262.7 10392.7 19503.1 19548.6 19565.5 19578.0 19640.8 6750.8 6840.1 6914.4 6981.8 7133.2 3787.7 3791.0 3795.9 3820.3 3885.4 2797.4 2895.4 2901.8 2904.5 2904.5 482.8 495.6 499.9 503.4 515.5 438.6 476.9 486.3 488.1 498.2 7571.3 7691.7 7816.6 7866.1 7995.7 433.2 488.1 511.5 522.5 531.8 3676.3 3677.8 3918.4 3957.0 4046.6 101994.0 104321.0 104648.0 106547.9 109761.0 51278.2 83068.6 86887.6 87357.6 87428.0 75733.6 80595.0 81049.6 82270.0 83889.2 6904.9 6919.2 6929.3 6983.5 7209.3 46858.5 47030.3 48742.3 49152.0 49701.0 63136.7 66093.0 71245.3 71250.6 71795.3 9681.1 9753.4 9760.1 9846.7 10129.9 10557.4 10644.6 10812.0 11080.7 11400.3 9742.5 9792.2 10176.7 10387.9 10395.3 8642.6 8863.7 8889.8 8959.9 8981.3 9621.8 9798.6 9965.4 10204.9 10441.6 7789.5 8139.1 8301.8 8365.7 8417.0 7424.0 7701.7 7793.6 7829.5 7982.9 15:29:39 INFO - PROCESS | 15722 | -------- Summary: end -------- 15:29:39 INFO - PROCESS | 15722 | 15:29:40 INFO - TEST-INFO | 15722: exit 0 15:29:40 INFO - TEST-OK | dromaeo_css | took 1121091ms 15:29:40 INFO - TEST-START | kraken 15:29:40 INFO - operating with platform_type : linux_ 15:29:40 INFO - Initialising browser for kraken test... 15:29:40 INFO - TEST-INFO | started process 16030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytNTrp/profile http://localhost:49139/getInfo.html) 15:29:44 INFO - PROCESS | 16030 | __metrics Screen width/height:1600/1200 15:29:44 INFO - PROCESS | 16030 | colorDepth:24 15:29:44 INFO - PROCESS | 16030 | Browser inner width/height: 1024/697 15:29:44 INFO - PROCESS | 16030 | __metrics 15:29:45 INFO - PROCESS | 16030 | 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" 15:29:45 INFO - PROCESS | 16030 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:45 INFO - PROCESS | 16030 | console.error: PushService: 15:29:45 INFO - PROCESS | 16030 | stateChangeProcessEnqueue: Error transitioning state 15:29:45 INFO - PROCESS | 16030 | UnknownError 15:29:46 INFO - TEST-INFO | 16030: exit 0 15:29:46 INFO - Browser initialized. 15:29:46 INFO - Running cycle 1/1 for kraken test... 15:29:46 INFO - TEST-INFO | started process 16112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytNTrp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:58 INFO - PROCESS | 16112 | RSS: Main: 174907392 15:29:58 INFO - PROCESS | 16112 | 15:30:01 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49139/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:02 INFO - PROCESS | 16112 | RSS: Main: 233725952 15:30:02 INFO - PROCESS | 16112 | 15:30:05 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49139/tests/kraken/driver.html?testName=audio-dft) 15:30:05 INFO - PROCESS | 16112 | RSS: Main: 218226688 15:30:05 INFO - PROCESS | 16112 | 15:30:08 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49139/tests/kraken/driver.html?testName=audio-fft) 15:30:09 INFO - PROCESS | 16112 | RSS: Main: 300142592 15:30:09 INFO - PROCESS | 16112 | 15:30:11 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49139/tests/kraken/driver.html?testName=audio-oscillator) 15:30:12 INFO - PROCESS | 16112 | RSS: Main: 209801216 15:30:12 INFO - PROCESS | 16112 | 15:30:14 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:15 INFO - PROCESS | 16112 | RSS: Main: 213581824 15:30:15 INFO - PROCESS | 16112 | 15:30:18 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49139/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:19 INFO - PROCESS | 16112 | RSS: Main: 250126336 15:30:19 INFO - PROCESS | 16112 | 15:30:22 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49139/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:23 INFO - PROCESS | 16112 | RSS: Main: 244539392 15:30:23 INFO - PROCESS | 16112 | 15:30:26 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49139/tests/kraken/driver.html?testName=json-parse-financial) 15:30:26 INFO - PROCESS | 16112 | RSS: Main: 247705600 15:30:26 INFO - PROCESS | 16112 | 15:30:28 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:29 INFO - PROCESS | 16112 | RSS: Main: 210866176 15:30:29 INFO - PROCESS | 16112 | 15:30:31 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:31 INFO - PROCESS | 16112 | RSS: Main: 217608192 15:30:31 INFO - PROCESS | 16112 | 15:30:33 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:34 INFO - PROCESS | 16112 | RSS: Main: 222044160 15:30:34 INFO - PROCESS | 16112 | 15:30:37 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:37 INFO - PROCESS | 16112 | RSS: Main: 222953472 15:30:37 INFO - PROCESS | 16112 | 15:30:40 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:41 INFO - PROCESS | 16112 | RSS: Main: 221052928 15:30:41 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | Cycle 1(1): loaded http://localhost:49139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49139/tests/kraken/driver.html?testName=ai-astar) 15:30:43 INFO - PROCESS | 16112 | RSS: Main: 273506304 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | __start_tp_report 15:30:43 INFO - PROCESS | 16112 | _x_x_mozilla_page_load 15:30:43 INFO - PROCESS | 16112 | _x_x_mozilla_page_load_details 15:30:43 INFO - PROCESS | 16112 | |i|pagename|runs| 15:30:43 INFO - PROCESS | 16112 | |0;ai-astar;112;115;114;116;114;116;117;117;115;114 15:30:43 INFO - PROCESS | 16112 | |1;audio-beat-detection;162;128;132;183;128;125;134;130;163;128 15:30:43 INFO - PROCESS | 16112 | |2;audio-dft;162;161;162;165;161;161;162;161;163;161 15:30:43 INFO - PROCESS | 16112 | |3;audio-fft;75;76;76;111;76;76;77;77;107;77 15:30:43 INFO - PROCESS | 16112 | |4;audio-oscillator;85;84;127;84;84;85;119;84;86;121 15:30:43 INFO - PROCESS | 16112 | |5;imaging-gaussian-blur;117;116;117;118;118;117;117;117;117;117 15:30:43 INFO - PROCESS | 16112 | |6;imaging-darkroom;147;146;147;146;147;148;147;147;146;146 15:30:43 INFO - PROCESS | 16112 | |7;imaging-desaturate;95;96;96;96;95;96;95;96;97;95 15:30:43 INFO - PROCESS | 16112 | |8;json-parse-financial;66;62;72;63;65;65;64;64;64;64 15:30:43 INFO - PROCESS | 16112 | |9;json-stringify-tinderbox;66;66;66;66;75;69;65;66;66;66 15:30:43 INFO - PROCESS | 16112 | |10;stanford-crypto-aes;82;81;83;83;83;82;82;85;82;81 15:30:43 INFO - PROCESS | 16112 | |11;stanford-crypto-ccm;147;136;143;133;131;134;133;135;175;140 15:30:43 INFO - PROCESS | 16112 | |12;stanford-crypto-pbkdf2;180;174;173;174;172;175;174;172;175;177 15:30:43 INFO - PROCESS | 16112 | |13;stanford-crypto-sha256-iterative;69;68;69;71;68;68;70;68;68;68 15:30:43 INFO - PROCESS | 16112 | __end_tp_report 15:30:43 INFO - PROCESS | 16112 | __start_cc_report 15:30:43 INFO - PROCESS | 16112 | _x_x_mozilla_cycle_collect,1921 15:30:43 INFO - PROCESS | 16112 | __end_cc_report 15:30:43 INFO - PROCESS | 16112 | __startTimestamp1474497043573__endTimestamp 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | ------- Summary: start ------- 15:30:43 INFO - PROCESS | 16112 | Number of tests: 14 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.50 stddev:1.56 (1.4%) stddev-sans-first:1.22 15:30:43 INFO - PROCESS | 16112 | Values: 112.0 115.0 114.0 116.0 114.0 116.0 117.0 117.0 115.0 114.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:133.00 stddev:20.28 (15.2%) stddev-sans-first:20.08 15:30:43 INFO - PROCESS | 16112 | Values: 162.0 128.0 132.0 183.0 128.0 125.0 134.0 130.0 163.0 128.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 15:30:43 INFO - PROCESS | 16112 | Values: 162.0 161.0 162.0 165.0 161.0 161.0 162.0 161.0 163.0 161.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.85 (18.2%) stddev-sans-first:14.40 15:30:43 INFO - PROCESS | 16112 | Values: 75.0 76.0 76.0 111.0 76.0 76.0 77.0 77.0 107.0 77.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:18.36 (21.9%) stddev-sans-first:19.04 15:30:43 INFO - PROCESS | 16112 | Values: 85.0 84.0 127.0 84.0 84.0 85.0 119.0 84.0 86.0 121.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:30:43 INFO - PROCESS | 16112 | Values: 117.0 116.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:30:43 INFO - PROCESS | 16112 | Values: 147.0 146.0 147.0 146.0 147.0 148.0 147.0 147.0 146.0 146.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:30:43 INFO - PROCESS | 16112 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 97.0 95.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:2.73 (4.2%) stddev-sans-first:2.86 15:30:43 INFO - PROCESS | 16112 | Values: 66.0 62.0 72.0 63.0 65.0 65.0 64.0 64.0 64.0 64.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:66.00 stddev:2.96 (4.5%) stddev-sans-first:3.11 15:30:43 INFO - PROCESS | 16112 | Values: 66.0 66.0 66.0 66.0 75.0 69.0 65.0 66.0 66.0 66.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 15:30:43 INFO - PROCESS | 16112 | Values: 82.0 81.0 83.0 83.0 83.0 82.0 82.0 85.0 82.0 81.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:138.00 stddev:13.06 (9.5%) stddev-sans-first:13.65 15:30:43 INFO - PROCESS | 16112 | Values: 147.0 136.0 143.0 133.0 131.0 134.0 133.0 135.0 175.0 140.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:174.50 stddev:2.41 (1.4%) stddev-sans-first:1.58 15:30:43 INFO - PROCESS | 16112 | Values: 180.0 174.0 173.0 174.0 172.0 175.0 174.0 172.0 175.0 177.0 15:30:43 INFO - PROCESS | 16112 | 15:30:43 INFO - PROCESS | 16112 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.06 (1.5%) stddev-sans-first:1.12 15:30:43 INFO - PROCESS | 16112 | Values: 69.0 68.0 69.0 71.0 68.0 68.0 70.0 68.0 68.0 68.0 15:30:43 INFO - PROCESS | 16112 | -------- Summary: end -------- 15:30:43 INFO - PROCESS | 16112 | 15:30:45 INFO - TEST-INFO | 16112: exit 0 15:30:45 INFO - TEST-OK | kraken | took 65026ms 15:30:45 INFO - SUITE-END | took 1186s 15:30:45 INFO - Completed test suite (00:19:46) 15:30:45 INFO - javascript benchmark 15:30:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.4209802794376, 2575.9824869176664, 2623.540880345939, 2629.539830529658, 2639.036751585672, 4541.114482675879, 4590.311453282009, 4653.581177694007, 4675.485696573374, 4685.203515402377, 4626.884327891796, 4631.536846315375, 4662.11419830232, 4684.85945421637, 4766.237402015669, 4264.78676066197, 4284.207421626993, 4316.870493885172, 4352.695311328208, 4370.912581748363, 4327.978360108195, 4348.260795664744, 4394.560543945612, 4399.38408622793, 4431.357453169288, 4362.760048197348, 4413.095315460339, 4424.977875110604, 4452.643788496929, 4474.284114541674, 4222.366645003243, 4259.51015633203, 4262.062346283813, 4269.807858646368, 4294.012377153273, 4213.873583792491, 4225.19721252961, 4232.492100947875, 4305.698601097924, 4305.698601097924, 4601.102784956935, 4623.144718227139, 4624.190766615862, 4641.559051890099, 4686.6485013624115, 4793.161196790547, 4844.806207751686, 4921.286413470027, 4942.357493525855, 4952.8761780955765, 5010.974945125251, 5024.19612861944, 5028.270900719412, 5032.924506132411, 5064.164412871872, 4673.8597842064455, 4695.882602934886, 4695.882602934954, 4696.436427628638, 4720.622350211975, 4903.681260718042, 4965.131102057126, 5037.168867136881, 5123.769430375642, 5157.716325602128, 4893.168161412497, 4900.877478063006, 4903.681260718042, 4937.21004639256, 4944.085344211332, 4975.154223781966, 4978.278149668277, 4980.427250866197, 4980.90038199234, 5049.823256186016, 4806.639502037361, 4860.416749990024, 4918.6556941014505, 4930.1865192243595, 4981.950180498148, 4926.852194434101, 4967.552920237196, 4992.450830408652, 4995.925061124086, 5005.749712514433, 4203.747775133502, 4205.76868272248, 4209.284421648327, 4255.234057869551, 4264.552222016644, 3681.116532032293, 3686.9815650921573, 3689.446583012516, 3746.4380342948775, 3776.263628592398, 4223.387608796768, 4270.380794784739, 4274.764887931132, 4283.336082907154, 4356.695031347838, 4971.403431588233, 4976.253561965734, 4979.57673597741, 5027.0, 5041.395032596112, 4312.698111132253, 4328.242557552416, 4330.761808100522, 4400.69195156336, 4401.449818772653, 4390.824367025283, 4431.889202769892, 4464.575865292792, 4501.954980450154, 4509.143262780061, 4745.549172828576, 4748.572628463455, 4788.760561971818, 4803.3995750531185, 4866.95133048665, 5012.874678133076, 5026.44709082008, 5027.698338099725, 5031.6226283029655, 5081.3902331718955, 4794.2089555223, 4817.9518204817505, 4819.95180048209, 4821.276808478756, 4872.780724867319, 4734.905301894012, 4761.833335833229, 4895.877603059952, 4917.508249175054, 5000.574951129195, 5000.549950504472, 5008.198688209869, 5020.146575082318, 5056.82301119459, 5080.695158290367, 4785.234362501983, 4829.2997515359375, 4833.154198015403, 4858.58702010333, 4892.31507588945, 4772.212584923449, 4818.253170758538, 4850.151223535938, 4855.465898751064, 4923.0153969205585, 4761.357216775829, 4787.569118779187, 4793.352897358952, 4851.393575803025, 4877.29279254499, 4889.193283108248, 4904.117258893433, 4904.901901961869, 4908.435529914105, 4964.3298154748645, 4680.555347242007, 4736.052789442194, 4763.904721905473, 4805.639577031807, 4872.269159625943], "value": 4588.017159122211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9428859969703, 550.2296784501697, 553.6954674928788, 560.4675558219691, 564.8079652918007, 24843.875780621092, 25332.493350132987, 27924.860375698117, 38187.236255274875, 39086.413703794395, 38642.420363694495, 39012.414813777745, 39046.21907561847, 39046.60953390465, 39100.21799564014, 7498.287662672037, 7646.847063058735, 7649.617519124049, 7651.196624354418, 7655.0, 7144.499885008052, 7370.557766533998, 7388.963055184717, 7542.886856697154, 7561.584112873789, 9201.0, 9459.0, 9473.810523789554, 9765.414075155513, 9773.51132443375, 9501.23990080792, 9551.188149007343, 9554.378965367297, 9571.473568953705, 9572.904270957306, 7091.645417729144, 7331.083614548182, 9457.10157535033, 9516.38143520669, 9525.904740952641, 30800.845995769876, 31203.843980780177, 31258.531122033186, 33966.1508462288, 33976.49035264473, 2843.985780071107, 3121.6566177720433, 3326.866925322984, 3490.7556867133503, 3634.545681789776, 27462.0, 27592.862035689894, 28385.222331671725, 28470.430591388056, 28484.0, 3510.947335789965, 3550.6626870447526, 3578.4632305154437, 3600.0999750062483, 3631.872884449058, 276992.0, 277380.0, 277547.0, 279170.0, 279494.99999999796, 45469.317960230626, 52455.0, 52735.0, 52758.472415275355, 52982.73508632509, 45228.77385613051, 54092.0, 55542.0, 55809.162862557096, 60604.69697651572, 14502.492412765714, 14579.92710036443, 14653.706925861423, 14678.706425871424, 14689.77965330521, 10425.895741042645, 10463.267571270091, 10474.214433917487, 10475.0, 10488.68533943983, 14990.625234369229, 15360.846391536164, 15367.465482938987, 17004.704364910827, 17098.743518847226, 5516.3380394352935, 6660.6336651484635, 6674.72938260249, 6700.966495167493, 6804.21751498584, 743.3569961982846, 856.7515420528101, 876.0669886570909, 889.4307643108416, 984.2568860510269, 24639.26082217536, 26489.470210596064, 27098.32254193661, 27517.86241068782, 27561.31096722598, 887.3344991256557, 941.6751220828803, 956.8564715292762, 1004.347174336687, 1031.7059638003284, 13489.2580908051, 14524.346404411615, 14681.41274349014, 14811.777823332659, 14916.477923272634, 391518.0, 396247.0, 396783.0, 396959.0, 397524.0, 46623.0, 47313.0, 47586.76206618945, 48069.75965120152, 48771.512284877404, 1083.712816103733, 1140.669205930271, 1175.160873233387, 1179.1745777955293, 1181.7163880668577, 27225.72774272232, 28073.859630701714, 28780.280492987844, 29218.415631687672, 29324.266893326985, 41068.0, 41618.375724363555, 41682.0, 41706.165876682906, 41763.582364177186, 319695.0, 321896.0, 358092.0, 362775.0, 368925.0, 33919.15202119967, 33956.830215848764, 33969.0, 34207.48688769621, 34634.0, 41063.43329937564, 41572.0, 42592.78703606462, 44883.0, 45933.08133837238, 34957.0, 34995.65004349924, 36497.27005459823, 36776.816115919246, 37049.6295037057, 35450.82274588611, 35730.821345893106, 35826.64173358233, 36029.63970360263, 36065.63934360623, 34530.65469345274, 34559.4816077754, 35124.473132903535, 35447.468287975185, 35647.0, 30369.848150759106, 32670.34659306848, 32841.67158328386, 32910.83544582262, 32940.0, 24558.63162052535, 24874.0, 25076.74923250744, 25142.62286065674, 25475.61786573166], "value": 17536.080467299635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.286649502026, 359.9100224943764, 366.86426022371717, 373.415604578834, 376.16866724538767, 12215.20601160924, 15482.148481833494, 15696.293666785008, 16314.673706525862, 17118.0, 14930.178840163786, 15019.92490037551, 15198.316075776589, 16139.0, 16944.491665250032, 4880.4143502779625, 5074.898502029957, 5075.187969924795, 5127.307813445174, 5351.170568561879, 3332.0836769888233, 5322.866928326784, 5370.194470829368, 5370.624056316059, 5376.865578360533, 3435.2442462658173, 5080.974595127019, 5337.2527846101575, 5354.384245811742, 5446.645968012067, 5363.758630861621, 5424.783008679668, 5437.728113594305, 5442.2380866678695, 5901.852453688649, 5297.894042119175, 5300.761465734051, 5301.231321458406, 5301.893962120775, 5302.337207849019, 12015.098867584966, 12218.755624887452, 18773.7183942241, 19646.312379066807, 19740.901295493575, 1671.0475029233342, 1719.759233707282, 1788.0076557510577, 1911.8183772541586, 2325.616273314901, 8906.02033776284, 8960.596773145224, 9061.365704400694, 9424.575894084783, 9550.570224339921, 1718.4415065103892, 1721.5954250751063, 1737.37454516374, 1746.9825301746946, 1800.6848801459691, 69188.96216556756, 69953.3004669957, 70717.29282707158, 70841.0, 72355.27644723591, 9761.951190244145, 9976.102150806317, 10084.0, 10136.138428233535, 10147.137493313152, 13432.529861454803, 13438.798418023738, 13448.260345681081, 13465.663358415923, 13470.326483675777, 7144.607046612487, 7213.0, 7268.45486588508, 7401.777946661608, 7413.258674132651, 7020.297970202939, 7081.362677359062, 7282.563046217244, 7288.70845166198, 7349.338559529561, 4037.8788636340955, 4142.233686767958, 4152.875413737593, 4239.830406783756, 4268.914621707549, 1621.8702503799905, 1686.1400685650406, 1695.440504633468, 1696.414736915762, 1710.512503936397, 797.7726347990795, 810.4569938141459, 814.7840822182127, 830.6635812495949, 913.8081002989313, 15510.224488775517, 16000.75998860018, 16610.50168494947, 16732.581685457717, 17183.742243866353, 802.9277365037058, 836.7206491764082, 846.1834329871704, 870.3863776038005, 909.0999910089097, 8738.257248133852, 9292.907070929205, 9535.0, 9584.616615335448, 9697.175740062032, 416927.0, 418899.0, 419438.0, 419528.0, 428907.0, 79312.0, 80667.59666201631, 81740.0, 82482.58758706169, 83215.58392208, 902.0, 913.356083960806, 947.327397547735, 950.6435086842434, 959.52023988006, 15544.06735595868, 15756.133412662413, 16185.75721364157, 16367.634564445809, 16560.420385286456, 39155.804220978716, 39232.80383598064, 39359.60640393674, 39551.20897581975, 39566.802165988986, 50709.74645126751, 52031.73984130055, 52095.73952130215, 52641.7367913158, 53755.46244537661, 6525.804225873231, 7163.4269258460245, 7267.418606511361, 7269.382102521345, 7314.305141011595, 9168.266538677024, 11499.0, 11530.365829879438, 11701.824472633087, 11840.644780656594, 10409.11522520564, 10514.211434142317, 10655.200859935381, 10865.456727163451, 10977.0, 9848.950755246178, 10110.898891010997, 10230.079292863678, 10514.0, 10790.352578845295, 10473.266871318934, 10583.417912014913, 10620.309679870783, 10954.616588419367, 11043.668689939315, 6660.067590537232, 6672.799816005528, 6727.629980350932, 6885.104936358442, 7330.743423980135, 8354.874676879974, 10623.89376106229, 10900.182486313399, 11395.14536409756, 11407.714807129889], "value": 8067.189981054582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.8969887559556, 1244.1353259484656, 1325.8408990921089, 1384.9307534623267, 1645.4652238022645, 6405.871882562352, 7432.145303290124, 7640.159582445934, 7661.23387661235, 7663.731769388072, 7425.777226683194, 7488.550686958786, 7495.550266983984, 7496.100467943855, 7501.39988800896, 2081.968770468448, 2089.6447603907295, 2106.631339515586, 2109.177420805887, 2117.5129720164373, 2089.8850563219016, 2113.5350222951, 2119.703241546185, 2119.9894000529976, 2126.36209137259, 2060.721802556651, 2102.211670623516, 2102.9474263143393, 2113.2075471698113, 2113.355426594888, 2058.9073491692834, 2059.155746144089, 2063.6285468615642, 2064.040221297089, 2066.917323307066, 2032.4512381657019, 2070.5858828234414, 2087.3007542473288, 2095.402810199086, 2108.652072408066, 7062.364387205176, 7394.482386232966, 7477.289657482531, 7490.3633191178815, 7496.7750967471065, 4306.590873866978, 4454.997625534229, 4496.865094047183, 4497.392851964975, 4509.323601459774, 2900.5214139666928, 3003.0690485949426, 3078.1381213260324, 3084.98457507711, 3096.179512429208, 1009.8737657792776, 1013.8276492996134, 1023.9436830974294, 1030.9175265978704, 1032.0866033560278, 9734.172595329406, 9943.502824858728, 10120.443375614339, 10137.0, 10146.441945692985, 3986.6013398660484, 4087.938680919729, 4113.85601503946, 4120.7733574653685, 4140.171965606891, 8646.3947523674, 8647.481151130953, 8651.394402391898, 8655.740327790176, 8671.869921951176, 4554.749488778083, 4575.336576196433, 4580.564846339593, 4586.128635559233, 4589.816407343669, 3202.3595280943905, 3484.6689564491335, 4090.427340172378, 4119.176164767058, 4123.381492776108, 3534.964650353515, 3631.5279013728573, 3649.1059690375496, 3690.6493883081066, 3713.4615480755137, 1176.817593273044, 1187.631834131422, 1192.3203773848995, 1197.167968262067, 1203.2239205712267, 776.1423626892202, 800.9719659811879, 806.1293802693077, 807.1726480357563, 822.284612387215, 4656.604188644003, 4781.282807578891, 4839.104765618372, 4965.776540055706, 5076.36545431821, 394.7710328009805, 395.566854294547, 397.7573680055164, 397.7712815131253, 399.6602887545563, 3079.153232860981, 3140.2149462634343, 3155.66865479126, 3169.8098114113227, 3264.3634491274447, 9103.408278461879, 9329.486878221627, 9404.106609872051, 9413.199878010446, 9440.24478041755, 9389.812203755886, 9405.811883762286, 9405.858912116324, 9424.104710052534, 9430.858537121949, 7130.181803640038, 7155.499115062, 7205.351518363268, 7209.639518024078, 7209.711611535585, 4855.295982082507, 5011.471501192172, 5139.511746384088, 5159.509846564571, 5361.597880159082, 8569.871451928351, 8650.394472386872, 8722.825543488967, 8756.299496040428, 8764.386492945432, 7760.961195193988, 8436.915630843612, 8815.338849586178, 8923.821523569362, 8966.148215919477, 5576.0, 6374.840628984312, 6418.326075762165, 6582.473402127723, 6591.802245932629, 6627.37039981201, 7055.400290975119, 7120.2167761547225, 7120.643967801693, 7126.109236345457, 6485.416312531895, 6521.282658907611, 6527.9673601633585, 6535.738570457129, 6606.4384527315715, 6317.589356691984, 6323.36766323364, 6336.429721325103, 6404.551681382259, 6422.903656445251, 5748.0, 5811.941880581309, 5846.912296315644, 5849.795257165979, 5932.822015339547, 4371.453568303962, 4417.0, 4467.5755803198645, 4474.105178964285, 4501.3473046407435, 4433.512313645432, 4464.464264288306, 4540.636749060133, 4564.977175114103, 4669.276262179367], "value": 3910.7915254340796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.13819646631833, 296.0969044414536, 300.7654029856712, 309.9070278916325, 311.08230719377843, 4854.732989685566, 4901.485344038873, 4914.0, 4914.189158788796, 4918.532739389757, 4531.43357080365, 4688.71867687939, 4696.389469368977, 4705.0, 4850.466448690641, 3649.4525821126845, 3649.799261040642, 3651.7808931464197, 3797.1076796952693, 3826.349520581508, 3804.2011177652726, 3809.8666546670734, 3822.7515211511163, 3822.808859557025, 3835.846566137351, 3667.0212819091316, 3783.3190025795348, 3785.9621403785886, 3788.1666033472593, 3828.9042773930596, 3770.245950809849, 3775.18833450808, 3814.8855534334016, 3821.789801560913, 3824.0, 3359.3785149747373, 3373.224158443572, 3379.2734562069027, 3384.3908096542614, 3390.9321813563593, 4724.4330680318235, 4728.125296820065, 4739.312799644067, 4742.834000809989, 4763.857084287477, 4220.78896055199, 4284.5715428457215, 4324.740515569076, 4334.934975975363, 4339.284018137004, 4952.653314268003, 4976.402831660188, 4992.1529034257555, 5000.599832047033, 5004.5495905368325, 3631.654992775682, 3638.490026638942, 3640.381135207021, 3649.288388764192, 3652.3425783358985, 5114.693118412907, 5197.688138711652, 5228.712420816853, 5286.577073834084, 5287.180487024518, 3711.498947642088, 3717.3494638438165, 3717.7769333839515, 3726.124360775216, 3753.9249215015548, 3767.981160094182, 3769.1142581493327, 3793.336166170909, 3800.042977866401, 3801.9924719949236, 4239.957600424018, 4271.466066741657, 4273.273543497613, 4286.54991225923, 4288.52826189119, 4868.9756551217015, 4953.23224900141, 4986.880575755289, 5015.122353588107, 5032.370953630796, 1308.9280089594972, 1316.5523721934587, 1321.3921596065918, 1325.4168166006925, 1326.774448343784, 827.6565225431378, 851.6806197675871, 866.8873046503915, 894.9015608283083, 923.7829110159107, 4425.137098265872, 4434.733915965053, 4437.755923424243, 4460.3532487789735, 4463.419755431773, 5183.885464625124, 5189.42916279209, 5190.377154741455, 5202.323697919246, 5222.634415590948, 4346.239408103569, 4488.214562451623, 4512.81948722054, 4520.9375796687755, 4580.221362368406, 2779.3885345224016, 2804.2288370697815, 2809.3819359740824, 2811.959574957279, 2815.591739197846, 5068.41713202979, 5072.365954255718, 5076.416212135578, 5084.949150508522, 5101.336826212643, 5090.541851233407, 5361.544268737123, 5406.91889621656, 5411.213225189031, 5432.6468779529205, 5059.72171530562, 5073.828856964397, 5080.161773307437, 5087.92368114486, 5090.887281778095, 5253.684778913124, 5258.211268309784, 5315.574754019592, 5326.6537675050995, 5345.1447768356875, 4874.5856602189215, 5074.340335756476, 5135.204043373283, 5136.5617627064485, 5150.871228219325, 5016.971520838147, 5044.873878153076, 5049.6465247432325, 5053.469385714447, 5056.381957773478, 3759.0077259052746, 3795.2978698940783, 3796.3925771876366, 3815.694744420495, 3840.4815349927403, 5055.16589762685, 5169.844904652867, 5229.346331708536, 5233.3196684432305, 5275.340582427197, 5011.899762004812, 5040.294358789845, 5054.0, 5065.265536497113, 5074.147936003406, 5063.544281014726, 5068.113080211022, 5077.619178561697, 5092.898142037213, 5096.311997880239, 4744.0, 4948.752562371939, 4957.950420495749, 4999.425066117443, 5027.673201241908, 4864.464908860094, 4982.2775697524385, 5023.497650234947, 5146.099432599205, 5152.381714194321, 4993.902560924493, 5020.6234532410945, 5025.522575355335, 5028.949710502849, 5055.090083784954], "value": 3841.326840806754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.0245004318026, 624.0202881476084, 639.7409049335018, 644.5837063563114, 660.0268166817574, 12936.0, 13936.860631393683, 14062.64843378916, 14112.082714623555, 14239.78640320396, 13544.525941592046, 13649.522266720667, 13696.246706431168, 13699.178049317048, 13700.040997130205, 590.5570821883588, 607.6020206764576, 732.2677322677323, 753.3897542990168, 759.582229773625, 733.2740586819037, 748.6144635512716, 752.4807882561042, 760.1941941541955, 760.4068826315482, 804.3364224514769, 804.7263930263709, 804.9798755031112, 805.2832978649008, 805.7059173401695, 626.8307556959641, 642.7075680565332, 795.8647030004884, 796.1401686178913, 796.4862663581986, 563.3493315220926, 573.4208449466028, 575.726529898295, 577.7486793244952, 579.5218944370869, 13079.41142648583, 13086.41111149991, 13111.737765244738, 13113.86886131136, 13124.343782810916, 12216.938915305456, 12703.0, 12714.809277860839, 12864.678383040406, 13351.866481335159, 11721.648350549498, 11847.348395838226, 11960.58137965167, 12030.69923251917, 12649.241045537297, 3947.624975627311, 4065.6950728695465, 4068.6338229559483, 4071.1043570414463, 4096.365063415145, 66162.66918665424, 67038.32961670369, 67178.66410667964, 67204.3279567203, 67223.3277667222, 9852.45811480361, 10189.490525473697, 10228.386296822215, 10262.682335087247, 10392.740181495372, 19503.122359493856, 19548.609027819362, 19565.51086222856, 19578.0, 19640.803591963897, 6750.831229219309, 6840.144981877265, 6914.412274956584, 6981.755638552728, 7133.179684336368, 3787.7348585598743, 3790.962090379116, 3795.9240815184094, 3820.312343778091, 3885.4171874218528, 2797.3705916169106, 2895.4353900989527, 2901.82589044658, 2904.477194105039, 2904.520754075596, 482.7562081148997, 495.6158976792942, 499.8800287930943, 503.36827281761157, 515.520565873741, 438.5723919178775, 476.8783960090224, 486.3312944701036, 488.12381774714476, 498.24018371983016, 7571.318581327707, 7691.653875575613, 7816.57008864518, 7866.056073271129, 7995.68017279314, 433.2310149484627, 488.1061481452015, 511.53194826733863, 522.4931816138339, 531.8324727710759, 3676.2647470506004, 3677.8344974476213, 3918.392649139388, 3956.9604303956594, 4046.59534046593, 101994.0, 104321.0, 104648.0, 106547.93452065536, 109761.0, 51278.230826537634, 83068.58465707753, 86887.56556217179, 87357.56321218354, 87428.0, 75733.621331893, 80595.0, 81049.59475202704, 82270.0, 83889.16110838935, 6904.930950690429, 6919.169699636076, 6929.3070692930305, 6983.476239282176, 7209.279072092749, 46858.548437898346, 47030.294545582525, 48742.26886596633, 49152.0, 49701.0, 63136.684316578125, 66093.0, 71245.28754712387, 71250.64374678301, 71795.28204718095, 9681.128698417177, 9753.366031207948, 9760.072793084646, 9846.655367062118, 10129.949350253497, 10557.419341936267, 10644.574217031543, 10812.0, 11080.722981925193, 11400.258983166068, 9742.512874356113, 9792.167665748206, 10176.694699159038, 10387.896121038693, 10395.272330936761, 8642.567871606268, 8863.689770857989, 8889.822203556021, 8959.865602015845, 8981.326400519856, 9621.807563848544, 9798.608055677692, 9965.381425172456, 10204.948975255076, 10441.582336706446, 7789.532628042336, 8139.1453897339925, 8301.83396332082, 8365.74902752894, 8416.98996120445, 7424.030387844905, 7701.730439434593, 7793.610319484116, 7829.45193836426, 7982.92017079845], "value": 6300.3777766652975, "unit": "score"}], "name": "dromaeo_css", "value": 6281.653417900685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 116.0, 114.0, 116.0, 117.0, 117.0, 115.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 128.0, 132.0, 183.0, 128.0, 125.0, 134.0, 130.0, 163.0, 128.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 165.0, 161.0, 161.0, 162.0, 161.0, 163.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 111.0, 76.0, 76.0, 77.0, 77.0, 107.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 127.0, 84.0, 84.0, 85.0, 119.0, 84.0, 86.0, 121.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.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, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 72.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 75.0, 69.0, 65.0, 66.0, 66.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 83.0, 83.0, 82.0, 82.0, 85.0, 82.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 136.0, 143.0, 133.0, 131.0, 134.0, 133.0, 135.0, 175.0, 140.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 173.0, 174.0, 172.0, 175.0, 174.0, 172.0, 175.0, 177.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 71.0, 68.0, 68.0, 70.0, 68.0, 68.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1554.8000000000002, "alertThreshold": 2.0}]} 15:30:45 INFO - Return code: 0 15:30:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:30:45 INFO - # TBPL SUCCESS # 15:30:45 INFO - Running post-action listener: _resource_record_post_action 15:30:45 INFO - [mozharness: 2016-09-21 22:30:45.394913Z] Finished run-tests step (success) 15:30:45 INFO - Running post-run listener: _resource_record_post_run 15:30:45 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399650816; Read time: 16; Write time: 312548 15:30:45 INFO - TinderboxPrint: CPU usage
13.0% 15:30:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:30:45 INFO - TinderboxPrint: I/O write bytes / time
399,650,816 / 312,548 15:30:45 INFO - TinderboxPrint: CPU idle
8,342.4 (87.0%) 15:30:45 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 15:30:45 INFO - TinderboxPrint: Swap in / out
0 / 0 15:30:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108908544; Read time: 0; Write time: 102980 15:30:45 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290742272; Read time: 0; Write time: 209568 15:30:46 INFO - Running post-run listener: _upload_blobber_files 15:30:46 INFO - Blob upload gear active. 15:30:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:46 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 15:30:46 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:46 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:46 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:30:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:30:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:50 INFO - (blobuploader) - INFO - Done attempting. 15:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:51 INFO - (blobuploader) - INFO - Done attempting. 15:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:52 INFO - (blobuploader) - INFO - Done attempting. 15:30:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:30:52 INFO - Return code: 0 15:30:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:30:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:30:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b3a880b507e81f19ba43d39c0cb62615a9c5dfe214f4b21814b7b2a950d22ad35b0192fbc0c8b5e7646e7aeb6775963a0ed1a45fb1a58105e1717101076c1e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/431fdabd0856799443b4a265a1052421a73a0acee9c504b6c933f8585b2e4eb0f78da2206d00e646b63fa7928991efdacbafcc9807fda1c01017f76d9c920d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa6b20729e3eb536f13d209561552e4cce985211a324c0f7e955cfcc076d07306c64dad3e40ebb00194998a8985f8057689b9dbd66ec0e92a1069eea1c3e82f0"} 15:30:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:30:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:30:52 INFO - Contents: 15:30:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b3a880b507e81f19ba43d39c0cb62615a9c5dfe214f4b21814b7b2a950d22ad35b0192fbc0c8b5e7646e7aeb6775963a0ed1a45fb1a58105e1717101076c1e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/431fdabd0856799443b4a265a1052421a73a0acee9c504b6c933f8585b2e4eb0f78da2206d00e646b63fa7928991efdacbafcc9807fda1c01017f76d9c920d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa6b20729e3eb536f13d209561552e4cce985211a324c0f7e955cfcc076d07306c64dad3e40ebb00194998a8985f8057689b9dbd66ec0e92a1069eea1c3e82f0"} 15:30:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:30:52 INFO - Copying logs to upload dir... 15:30:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:30:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.857810 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-21 15:30:52.719089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:30:52.722592) ========= 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=32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b3a880b507e81f19ba43d39c0cb62615a9c5dfe214f4b21814b7b2a950d22ad35b0192fbc0c8b5e7646e7aeb6775963a0ed1a45fb1a58105e1717101076c1e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/431fdabd0856799443b4a265a1052421a73a0acee9c504b6c933f8585b2e4eb0f78da2206d00e646b63fa7928991efdacbafcc9807fda1c01017f76d9c920d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa6b20729e3eb536f13d209561552e4cce985211a324c0f7e955cfcc076d07306c64dad3e40ebb00194998a8985f8057689b9dbd66ec0e92a1069eea1c3e82f0"} build_url:https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/MqgMwpJvQxSIGpC4vVAMsQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b3a880b507e81f19ba43d39c0cb62615a9c5dfe214f4b21814b7b2a950d22ad35b0192fbc0c8b5e7646e7aeb6775963a0ed1a45fb1a58105e1717101076c1e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/431fdabd0856799443b4a265a1052421a73a0acee9c504b6c933f8585b2e4eb0f78da2206d00e646b63fa7928991efdacbafcc9807fda1c01017f76d9c920d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa6b20729e3eb536f13d209561552e4cce985211a324c0f7e955cfcc076d07306c64dad3e40ebb00194998a8985f8057689b9dbd66ec0e92a1069eea1c3e82f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:30:52.747694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:30:52.748015) ========= 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=32c5991c409366f7fec8a718000001d2-1474495802.222264-390955933 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004364 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:30:52.831194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 15:30:52.831572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 15:30:52.831875) ========= ========= Total master_lag: 0.16 =========