builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1474907099.39 results: success (0) buildid: 20160926063000 builduid: c00da7d59f6b4e3a801f47b18e4f3807 revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.394457) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.394869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.397879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.448470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.448768) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 09:24:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-09-26 09:24:59 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.574040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.574371) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.628274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:24:59.628605) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --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 c55bcb7c777ea09431b4d16903ed079ae5632648 --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=337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 09:25:00,081 truncating revision to first 12 chars 2016-09-26 09:25:00,081 Setting DEBUG logging. 2016-09-26 09:25:00,081 attempt 1/10 2016-09-26 09:25:00,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 09:25:00,371 unpacking tar archive at: fx-team-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:25:00.250213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 09:25:00.250521) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 09:25:00.250919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 09:25:00.251257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 09:25:00.265558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-26 09:25:00.265872) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:00 INFO - MultiFileLogger online at 20160926 09:25:00 in /builds/slave/test 09:25:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:25:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:00 INFO - {'append_to_log': False, 09:25:00 INFO - 'base_work_dir': '/builds/slave/test', 09:25:00 INFO - 'blob_upload_branch': 'Fx-Team', 09:25:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:00 INFO - 'branch': 'Fx-Team', 09:25:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:00 INFO - 'config_files': ('talos/linux_config.py',), 09:25:00 INFO - 'default_actions': ('clobber', 09:25:00 INFO - 'read-buildbot-config', 09:25:00 INFO - 'download-and-extract', 09:25:00 INFO - 'populate-webroot', 09:25:00 INFO - 'create-virtualenv', 09:25:00 INFO - 'install', 09:25:00 INFO - 'run-tests'), 09:25:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:00 INFO - 'download_minidump_stackwalk': True, 09:25:00 INFO - 'download_symbols': 'ondemand', 09:25:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:00 INFO - 'installer_path': 'installer.exe', 09:25:00 INFO - 'log_level': 'info', 09:25:00 INFO - 'log_name': 'talos', 09:25:00 INFO - 'log_to_console': True, 09:25:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:00 INFO - 'opt_config_files': (), 09:25:00 INFO - 'pip_index': False, 09:25:00 INFO - 'sps_profile': False, 09:25:00 INFO - 'sps_profile_interval': 0, 09:25:00 INFO - 'suite': 'dromaeojs', 09:25:00 INFO - 'system_bits': '32', 09:25:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:00 INFO - 'title': 'talos-linux64-ix-060', 09:25:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:00 INFO - 'use_talos_json': True, 09:25:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:00 INFO - 'work_dir': 'build'} 09:25:00 INFO - [mozharness: 2016-09-26 16:25:00.820321Z] Running clobber step. 09:25:00 INFO - Running pre-action listener: _resource_record_pre_action 09:25:00 INFO - Running main action method: clobber 09:25:00 INFO - rmtree: /builds/slave/test/build 09:25:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:01 INFO - Running post-action listener: _resource_record_post_action 09:25:01 INFO - [mozharness: 2016-09-26 16:25:01.797702Z] Finished clobber step (success) 09:25:01 INFO - [mozharness: 2016-09-26 16:25:01.797803Z] Running read-buildbot-config step. 09:25:01 INFO - Running pre-action listener: _resource_record_pre_action 09:25:01 INFO - Running main action method: read_buildbot_config 09:25:01 INFO - Using buildbot properties: 09:25:01 INFO - { 09:25:01 INFO - "project": "", 09:25:01 INFO - "product": "firefox", 09:25:01 INFO - "script_repo_revision": "production", 09:25:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:25:01 INFO - "repository": "", 09:25:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:25:01 INFO - "buildid": "20160926063000", 09:25:01 INFO - "pgo_build": "True", 09:25:01 INFO - "basedir": "/builds/slave/test", 09:25:01 INFO - "buildnumber": 476, 09:25:01 INFO - "slavename": "talos-linux64-ix-060", 09:25:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:25:01 INFO - "platform": "ubuntu64_hw", 09:25:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:25:01 INFO - "branch": "fx-team", 09:25:01 INFO - "repo_path": "integration/fx-team", 09:25:01 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 09:25:01 INFO - "stage_platform": "linux64-pgo", 09:25:01 INFO - "builduid": "c00da7d59f6b4e3a801f47b18e4f3807", 09:25:01 INFO - "slavebuilddir": "test" 09:25:01 INFO - } 09:25:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:25:01 INFO - Running post-action listener: _resource_record_post_action 09:25:01 INFO - [mozharness: 2016-09-26 16:25:01.800257Z] Finished read-buildbot-config step (success) 09:25:01 INFO - [mozharness: 2016-09-26 16:25:01.800346Z] Running download-and-extract step. 09:25:01 INFO - Running pre-action listener: _resource_record_pre_action 09:25:01 INFO - Running main action method: download_and_extract 09:25:01 INFO - mkdir: /builds/slave/test/build/tests 09:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:01 INFO - trying https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:01 INFO - Downloading https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/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 09:25:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/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 09:25:02 INFO - Downloaded 1361 bytes. 09:25:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:02 INFO - Using the following test package requirements: 09:25:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:25:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:25:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'jsshell-linux-x86_64.zip'], 09:25:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:25:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:25:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:25:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:25:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:25:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:25:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:25:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:02 INFO - Fetch https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:25:02 INFO - Expected file size: 21981419 09:25:07 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 09:25:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:25:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:07 INFO - Fetch https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:25:07 INFO - Expected file size: 21981419 09:25:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:25:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:25:13 INFO - Expected file size: 14414057 09:25:13 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')]} 09:25:13 INFO - trying https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/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 09:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/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 09:25:14 INFO - Downloaded 59695080 bytes. 09:25:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:14 INFO - mkdir: /builds/slave/test/properties 09:25:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:25:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:25:14 INFO - Contents: 09:25:14 INFO - build_url:https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:15 INFO - Running post-action listener: _resource_record_post_action 09:25:15 INFO - Running post-action listener: set_extra_try_arguments 09:25:15 INFO - [mozharness: 2016-09-26 16:25:15.471124Z] Finished download-and-extract step (success) 09:25:15 INFO - [mozharness: 2016-09-26 16:25:15.471386Z] Running populate-webroot step. 09:25:15 INFO - Running pre-action listener: _resource_record_pre_action 09:25:15 INFO - Running main action method: populate_webroot 09:25:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:15 INFO - '--tppagecycles', 09:25:15 INFO - '7'], 09:25:15 INFO - 'tests': ['tsvgm']}}, 09:25:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:25:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:25:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:25:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['damp', 'tps']}, 09:25:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'tests': ['damp', 'tps']}, 09:25:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['dromaeo_dom']}, 09:25:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['basic_compositor_video']}, 09:25:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:25:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['a11yr', 09:25:15 INFO - 'ts_paint', 09:25:15 INFO - 'tpaint', 09:25:15 INFO - 'sessionrestore', 09:25:15 INFO - 'sessionrestore_no_auto_restore', 09:25:15 INFO - 'tabpaint']}, 09:25:15 INFO - 'other-e10s': {'tests': ['a11yr', 09:25:15 INFO - 'ts_paint', 09:25:15 INFO - 'tpaint', 09:25:15 INFO - 'sessionrestore', 09:25:15 INFO - 'sessionrestore_no_auto_restore', 09:25:15 INFO - 'tabpaint']}, 09:25:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:25:15 INFO - 'ts_paint', 09:25:15 INFO - 'tpaint', 09:25:15 INFO - 'sessionrestore', 09:25:15 INFO - 'sessionrestore_no_auto_restore', 09:25:15 INFO - 'tabpaint']}, 09:25:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:25:15 INFO - 'ts_paint', 09:25:15 INFO - 'tpaint', 09:25:15 INFO - 'sessionrestore', 09:25:15 INFO - 'sessionrestore_no_auto_restore', 09:25:15 INFO - 'tabpaint']}, 09:25:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['a11yr', 09:25:15 INFO - 'ts_paint', 09:25:15 INFO - 'tpaint', 09:25:15 INFO - 'sessionrestore', 09:25:15 INFO - 'sessionrestore_no_auto_restore', 09:25:15 INFO - 'tabpaint']}, 09:25:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['a11yr', 09:25:15 INFO - 'ts_paint', 09:25:15 INFO - 'tpaint', 09:25:15 INFO - 'sessionrestore', 09:25:15 INFO - 'sessionrestore_no_auto_restore', 09:25:15 INFO - 'tabpaint']}, 09:25:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['tsvgx', 09:25:15 INFO - 'tsvgr_opacity', 09:25:15 INFO - 'tart', 09:25:15 INFO - 'tscrollx', 09:25:15 INFO - 'cart']}, 09:25:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:25:15 INFO - 'tsvgr_opacity', 09:25:15 INFO - 'tart', 09:25:15 INFO - 'tscrollx', 09:25:15 INFO - 'cart']}, 09:25:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'talos_options': ['--disable-e10s'], 09:25:15 INFO - 'tests': ['tp5o']}, 09:25:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'tests': ['tp5o']}, 09:25:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'talos_options': ['--disable-e10s', 09:25:15 INFO - '--xperf_path', 09:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:15 INFO - 'tests': ['tp5n']}, 09:25:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:15 INFO - 'talos_options': ['--xperf_path', 09:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:15 INFO - 'tests': ['tp5n']}}, 09:25:15 INFO - 'talos.zip': {'path': '', 09:25:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:15 INFO - Running post-action listener: _resource_record_post_action 09:25:15 INFO - [mozharness: 2016-09-26 16:25:15.489574Z] Finished populate-webroot step (success) 09:25:15 INFO - [mozharness: 2016-09-26 16:25:15.489663Z] Running create-virtualenv step. 09:25:15 INFO - Running pre-action listener: _resource_record_pre_action 09:25:15 INFO - Running main action method: create_virtualenv 09:25:15 INFO - Creating virtualenv /builds/slave/test/build/venv 09:25:15 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 09:25:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:25:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:15 INFO - Using real prefix '/usr' 09:25:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:25:16 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:18 INFO - Installing pip.................done. 09:25:18 INFO - Return code: 0 09:25:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:25:18 INFO - Reading from file tmpfile_stdout 09:25:18 INFO - Output received: 09:25:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:25:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:18 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:18 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 09:25:18 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 09:25:18 INFO - Using env: {'DISPLAY': ':0', 09:25:18 INFO - 'HOME': '/home/cltbld', 09:25:18 INFO - 'LANG': 'en_US.UTF-8', 09:25:18 INFO - 'LANGUAGE': 'en_US:en', 09:25:18 INFO - 'LOGNAME': 'cltbld', 09:25:18 INFO - 'MAIL': '/var/mail/cltbld', 09:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:18 INFO - 'MOZ_NO_REMOTE': '1', 09:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:18 INFO - 'NO_EM_RESTART': '1', 09:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:18 INFO - 'PWD': '/builds/slave/test', 09:25:18 INFO - 'SHELL': '/bin/bash', 09:25:18 INFO - 'SHLVL': '1', 09:25:18 INFO - 'TERM': 'linux', 09:25:18 INFO - 'TMOUT': '86400', 09:25:18 INFO - 'USER': 'cltbld', 09:25:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:18 INFO - '_': '/tools/buildbot/bin/python'} 09:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:18 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 09:25:18 INFO - Cleaning up... 09:25:18 INFO - Return code: 0 09:25:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:18 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:18 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 09:25:18 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 09:25:18 INFO - Using env: {'DISPLAY': ':0', 09:25:18 INFO - 'HOME': '/home/cltbld', 09:25:18 INFO - 'LANG': 'en_US.UTF-8', 09:25:18 INFO - 'LANGUAGE': 'en_US:en', 09:25:18 INFO - 'LOGNAME': 'cltbld', 09:25:18 INFO - 'MAIL': '/var/mail/cltbld', 09:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:18 INFO - 'MOZ_NO_REMOTE': '1', 09:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:18 INFO - 'NO_EM_RESTART': '1', 09:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:18 INFO - 'PWD': '/builds/slave/test', 09:25:18 INFO - 'SHELL': '/bin/bash', 09:25:18 INFO - 'SHLVL': '1', 09:25:18 INFO - 'TERM': 'linux', 09:25:18 INFO - 'TMOUT': '86400', 09:25:18 INFO - 'USER': 'cltbld', 09:25:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:18 INFO - '_': '/tools/buildbot/bin/python'} 09:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:18 INFO - Downloading/unpacking psutil>=3.1.1 09:25:18 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 09:25:18 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 09:25:18 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 09:25:18 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 09:25:18 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 09:25:18 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 09:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:20 INFO - Installing collected packages: psutil 09:25:20 INFO - Running setup.py install for psutil 09:25:20 INFO - building 'psutil._psutil_linux' extension 09:25:20 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 09:25:20 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 09:25:20 INFO - building 'psutil._psutil_posix' extension 09:25:20 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 09:25:21 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 09:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:21 INFO - Successfully installed psutil 09:25:21 INFO - Cleaning up... 09:25:21 INFO - Return code: 0 09:25:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:21 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:21 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 09:25:21 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 09:25:21 INFO - Using env: {'DISPLAY': ':0', 09:25:21 INFO - 'HOME': '/home/cltbld', 09:25:21 INFO - 'LANG': 'en_US.UTF-8', 09:25:21 INFO - 'LANGUAGE': 'en_US:en', 09:25:21 INFO - 'LOGNAME': 'cltbld', 09:25:21 INFO - 'MAIL': '/var/mail/cltbld', 09:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:21 INFO - 'MOZ_NO_REMOTE': '1', 09:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:21 INFO - 'NO_EM_RESTART': '1', 09:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:21 INFO - 'PWD': '/builds/slave/test', 09:25:21 INFO - 'SHELL': '/bin/bash', 09:25:21 INFO - 'SHLVL': '1', 09:25:21 INFO - 'TERM': 'linux', 09:25:21 INFO - 'TMOUT': '86400', 09:25:21 INFO - 'USER': 'cltbld', 09:25:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:21 INFO - '_': '/tools/buildbot/bin/python'} 09:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:25:21 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 09:25:21 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 09:25:21 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 09:25:21 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 09:25:21 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 09:25:21 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 09:25:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:25:23 INFO - Installing collected packages: mozsystemmonitor 09:25:23 INFO - Running setup.py install for mozsystemmonitor 09:25:23 INFO - Successfully installed mozsystemmonitor 09:25:23 INFO - Cleaning up... 09:25:23 INFO - Return code: 0 09:25:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:25:23 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')]} 09:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:23 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')]} 09:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:23 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:23 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 09:25:23 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 09:25:23 INFO - Using env: {'DISPLAY': ':0', 09:25:23 INFO - 'HOME': '/home/cltbld', 09:25:23 INFO - 'LANG': 'en_US.UTF-8', 09:25:23 INFO - 'LANGUAGE': 'en_US:en', 09:25:23 INFO - 'LOGNAME': 'cltbld', 09:25:23 INFO - 'MAIL': '/var/mail/cltbld', 09:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:23 INFO - 'MOZ_NO_REMOTE': '1', 09:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:23 INFO - 'NO_EM_RESTART': '1', 09:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:23 INFO - 'PWD': '/builds/slave/test', 09:25:23 INFO - 'SHELL': '/bin/bash', 09:25:23 INFO - 'SHLVL': '1', 09:25:23 INFO - 'TERM': 'linux', 09:25:23 INFO - 'TMOUT': '86400', 09:25:23 INFO - 'USER': 'cltbld', 09:25:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:23 INFO - '_': '/tools/buildbot/bin/python'} 09:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:25:23 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 09:25:23 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 09:25:23 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 09:25:23 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 09:25:23 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 09:25:23 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 09:25:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:25 INFO - warning: no files found matching '*.txt' 09:25:25 INFO - no previously-included directories found matching 'build' 09:25:25 INFO - no previously-included directories found matching 'dist' 09:25:25 INFO - no previously-included directories found matching '.git*' 09:25:25 INFO - Installing collected packages: jsonschema, functools32 09:25:25 INFO - Running setup.py install for functools32 09:25:25 INFO - warning: no files found matching '*.txt' 09:25:25 INFO - no previously-included directories found matching 'build' 09:25:25 INFO - no previously-included directories found matching 'dist' 09:25:25 INFO - no previously-included directories found matching '.git*' 09:25:26 INFO - Successfully installed jsonschema functools32 09:25:26 INFO - Cleaning up... 09:25:26 INFO - Return code: 0 09:25:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:25:26 INFO - Using env: {'DISPLAY': ':0', 09:25:26 INFO - 'HOME': '/home/cltbld', 09:25:26 INFO - 'LANG': 'en_US.UTF-8', 09:25:26 INFO - 'LANGUAGE': 'en_US:en', 09:25:26 INFO - 'LOGNAME': 'cltbld', 09:25:26 INFO - 'MAIL': '/var/mail/cltbld', 09:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:26 INFO - 'MOZ_NO_REMOTE': '1', 09:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:26 INFO - 'NO_EM_RESTART': '1', 09:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:26 INFO - 'PWD': '/builds/slave/test', 09:25:26 INFO - 'SHELL': '/bin/bash', 09:25:26 INFO - 'SHLVL': '1', 09:25:26 INFO - 'TERM': 'linux', 09:25:26 INFO - 'TMOUT': '86400', 09:25:26 INFO - 'USER': 'cltbld', 09:25:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:26 INFO - '_': '/tools/buildbot/bin/python'} 09:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:25:26 INFO - Cleaning up... 09:25:26 INFO - Return code: 0 09:25:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:25:26 INFO - Using env: {'DISPLAY': ':0', 09:25:26 INFO - 'HOME': '/home/cltbld', 09:25:26 INFO - 'LANG': 'en_US.UTF-8', 09:25:26 INFO - 'LANGUAGE': 'en_US:en', 09:25:26 INFO - 'LOGNAME': 'cltbld', 09:25:26 INFO - 'MAIL': '/var/mail/cltbld', 09:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:26 INFO - 'MOZ_NO_REMOTE': '1', 09:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:26 INFO - 'NO_EM_RESTART': '1', 09:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:26 INFO - 'PWD': '/builds/slave/test', 09:25:26 INFO - 'SHELL': '/bin/bash', 09:25:26 INFO - 'SHLVL': '1', 09:25:26 INFO - 'TERM': 'linux', 09:25:26 INFO - 'TMOUT': '86400', 09:25:26 INFO - 'USER': 'cltbld', 09:25:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:26 INFO - '_': '/tools/buildbot/bin/python'} 09:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:29 INFO - Downloading docopt-0.6.1.tar.gz 09:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:29 INFO - Running setup.py install for blobuploader 09:25:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:29 INFO - Running setup.py install for requests 09:25:29 INFO - Running setup.py install for docopt 09:25:29 INFO - Successfully installed blobuploader requests docopt 09:25:29 INFO - Cleaning up... 09:25:29 INFO - Return code: 0 09:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:29 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:29 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 09:25:29 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 09:25:29 INFO - Using env: {'DISPLAY': ':0', 09:25:29 INFO - 'HOME': '/home/cltbld', 09:25:29 INFO - 'LANG': 'en_US.UTF-8', 09:25:29 INFO - 'LANGUAGE': 'en_US:en', 09:25:29 INFO - 'LOGNAME': 'cltbld', 09:25:29 INFO - 'MAIL': '/var/mail/cltbld', 09:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:29 INFO - 'MOZ_NO_REMOTE': '1', 09:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:29 INFO - 'NO_EM_RESTART': '1', 09:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:29 INFO - 'PWD': '/builds/slave/test', 09:25:29 INFO - 'SHELL': '/bin/bash', 09:25:29 INFO - 'SHLVL': '1', 09:25:29 INFO - 'TERM': 'linux', 09:25:29 INFO - 'TMOUT': '86400', 09:25:29 INFO - 'USER': 'cltbld', 09:25:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:29 INFO - '_': '/tools/buildbot/bin/python'} 09:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:30 INFO - Running setup.py (path:/tmp/pip-MJrGlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:30 INFO - Running setup.py (path:/tmp/pip-CXmZAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:30 INFO - Running setup.py (path:/tmp/pip-BuMAsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:30 INFO - Running setup.py (path:/tmp/pip-aC7Nl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:30 INFO - Running setup.py (path:/tmp/pip-wYcAHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:30 INFO - Running setup.py (path:/tmp/pip-YHpowN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:30 INFO - Running setup.py (path:/tmp/pip-2jExwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:30 INFO - Running setup.py (path:/tmp/pip-6RrUUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:30 INFO - Running setup.py (path:/tmp/pip-tCxFsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:30 INFO - Running setup.py (path:/tmp/pip-hnU6VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:30 INFO - Running setup.py (path:/tmp/pip-mC4Xem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:30 INFO - Running setup.py (path:/tmp/pip-bZDIRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:30 INFO - Running setup.py (path:/tmp/pip-orY7hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:30 INFO - Running setup.py (path:/tmp/pip-W60Cxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:31 INFO - Running setup.py (path:/tmp/pip-aN4jaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:31 INFO - Running setup.py (path:/tmp/pip-AHA_TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:31 INFO - Running setup.py (path:/tmp/pip-VI59bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:31 INFO - Running setup.py install for manifestparser 09:25:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozcrash 09:25:31 INFO - Running setup.py install for mozdebug 09:25:31 INFO - Running setup.py install for mozdevice 09:25:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozfile 09:25:31 INFO - Running setup.py install for mozhttpd 09:25:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozinfo 09:25:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:31 INFO - Running setup.py install for mozInstall 09:25:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for mozleak 09:25:32 INFO - Running setup.py install for mozlog 09:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for moznetwork 09:25:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for mozprocess 09:25:32 INFO - Running setup.py install for mozprofile 09:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for mozrunner 09:25:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:32 INFO - Running setup.py install for mozscreenshot 09:25:32 INFO - Running setup.py install for moztest 09:25:32 INFO - Running setup.py install for mozversion 09:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:33 INFO - Cleaning up... 09:25:33 INFO - Return code: 0 09:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:33 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:33 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 09:25:33 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 09:25:33 INFO - Using env: {'DISPLAY': ':0', 09:25:33 INFO - 'HOME': '/home/cltbld', 09:25:33 INFO - 'LANG': 'en_US.UTF-8', 09:25:33 INFO - 'LANGUAGE': 'en_US:en', 09:25:33 INFO - 'LOGNAME': 'cltbld', 09:25:33 INFO - 'MAIL': '/var/mail/cltbld', 09:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:33 INFO - 'MOZ_NO_REMOTE': '1', 09:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:33 INFO - 'NO_EM_RESTART': '1', 09:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:33 INFO - 'PWD': '/builds/slave/test', 09:25:33 INFO - 'SHELL': '/bin/bash', 09:25:33 INFO - 'SHLVL': '1', 09:25:33 INFO - 'TERM': 'linux', 09:25:33 INFO - 'TMOUT': '86400', 09:25:33 INFO - 'USER': 'cltbld', 09:25:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:33 INFO - '_': '/tools/buildbot/bin/python'} 09:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:33 INFO - Running setup.py (path:/tmp/pip-b8cgwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:33 INFO - Running setup.py (path:/tmp/pip-BZKm05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:33 INFO - Running setup.py (path:/tmp/pip-WtUXOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:33 INFO - Running setup.py (path:/tmp/pip-AY5fMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:33 INFO - Running setup.py (path:/tmp/pip-slIY_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:33 INFO - Running setup.py (path:/tmp/pip-BU_QCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:33 INFO - Running setup.py (path:/tmp/pip-rqCEfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:33 INFO - Running setup.py (path:/tmp/pip-LPUnDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:33 INFO - Running setup.py (path:/tmp/pip-wyzjne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:33 INFO - Running setup.py (path:/tmp/pip-YX83Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:33 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)) 09:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:33 INFO - Running setup.py (path:/tmp/pip-o5yRjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:34 INFO - Running setup.py (path:/tmp/pip-Hpzw6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:34 INFO - Running setup.py (path:/tmp/pip-73Ro5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:34 INFO - Running setup.py (path:/tmp/pip-o2NRWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:34 INFO - Running setup.py (path:/tmp/pip-R7pE1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:34 INFO - Running setup.py (path:/tmp/pip-LTjrku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:34 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)) 09:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:34 INFO - Running setup.py (path:/tmp/pip-vKHXeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:34 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)) 09:25:34 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)) 09:25:34 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)) 09:25:34 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)) 09:25:34 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)) 09:25:34 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)) 09:25:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:36 INFO - Downloading blessings-1.6.tar.gz 09:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:36 INFO - Installing collected packages: blessings 09:25:36 INFO - Running setup.py install for blessings 09:25:36 INFO - Successfully installed blessings 09:25:36 INFO - Cleaning up... 09:25:36 INFO - Return code: 0 09:25:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:36 INFO - Reading from file tmpfile_stdout 09:25:36 INFO - Current package versions: 09:25:36 INFO - argparse == 1.2.1 09:25:36 INFO - blessings == 1.6 09:25:36 INFO - blobuploader == 1.2.4 09:25:36 INFO - docopt == 0.6.1 09:25:36 INFO - functools32 == 3.2.3-2 09:25:36 INFO - jsonschema == 2.5.1 09:25:36 INFO - manifestparser == 1.1 09:25:36 INFO - mozInstall == 1.12 09:25:36 INFO - mozcrash == 0.17 09:25:36 INFO - mozdebug == 0.1 09:25:36 INFO - mozdevice == 0.48 09:25:36 INFO - mozfile == 1.2 09:25:36 INFO - mozhttpd == 0.7 09:25:36 INFO - mozinfo == 0.9 09:25:36 INFO - mozleak == 0.1 09:25:36 INFO - mozlog == 3.4 09:25:36 INFO - moznetwork == 0.27 09:25:36 INFO - mozprocess == 0.23 09:25:36 INFO - mozprofile == 0.28 09:25:36 INFO - mozrunner == 6.12 09:25:36 INFO - mozscreenshot == 0.1 09:25:36 INFO - mozsystemmonitor == 0.3 09:25:36 INFO - moztest == 0.7 09:25:36 INFO - mozversion == 1.4 09:25:36 INFO - psutil == 3.1.1 09:25:36 INFO - requests == 1.2.3 09:25:36 INFO - wsgiref == 0.1.2 09:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:36 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')]} 09:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:36 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')]} 09:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:36 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:36 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 09:25:36 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 09:25:36 INFO - Using env: {'DISPLAY': ':0', 09:25:36 INFO - 'HOME': '/home/cltbld', 09:25:36 INFO - 'LANG': 'en_US.UTF-8', 09:25:36 INFO - 'LANGUAGE': 'en_US:en', 09:25:36 INFO - 'LOGNAME': 'cltbld', 09:25:36 INFO - 'MAIL': '/var/mail/cltbld', 09:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:36 INFO - 'MOZ_NO_REMOTE': '1', 09:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:36 INFO - 'NO_EM_RESTART': '1', 09:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:36 INFO - 'PWD': '/builds/slave/test', 09:25:36 INFO - 'SHELL': '/bin/bash', 09:25:36 INFO - 'SHLVL': '1', 09:25:36 INFO - 'TERM': 'linux', 09:25:36 INFO - 'TMOUT': '86400', 09:25:36 INFO - 'USER': 'cltbld', 09:25:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:36 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 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)) 09:25:37 INFO - Cleaning up... 09:25:37 INFO - Return code: 0 09:25:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:37 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 0x7f7930c1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', '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 09:25:37 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 09:25:37 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 09:25:37 INFO - Using env: {'DISPLAY': ':0', 09:25:37 INFO - 'HOME': '/home/cltbld', 09:25:37 INFO - 'LANG': 'en_US.UTF-8', 09:25:37 INFO - 'LANGUAGE': 'en_US:en', 09:25:37 INFO - 'LOGNAME': 'cltbld', 09:25:37 INFO - 'MAIL': '/var/mail/cltbld', 09:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:37 INFO - 'MOZ_NO_REMOTE': '1', 09:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:37 INFO - 'NO_EM_RESTART': '1', 09:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:37 INFO - 'PWD': '/builds/slave/test', 09:25:37 INFO - 'SHELL': '/bin/bash', 09:25:37 INFO - 'SHLVL': '1', 09:25:37 INFO - 'TERM': 'linux', 09:25:37 INFO - 'TMOUT': '86400', 09:25:37 INFO - 'USER': 'cltbld', 09:25:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:37 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:37 INFO - Cleaning up... 09:25:37 INFO - Return code: 0 09:25:37 INFO - Running post-action listener: _resource_record_post_action 09:25:37 INFO - Running post-action listener: _start_resource_monitoring 09:25:37 INFO - Starting resource monitoring. 09:25:37 INFO - [mozharness: 2016-09-26 16:25:37.322096Z] Finished create-virtualenv step (success) 09:25:37 INFO - [mozharness: 2016-09-26 16:25:37.322611Z] Running install step. 09:25:37 INFO - Running pre-action listener: _resource_record_pre_action 09:25:37 INFO - Running main action method: install 09:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:37 INFO - Reading from file tmpfile_stdout 09:25:37 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:37 INFO - Reading from file tmpfile_stdout 09:25:37 INFO - Output received: 09:25:37 INFO - Usage: mozinstall [options] installer 09:25:37 INFO - Options: 09:25:37 INFO - -h, --help show this help message and exit 09:25:37 INFO - -d DEST, --destination=DEST 09:25:37 INFO - Directory to install application into. [default: 09:25:37 INFO - "/builds/slave/test"] 09:25:37 INFO - --app=APP Application being installed. [default: firefox] 09:25:37 INFO - mkdir: /builds/slave/test/build/application 09:25:37 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'] 09:25:37 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 09:25:54 INFO - Reading from file tmpfile_stdout 09:25:54 INFO - Output received: 09:25:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - [mozharness: 2016-09-26 16:25:54.608904Z] Finished install step (success) 09:25:54 INFO - [mozharness: 2016-09-26 16:25:54.609148Z] Running run-tests step. 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: run_tests 09:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:54 INFO - Python 2.7.3 09:25:54 INFO - Return code: 0 09:25:54 INFO - grabbing minidump binary from tooltool 09:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:54 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 0x29b9930>, '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 0x29ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bacc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:54 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 09:25:54 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 09:25:54 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 09:25:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:54 INFO - Return code: 0 09:25:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:25:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:25:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 09:25:54 INFO - Using env: {'DISPLAY': ':0', 09:25:54 INFO - 'HOME': '/home/cltbld', 09:25:54 INFO - 'LANG': 'en_US.UTF-8', 09:25:54 INFO - 'LANGUAGE': 'en_US:en', 09:25:54 INFO - 'LOGNAME': 'cltbld', 09:25:54 INFO - 'MAIL': '/var/mail/cltbld', 09:25:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:54 INFO - 'MOZ_NO_REMOTE': '1', 09:25:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:54 INFO - 'NO_EM_RESTART': '1', 09:25:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:54 INFO - 'PWD': '/builds/slave/test', 09:25:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:54 INFO - 'SHELL': '/bin/bash', 09:25:54 INFO - 'SHLVL': '1', 09:25:54 INFO - 'TERM': 'linux', 09:25:54 INFO - 'TMOUT': '86400', 09:25:54 INFO - 'USER': 'cltbld', 09:25:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418', 09:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:54 INFO - '_': '/tools/buildbot/bin/python'} 09:25:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:25:54 INFO - mozversion application_buildid: 20160926063000 09:25:54 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 09:25:54 INFO - mozversion application_display_name: Nightly 09:25:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:54 INFO - mozversion application_name: Firefox 09:25:54 INFO - mozversion application_remotingname: firefox 09:25:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:25:54 INFO - mozversion application_vendor: Mozilla 09:25:54 INFO - mozversion application_version: 52.0a1 09:25:54 INFO - mozversion platform_buildid: 20160926063000 09:25:54 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 09:25:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:25:54 INFO - mozversion platform_version: 52.0a1 09:25:54 INFO - using testdate: 1474907154 09:25:54 INFO - actual date: 1474907154 09:25:54 INFO - starting webserver on 'localhost:57445' 09:25:54 INFO - SUITE-START | Running 2 tests 09:25:54 INFO - TEST-START | dromaeo_css 09:25:54 INFO - operating with platform_type : linux_ 09:25:54 INFO - Initialising browser for dromaeo_css test... 09:25:54 INFO - TEST-INFO | started process 16987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1aAjgq/profile http://localhost:57445/getInfo.html) 09:25:59 INFO - PROCESS | 16987 | __metrics Screen width/height:1600/1200 09:25:59 INFO - PROCESS | 16987 | colorDepth:24 09:25:59 INFO - PROCESS | 16987 | Browser inner width/height: 1024/697 09:25:59 INFO - PROCESS | 16987 | __metrics 09:25:59 INFO - PROCESS | 16987 | 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" 09:25:59 INFO - PROCESS | 16987 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:00 INFO - PROCESS | 16987 | console.error: PushService: 09:26:00 INFO - PROCESS | 16987 | stateChangeProcessEnqueue: Error transitioning state 09:26:00 INFO - PROCESS | 16987 | UnknownError 09:26:01 INFO - TEST-INFO | 16987: exit 0 09:26:01 INFO - Browser initialized. 09:26:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:26:01 INFO - TEST-INFO | started process 17069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1aAjgq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:13 INFO - PROCESS | 17069 | RSS: Main: 177672192 09:26:13 INFO - PROCESS | 17069 | 09:27:04 INFO - PROCESS | 17069 | 1474907224403 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] 09:29:13 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:57445/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57445/tests/dromaeo/cssquery-ext.html) 09:29:14 INFO - PROCESS | 17069 | RSS: Main: 316305408 09:29:14 INFO - PROCESS | 17069 | 09:32:17 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:57445/tests/dromaeo/cssquery-ext.html (next: http://localhost:57445/tests/dromaeo/cssquery-jquery.html) 09:32:17 INFO - PROCESS | 17069 | RSS: Main: 273014784 09:32:17 INFO - PROCESS | 17069 | 09:35:20 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:57445/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57445/tests/dromaeo/cssquery-mootools.html) 09:35:20 INFO - PROCESS | 17069 | RSS: Main: 263098368 09:35:20 INFO - PROCESS | 17069 | 09:38:22 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:57445/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57445/tests/dromaeo/cssquery-prototype.html) 09:38:23 INFO - PROCESS | 17069 | RSS: Main: 234348544 09:38:23 INFO - PROCESS | 17069 | 09:41:25 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:57445/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57445/tests/dromaeo/cssquery-yui.html) 09:41:26 INFO - PROCESS | 17069 | RSS: Main: 218144768 09:41:26 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | Cycle 1(1): loaded http://localhost:57445/tests/dromaeo/cssquery-yui.html (next: http://localhost:57445/tests/dromaeo/cssquery-dojo.html) 09:44:29 INFO - PROCESS | 17069 | RSS: Main: 307212288 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | __start_tp_report 09:44:29 INFO - PROCESS | 17069 | _x_x_mozilla_page_load 09:44:29 INFO - PROCESS | 17069 | _x_x_mozilla_page_load_details 09:44:29 INFO - PROCESS | 17069 | |i|pagename|runs| 09:44:29 INFO - PROCESS | 17069 | |0;dojo.html;2964.8814047438095;3040.8023478473897;3044.832534210618;3064.862081206348;3096.3652451247494;5099.260607211952;5192.636515443921;5207.453217412174;5265.789368425263;5320.201969704542;5214.270002199695;5220.582353411718;5232.058229518685;5236.266922630825;5261.447548007452;4718.9292160617615;4730;4838.854834354975;4879.268109783526;4931.852044438672;4899.118158731427;4941.950580494185;4958.330625365584;4987.1521841286885;5029.421616514092;4687.437507499105;4731.881702957419;4736.360591320162;4796.592289655384;4834.58905992991;4826.831060912887;4940.55535001848;4944.159492886218;4944.802207911715;4952.504749525055;4784.545468180518;4833.419989601235;4836.879078023042;4846.103470857903;4892.779824907888;5302.575793936476;5311.123664595337;5317.202419637047;5328.49379308965;5328.706921119337;5495.313085864267;5531.032069387881;5554.694491802949;5597.076482380402;5602.13166959122;5682.17608446777;5708.71456427177;5714.885702285931;5734.569907256972;5772.3938986406665;5301.204819277101;5305.124654432053;5309.283246761715;5311.760970756325;5377.032134215879;5527.640703354269;5628.155776633538;5746.9712651436475;5796.217510636095;5801.9129713054335;5575.888482230333;5611.046122159243;5613.46672066153;5664.037113690682;5674.858128546819;5673.886522269531;5677.460641239076;5679.346875109415;5679.574031947621;5681.914771278434;5420.268263784417;5452.836414907559;5548.528375088082;5676.517496012885;5683.658980461186;5590.329160500684;5644.266245388073;5652.519535839499;5701.629394089371;5713.942860571424;4350.58669426404;4352.934705979413;4368.694191406571;4402.603765661106;4406.515283318832;3879.3792993120965;3880.9029774255305;3895.045713800137;3909.9413508797393;3961.8613348532663;5259.60552958522;5310.840674779763;5323.1216849219445;5388.164834450667;5393.056215162331;5688.687122208235;5692.971535142381;5693.943060569424;5707.0583353747;5751.597388182787;5378.489043540857;5383.327084114486;5383.623146379794;5390.272313237741;5391.32608423947;4768.284757286435;4790.257510085942;4797.328374027639;4817.0606731687685;4913.950860491421;5704.3725190228215;5713.171590119409;5719.227904232958;5778.797742079091;5779.479846813807;5537.2524709165355;5583.330000399978;5584.86037849057;5588.497035266845;5590.692511911721;5602.299712535933;5633.295838020247;5661.2923384576925;5724.685142317046;5758.2514273144225;5562.527185189304;5612.438756124355;5616.7191640416995;5668.0364338063455;5678.290213723285;5681.0910254359105;5690.544756419394;5691.345495268097;5701.315842098975;5705.030144875464;5385.865353366197;5424.538914192338;5562.860928476821;5568.192612071308;5569.832905012856;5410.48600382963;5452.04589196881;5469.945300546943;5497.367802702581;5567.415421380697;5371.677699338053;5410.026195284887;5410.945890541044;5416.8104116355735;5435.266239057677;5422.969635769191;5497.230387745799;5527.972360138174;5535.750891209825;5543.528800051879;5330.2804121443105;5378.381486129145;5385.730713464232;5405.594580406407;5503.284573005483 09:44:29 INFO - PROCESS | 17069 | |1;ext.html;546.8442126465021;552.5662355051282;561.1162419189777;594.9405059494051;608.297416483961;27611.5858262126;42752.14495710084;43768.562314376846;43843.56156438435;43873.78063109684;44332.3350149748;44669.55330446694;44734.10531789371;44744;44786;8888.466691998468;9033;9039.548022598876;9040.412373195753;9044.638214471413;8718.825623487526;8837.160469755363;8846.5134417607;8850.114988501131;8867.334949878752;8953.686620968267;8966.955165224164;9005.279577633773;9005.504697241682;9008.504532250723;8946.776330591721;8983.371164018521;8989.955050224773;8993.010768815426;8993.325500587416;8851.380403371766;8944.329175311877;8951.104889511062;8952.507612081334;8955.731328060168;41891.790541047405;42143;42269.1546169078;42273.36589951153;42297.36553951693;3444.7588668793196;3488.494168345576;3555.822208889545;3778.67881230093;3934.744241624314;31864.362712745846;31907.202319941956;32398.35203295921;32404.351912961843;32782.34435311281;3964.1278918637854;3965.286248475273;3972.3644216925154;3991.8802435926677;4059.837606495766;359914;360003;360029;360892.19553902326;361018;56384;56766.71616641973;56769.71615141898;56816.43183568111;56824;40094.59905400967;40615.79692101521;58188.70905645445;59339.70330148322;59591.40408595945;15791.763123553155;16503.752443713354;16524.173791310386;16728.83271167297;16731.414400496167;12962.416691248916;13053.673658158432;13057.477700892048;13059.34703264833;13063.412146453242;11431.942840285745;11581.189316747916;15982.60043498922;16084.265674835306;16136.596585085232;6080.7871724490315;6326.905096423558;6554.574807321226;6649.135612370457;6781.287964763629;887.7691800132012;983.7404040504598;987.6148302162162;1004.1916257412853;1045.5713157605346;32020.519692204634;32536;32676.346473070407;32698.346033079204;33049.66950330514;1042.1975079189133;1069.2889228662852;1092.4919912240846;1105.5190991918541;1175.6061719324123;15402.768958465633;16272.83727162737;16442.260098295606;16491.049512063815;16617.50147495577;491632;505760;507344;511298;512023;55763.49064292116;56177.43822561722;56219.43780562142;56245.7187714067;56280.155797663065;1341.2824139085542;1356.5455572383362;1379.593020059085;1388.6389538719804;1393.4008376398247;28426;28780.856095719388;30313.393732125674;30407.087787366414;31054.844725776227;47075.29387059265;47379;47435.288470672276;47450.28824567565;47458.76270618625;346548;347927;348077;348191;348702.7954021597;21339.35981920545;21853.125874964822;26842.194734157227;27738.861305693343;27784.305392365353;44743.55256447524;44910.55089449064;45036.54963450455;45324.64026079091;45547;38776;39192;39534;41008.38487422751;41119.7944010278;37245.813770930974;40277.79861100676;40664;41909.161816762884;42558.787206063775;39339.80330098331;39758.602413976645;39964;40055.59944400635;40442.1911561773;31867;34496.31007379788;35109.47335790016;35490;36545;28114.578281326205;28179.154625361272;28397.574036389884;28519.42961140807;28533.28666783347 09:44:29 INFO - PROCESS | 17069 | |2;jquery.html;385.845661735306;391.75515302935685;402.585337102784;403.2177575503523;419.5217452104599;13333.466661333536;17185.57036074099;18108.909455452722;19930.60138797225;19940.102695378708;13662.385192666328;15150.393984240618;17419.390321338757;17666.646667066652;17776.11119444029;5171.198464238049;5578.665280083188;5600.18797274395;5604.131359639242;5614.775408983656;5562.721863906789;5584.1902924075985;5669.546436285108;5672.205891175218;5673.943260567404;5477.1510415885605;5606.607537472379;5613.859653508654;5616.719164041802;5617.101263797793;5513.365962914276;5597.860053498654;5618.15727640853;5622.634528755638;5625.1843482694985;5033.245013248005;5058.013687330972;5075.3402057732255;5077.060743762416;5079.695218286877;22185.667214991787;22897.656535151986;23075.307740767803;23152.18967336152;23183.304500865;2079.7712251652306;2280.7605201453775;2289.1301305503966;2322.314917099443;2381.868997205153;9851.458169800659;9988.95005524975;9997.950010249902;10168.79662406755;10532.42071686057;1752.4567384110967;1760.9295628174857;1793.6771381151389;1835.7980622131554;1866.1415748755453;74658.25341746568;80989.59505202495;81280;82631.9999999994;83775;10305.433201173857;10492.737681558023;10593.993570610779;10886.564537418573;10929.56281748721;15158.166300853338;15173;15177.772333415007;15231.162286074372;15261;6598.1422415085735;6869.931300687029;6906.654667266717;7868.449208555347;8129.333486635343;6476.708548115346;6715.865682686319;6721.092652491949;6926.134233220848;6975.337342952412;4397.670174736908;4457.8216871324785;4565.908681826345;4601.6548758842555;4641.86074417768;1894.981050189508;1902.4387805597382;1979.140142494111;2017.3746138697052;2030.5532782787764;854.9358798090044;904.9502277374676;923.7459698582943;930.2604429478581;1053.89461053894;17225.1387430628;18360.632787344177;18686.626267474574;18934.928915614626;19071.618567628848;961.9855702164473;974.084360700953;977.8875429325718;1010.5806090472519;1050.138886113395;9828.21374290055;10524.105451036748;10714.035736783728;10722.982993011654;10808.081313088318;453218;464396;464634;466723.6663816727;503582;66976;96119.51940240254;97540.51229743806;99046.00953990368;101426.49286753518;986.980260394788;1005.2912696548915;1030.845373194027;1042.124615323117;1044.806710758512;17069.31722731077;17399.78900341268;17564.38524651631;17730.645387092445;17877;41566.58433415627;42535.57464425316;42667.999999998756;42710.5728942719;46105.07789844251;60024.39975600188;60529.09206361996;60865.391346087745;61024.69487652533;61915;8360.414770965974;8399;8465.238128568459;8708.782280442787;8810.779730506789;12126.272423654256;12873.356332183166;12903.870961290642;13358.933205333911;13550.186988780704;10913.945430272797;11095.88904110981;11394.715132121763;11578.247413918069;11813.114016448973;10550.155987520826;11131.610393636183;11237.662870113909;11316.60391886313;11764.882351176379;11466.827997579876;11663.708407289885;11764.117691173367;11961.770322013183;11978.76042479128;8307.543085130375;8391.370647201606;8767.21095101444;11185.272957258077;11919.702007449883;11236.550537978716;11647.30116193031;12132.272063676208;12179;12583.685407864876 09:44:29 INFO - PROCESS | 17069 | |3;mootools.html;1240.590605100317;1460.6348412896773;1517.9924100379496;1578.7079390312792;1692.7884014498195;8021.799455013627;8988.550572471382;9433.056694330571;9433.81132377352;9713.174380177694;9473.100055494717;9550.283728720338;9561.904380956188;9566.330356875022;9569.617215311397;2431.6960379952507;2449.3386785567886;2449.473363226906;2449.9020039198413;2457.58221102413;2375.4417711837705;2398.244552965819;2449.289705985262;2454.6563481112657;2456;2340.2511196417154;2353.399883029825;2377.512609914972;2405.987970060156;2414.6498757680124;2332.626779715246;2333.673285739998;2341.718993720756;2346.378209774411;2375.691160149187;2315.872627005514;2318;2320.6867072945106;2321.0831721470095;2324.465372964211;8922.598483068212;9323.72028839136;9351.76620584484;9364.110409511153;9488.905110948872;5430.728463576806;5659.066254068074;5664.150377443417;5696.231008813798;5702.77188912443;3520.6695764210167;3533.5583052118486;3535.416656251741;3567;3589.300086483137;1014.3862962907408;1019.6074511313124;1034.5086084110062;1035.3891204189565;1038.5897570459701;13099.86900130996;13122.737545249138;13386.531471398454;13389;13404.262765547988;4502.5047244803045;4649.18639238132;4697.154512187771;4851.708897466164;4855.5387238212315;10279.383237005804;10299.742506437398;10310.896891030994;10316.329438586468;10321.174306055498;5434.076207044733;5454.781808727606;5471.753771080232;5474.671519708831;5505.669659820343;4209.7474151551005;4416.293393057095;4551.544845515422;4567.018091110427;5106.770195341219;3732.682721968663;3874.496315479026;3912.256671232457;3912.921741565153;3929.292727309112;1177.4819079604947;1224.0758227538151;1225.4301749686438;1238.139493052338;1242.7328124453104;831.3556993330218;918.0910898210857;922.4511415707643;927.7773334399695;943.193569498083;6063.393660633901;6084.969575152096;6224.470919971853;6225.097360882737;6543.574667646683;456.58678895599536;468.83590743240273;471.32600381454165;476.7258826174894;487.7683100527292;4109.547949725587;4264.530901600883;4290.141971605692;4292.635126014261;4327.956720432819;11579.826302605468;11648.70878228034;11748.765024699458;11886.049116070693;11892.762144757056;11595.362255075883;11746.70633234159;11772.88227117735;11791.646250612324;11826.231294965799;8640.740777776677;8777.385583009256;8810.515421651742;8811.251043661232;8814.471131732116;6225.62646241227;6274.6548939808745;6303.1175635412;6305.117283580211;6310.873782524415;10650.201234907569;10789.352638841694;10850.403227822546;10858.565657373616;10944.671659849899;9170.908290917005;11057.225994180651;11099.112071034458;11182.217244792786;11251;7452.701891924262;7664.80837979055;7678.424118191269;7688.500247483896;7718.807029824299;8765.298776097768;8783.692570759993;8819.735407937773;8834.072422395557;8907.153820387053;7835.725749598737;7916.643751031333;7929.286364227247;7969.6015199240965;8012.959935200287;7880.014998125234;7883.329916957123;7915.208479152038;7926.286634202949;8078.6364613593705;7221.4222862171955;7367.373773229336;7416.740414085697;7641.617919104134;7646.388288936983;4988.351514303117;5086.21163719624;5090.363704536933;5096.311997880387;5106;4957.35554377943;5119.74401279942;5145.588352931682;5331.333583302087;5351.892962140658 09:44:29 INFO - PROCESS | 17069 | |4;prototype.html;326.90192942117375;334.86772724773715;336.885458943959;340.72060910053756;342.41276211297617;5113.33526641537;5238.423773384925;5262.368515778107;5270.81406683497;5317.49483799039;5041;5103.540681338679;5151.304573882525;5160.838811267463;5187.23633964452;4147.506897516907;4155.542890282067;4156.314208155666;4162.188373267214;4176.624103830647;3970.4441378207075;4124.917501649965;4159.937600935973;4174.895627609304;4198.727082739628;4121.752694838305;4132.607402296777;4136.751794892316;4139.586041395866;4161.646260067898;4117.447182746716;4121.340585506319;4126.958730412687;4145.54399016108;4155.709100362976;3622.1850083731215;3714.3685573452576;3717.20080182762;3725.9627403725885;3730.198007428416;5091.23631455281;5092.134337162691;5097.388313402378;5100.846974590768;5105.412877519096;4746.810127594927;4771.141194584973;4779.068081724065;4793.113274044313;4817.807287708488;5320.787168513255;5407.675539467606;5455.063452474394;5456.236126942231;5483.60016789593;4031.3348297530874;4033.81847816846;4053.8041277823113;4059.6955228357992;4071.7760523171214;5666.724986877919;5719.828405147852;5721.942780572224;5723.255976723041;5727.1695604137585;4023.2355852387955;4122.34042553196;4129.442525259112;4170.72890262132;4183.226103170923;4196.958030419718;4201.474815648044;4209.852655157055;4214.093969796509;4224.683148763855;4751.144793937125;4758.191107511731;4762.666613337033;4765.976170119127;4785.569298763058;5414.864628384322;5513.7794488220825;5539.861503462365;5544.889102217933;5569.972150139223;1375.4910683047337;1393.2615713671566;1412.498563010137;1437.3891096284037;1450.5285782120852;997.1275134257525;1014.1937159957852;1030.644427672452;1035.5805898611075;1038.7610849504506;5185.744201272459;5196.506331898464;5216.869578260498;5242.850431323215;5275.4724527547705;5487.451254874481;5543.25166102571;5553.445794691401;5565.332160140809;5568.749406276727;5076.213186956028;5132.46109158533;5149.658847552109;5277.182036784305;5290.894182116336;2542.580474221733;2566.5636841736577;2598.9610155847677;2636.220551127981;2647.2455350225478;4993.775280112403;5014.598832093424;5026.522480364432;5029.636071046602;5072.797088116507;5021.895183059721;5072;5372.892542149213;5768.682722450221;5785.971070144622;5729.369769325371;5731.885362292647;5737.340205876294;5740.339860915965;5751.338596061423;5475.534579560623;5640.520555752807;5648.915266271091;5662.235598194191;5741.540676745767;5530.62631794613;5531.806386776443;5562.159732281169;5568.081266590967;5590.720463976866;5688.175214593944;5710.257666503494;5722.799702010409;5732.140178973187;5738.282714660668;3998.5601583826337;4035.9192816142927;4040.7373520721058;4049.7367671101283;4106.281400754916;5340.5994550408095;5492.148716948719;5597.44025597437;5677.602567820213;5684.971575142098;5358.383785864676;5382.165764306539;5390.137577987503;5409.215663728816;5520.66875987442;5468.781248750164;5476.616636835383;5505.889882202414;5517.724113794375;5521.089020311603;5294.894102117859;5432.511074003359;5449.891002180014;5454.481824226692;5530.917036244379;5502.789386335;5511.559075273888;5511.807086752105;5533.335999680065;5534.972325138348;5176.964607078675;5411.972940135274;5440.918386224289;5440.972795135999;5444.455554444524 09:44:29 INFO - PROCESS | 17069 | |5;yui.html;744.9590272535008;755.5957562703954;779.1935346915943;779.9220077992202;825.4510750351017;14856.33146508407;16113.113778742165;16345.754813677804;16347.34610615574;16426.83573164268;15212.23938803061;15398.538043858674;15441.69116617667;15443.845561544382;15452.15013174275;542.9782808687647;556.8524341049605;783.5416281475316;789.3527307607764;792.4690457393531;812.3501199040774;813.8779183122549;814.9633266503022;815.3029160068145;815.6451943404609;468.15498026062943;860.8837806896083;861.1517655109712;862.6290695001147;862.8188080503102;470.57648116695077;800.5596921693045;801.5951944268165;808.5391326943644;831.8294749576322;620.8044465993243;622.2657264427974;622.9719662615194;623.7286780250605;623.7349126621168;14470.565883023526;14540.127592344494;14543.636409089751;14549.272536373244;14637.487687930978;14781.482648107372;15109.54671359861;15176.848231517764;15205.391784328614;15207.543773686808;10216.948915255376;10317.638882639072;10590.31162974412;10672.03951644348;10841.403722795243;3766.9811650941842;3791.545014598238;3793.696504279651;3940.980295098535;3960.4653371794725;66918;67817;68189.9999999995;84914;86583.56708216481;10209;10701.83947240792;10846.78306433867;11226.382548959886;11413.315201087962;22893.08427662875;22940;22956;23010;23108.075676972734;8205.79485512855;8265.628046737911;8304.875426868603;8395.202455766814;8530.019047809457;4235.709188932081;4389.1660584488845;4395.110327360245;4469.955300447019;4536.682432229778;3434.5191673165778;3561.8397172127316;3566.661167189113;3571.4821350904494;3572.1426857554;578.7684926029538;585.4847733994143;587.7854583077232;595.1578516399333;595.5295316699759;611.4466407900857;635.4725577770532;654.8690261947535;683.4668958212602;717.7810767715897;8495.74512764618;8967.072079502808;9085.909140908638;9233.307501937381;9492.952535237418;676.2324761395851;716.4984510842431;717.5658726470515;738.1879932074783;749.1871319618166;4404.6256068233915;4470.240059189946;4477.910441791211;4511.571400716926;4516.661250406232;68402;68576.6571167141;69392.30607693858;69535.3046469539;120901.39549302198;107255;110792.44603776929;111163.44418277856;113782.43108784403;117381;94082;96099.51950240343;96859.51570242245;97711;98471;8431.494110353398;8440.831183376175;8444;8649.3512986525;8715.215630593277;45670.771646141555;49606.751966239935;50391;51992.22011669752;56314.029008984486;49725;50038.249426257906;54199.01905395083;72835.63582182056;76827.23172768201;11112.388818615054;11284.548618055185;11505.309681419141;11773.234739741889;12159.392030398269;13159.802602960772;13189.670258243621;13341.533046343331;13416.798748018982;14482;8051.677932882619;12639.241645501299;12900;13065.608031759062;13112.475500979854;13842.30788460593;13865.168089914638;13996.860031399556;14102.224377659328;14367.856321436651;12862.678433038875;12902.225866448043;12978;13051.804222936853;13692.931535342259;10519.579216831242;10755.408452535186;11129.66611001639;11234.719132021764;11280.548778048786;11481.598144064918;11552.711182220175;11590.826137608112;11591.826122608;11650.30098194111 09:44:29 INFO - PROCESS | 17069 | __end_tp_report 09:44:29 INFO - PROCESS | 17069 | __start_cc_report 09:44:29 INFO - PROCESS | 17069 | _x_x_mozilla_cycle_collect,972 09:44:29 INFO - PROCESS | 17069 | __end_cc_report 09:44:29 INFO - PROCESS | 17069 | __startTimestamp1474908269442__endTimestamp 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | ------- Summary: start ------- 09:44:29 INFO - PROCESS | 17069 | Number of tests: 6 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | [#0] dojo.html Cycles:165 Average:5244.55 Median:5410.49 stddev:577.78 (10.7%) stddev-sans-first:551.18 09:44:29 INFO - PROCESS | 17069 | Values: 2964.9 3040.8 3044.8 3064.9 3096.4 5099.3 5192.6 5207.5 5265.8 5320.2 5214.3 5220.6 5232.1 5236.3 5261.4 4718.9 4730.0 4838.9 4879.3 4931.9 4899.1 4942.0 4958.3 4987.2 5029.4 4687.4 4731.9 4736.4 4796.6 4834.6 4826.8 4940.6 4944.2 4944.8 4952.5 4784.5 4833.4 4836.9 4846.1 4892.8 5302.6 5311.1 5317.2 5328.5 5328.7 5495.3 5531.0 5554.7 5597.1 5602.1 5682.2 5708.7 5714.9 5734.6 5772.4 5301.2 5305.1 5309.3 5311.8 5377.0 5527.6 5628.2 5747.0 5796.2 5801.9 5575.9 5611.0 5613.5 5664.0 5674.9 5673.9 5677.5 5679.3 5679.6 5681.9 5420.3 5452.8 5548.5 5676.5 5683.7 5590.3 5644.3 5652.5 5701.6 5713.9 4350.6 4352.9 4368.7 4402.6 4406.5 3879.4 3880.9 3895.0 3909.9 3961.9 5259.6 5310.8 5323.1 5388.2 5393.1 5688.7 5693.0 5693.9 5707.1 5751.6 5378.5 5383.3 5383.6 5390.3 5391.3 4768.3 4790.3 4797.3 4817.1 4914.0 5704.4 5713.2 5719.2 5778.8 5779.5 5537.3 5583.3 5584.9 5588.5 5590.7 5602.3 5633.3 5661.3 5724.7 5758.3 5562.5 5612.4 5616.7 5668.0 5678.3 5681.1 5690.5 5691.3 5701.3 5705.0 5385.9 5424.5 5562.9 5568.2 5569.8 5410.5 5452.0 5469.9 5497.4 5567.4 5371.7 5410.0 5410.9 5416.8 5435.3 5423.0 5497.2 5528.0 5535.8 5543.5 5330.3 5378.4 5385.7 5405.6 5503.3 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | [#1] ext.html Cycles:180 Average:56222.31 Median:40186.20 stddev:108763.47 (270.6%) stddev-sans-first:108988.25 09:44:29 INFO - PROCESS | 17069 | Values: 546.8 552.6 561.1 594.9 608.3 27611.6 42752.1 43768.6 43843.6 43873.8 44332.3 44669.6 44734.1 44744.0 44786.0 8888.5 9033.0 9039.5 9040.4 9044.6 8718.8 8837.2 8846.5 8850.1 8867.3 8953.7 8967.0 9005.3 9005.5 9008.5 8946.8 8983.4 8990.0 8993.0 8993.3 8851.4 8944.3 8951.1 8952.5 8955.7 41891.8 42143.0 42269.2 42273.4 42297.4 3444.8 3488.5 3555.8 3778.7 3934.7 31864.4 31907.2 32398.4 32404.4 32782.3 3964.1 3965.3 3972.4 3991.9 4059.8 359914.0 360003.0 360029.0 360892.2 361018.0 56384.0 56766.7 56769.7 56816.4 56824.0 40094.6 40615.8 58188.7 59339.7 59591.4 15791.8 16503.8 16524.2 16728.8 16731.4 12962.4 13053.7 13057.5 13059.3 13063.4 11431.9 11581.2 15982.6 16084.3 16136.6 6080.8 6326.9 6554.6 6649.1 6781.3 887.8 983.7 987.6 1004.2 1045.6 32020.5 32536.0 32676.3 32698.3 33049.7 1042.2 1069.3 1092.5 1105.5 1175.6 15402.8 16272.8 16442.3 16491.0 16617.5 491632.0 505760.0 507344.0 511298.0 512023.0 55763.5 56177.4 56219.4 56245.7 56280.2 1341.3 1356.5 1379.6 1388.6 1393.4 28426.0 28780.9 30313.4 30407.1 31054.8 47075.3 47379.0 47435.3 47450.3 47458.8 346548.0 347927.0 348077.0 348191.0 348702.8 21339.4 21853.1 26842.2 27738.9 27784.3 44743.6 44910.6 45036.5 45324.6 45547.0 38776.0 39192.0 39534.0 41008.4 41119.8 37245.8 40277.8 40664.0 41909.2 42558.8 39339.8 39758.6 39964.0 40055.6 40442.2 31867.0 34496.3 35109.5 35490.0 36545.0 28114.6 28179.2 28397.6 28519.4 28533.3 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | [#2] jquery.html Cycles:180 Average:28323.18 Median:1383.86 stddev:77860.22 (5626.3%) stddev-sans-first:78050.38 09:44:29 INFO - PROCESS | 17069 | Values: 385.8 391.8 402.6 403.2 419.5 13333.5 17185.6 18108.9 19930.6 19940.1 13662.4 15150.4 17419.4 17666.6 17776.1 5171.2 5578.7 5600.2 5604.1 5614.8 5562.7 5584.2 5669.5 5672.2 5673.9 5477.2 5606.6 5613.9 5616.7 5617.1 5513.4 5597.9 5618.2 5622.6 5625.2 5033.2 5058.0 5075.3 5077.1 5079.7 22185.7 22897.7 23075.3 23152.2 23183.3 2079.8 2280.8 2289.1 2322.3 2381.9 9851.5 9989.0 9998.0 10168.8 10532.4 1752.5 1760.9 1793.7 1835.8 1866.1 74658.3 80989.6 81280.0 82632.0 83775.0 10305.4 10492.7 10594.0 10886.6 10929.6 15158.2 15173.0 15177.8 15231.2 15261.0 6598.1 6869.9 6906.7 7868.4 8129.3 6476.7 6715.9 6721.1 6926.1 6975.3 4397.7 4457.8 4565.9 4601.7 4641.9 1895.0 1902.4 1979.1 2017.4 2030.6 854.9 905.0 923.7 930.3 1053.9 17225.1 18360.6 18686.6 18934.9 19071.6 962.0 974.1 977.9 1010.6 1050.1 9828.2 10524.1 10714.0 10723.0 10808.1 453218.0 464396.0 464634.0 466723.7 503582.0 66976.0 96119.5 97540.5 99046.0 101426.5 987.0 1005.3 1030.8 1042.1 1044.8 17069.3 17399.8 17564.4 17730.6 17877.0 41566.6 42535.6 42668.0 42710.6 46105.1 60024.4 60529.1 60865.4 61024.7 61915.0 8360.4 8399.0 8465.2 8708.8 8810.8 12126.3 12873.4 12903.9 13358.9 13550.2 10913.9 11095.9 11394.7 11578.2 11813.1 10550.2 11131.6 11237.7 11316.6 11764.9 11466.8 11663.7 11764.1 11961.8 11978.8 8307.5 8391.4 8767.2 11185.3 11919.7 11236.6 11647.3 12132.3 12179.0 12583.7 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | [#3] mootools.html Cycles:180 Average:6028.95 Median:2559.01 stddev:3564.47 (139.3%) stddev-sans-first:3556.31 09:44:29 INFO - PROCESS | 17069 | Values: 1240.6 1460.6 1518.0 1578.7 1692.8 8021.8 8988.6 9433.1 9433.8 9713.2 9473.1 9550.3 9561.9 9566.3 9569.6 2431.7 2449.3 2449.5 2449.9 2457.6 2375.4 2398.2 2449.3 2454.7 2456.0 2340.3 2353.4 2377.5 2406.0 2414.6 2332.6 2333.7 2341.7 2346.4 2375.7 2315.9 2318.0 2320.7 2321.1 2324.5 8922.6 9323.7 9351.8 9364.1 9488.9 5430.7 5659.1 5664.2 5696.2 5702.8 3520.7 3533.6 3535.4 3567.0 3589.3 1014.4 1019.6 1034.5 1035.4 1038.6 13099.9 13122.7 13386.5 13389.0 13404.3 4502.5 4649.2 4697.2 4851.7 4855.5 10279.4 10299.7 10310.9 10316.3 10321.2 5434.1 5454.8 5471.8 5474.7 5505.7 4209.7 4416.3 4551.5 4567.0 5106.8 3732.7 3874.5 3912.3 3912.9 3929.3 1177.5 1224.1 1225.4 1238.1 1242.7 831.4 918.1 922.5 927.8 943.2 6063.4 6085.0 6224.5 6225.1 6543.6 456.6 468.8 471.3 476.7 487.8 4109.5 4264.5 4290.1 4292.6 4328.0 11579.8 11648.7 11748.8 11886.0 11892.8 11595.4 11746.7 11772.9 11791.6 11826.2 8640.7 8777.4 8810.5 8811.3 8814.5 6225.6 6274.7 6303.1 6305.1 6310.9 10650.2 10789.4 10850.4 10858.6 10944.7 9170.9 11057.2 11099.1 11182.2 11251.0 7452.7 7664.8 7678.4 7688.5 7718.8 8765.3 8783.7 8819.7 8834.1 8907.2 7835.7 7916.6 7929.3 7969.6 8013.0 7880.0 7883.3 7915.2 7926.3 8078.6 7221.4 7367.4 7416.7 7641.6 7646.4 4988.4 5086.2 5090.4 5096.3 5106.0 4957.4 5119.7 5145.6 5331.3 5351.9 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | [#4] prototype.html Cycles:180 Average:4598.97 Median:5141.06 stddev:1329.05 (25.9%) stddev-sans-first:1293.52 09:44:29 INFO - PROCESS | 17069 | Values: 326.9 334.9 336.9 340.7 342.4 5113.3 5238.4 5262.4 5270.8 5317.5 5041.0 5103.5 5151.3 5160.8 5187.2 4147.5 4155.5 4156.3 4162.2 4176.6 3970.4 4124.9 4159.9 4174.9 4198.7 4121.8 4132.6 4136.8 4139.6 4161.6 4117.4 4121.3 4127.0 4145.5 4155.7 3622.2 3714.4 3717.2 3726.0 3730.2 5091.2 5092.1 5097.4 5100.8 5105.4 4746.8 4771.1 4779.1 4793.1 4817.8 5320.8 5407.7 5455.1 5456.2 5483.6 4031.3 4033.8 4053.8 4059.7 4071.8 5666.7 5719.8 5721.9 5723.3 5727.2 4023.2 4122.3 4129.4 4170.7 4183.2 4197.0 4201.5 4209.9 4214.1 4224.7 4751.1 4758.2 4762.7 4766.0 4785.6 5414.9 5513.8 5539.9 5544.9 5570.0 1375.5 1393.3 1412.5 1437.4 1450.5 997.1 1014.2 1030.6 1035.6 1038.8 5185.7 5196.5 5216.9 5242.9 5275.5 5487.5 5543.3 5553.4 5565.3 5568.7 5076.2 5132.5 5149.7 5277.2 5290.9 2542.6 2566.6 2599.0 2636.2 2647.2 4993.8 5014.6 5026.5 5029.6 5072.8 5021.9 5072.0 5372.9 5768.7 5786.0 5729.4 5731.9 5737.3 5740.3 5751.3 5475.5 5640.5 5648.9 5662.2 5741.5 5530.6 5531.8 5562.2 5568.1 5590.7 5688.2 5710.3 5722.8 5732.1 5738.3 3998.6 4035.9 4040.7 4049.7 4106.3 5340.6 5492.1 5597.4 5677.6 5685.0 5358.4 5382.2 5390.1 5409.2 5520.7 5468.8 5476.6 5505.9 5517.7 5521.1 5294.9 5432.5 5449.9 5454.5 5530.9 5502.8 5511.6 5511.8 5533.3 5535.0 5177.0 5412.0 5440.9 5441.0 5444.5 09:44:29 INFO - PROCESS | 17069 | 09:44:29 INFO - PROCESS | 17069 | [#5] yui.html Cycles:180 Average:19868.37 Median:4474.08 stddev:28759.49 (642.8%) stddev-sans-first:28804.32 09:44:29 INFO - PROCESS | 17069 | Values: 745.0 755.6 779.2 779.9 825.5 14856.3 16113.1 16345.8 16347.3 16426.8 15212.2 15398.5 15441.7 15443.8 15452.2 543.0 556.9 783.5 789.4 792.5 812.4 813.9 815.0 815.3 815.6 468.2 860.9 861.2 862.6 862.8 470.6 800.6 801.6 808.5 831.8 620.8 622.3 623.0 623.7 623.7 14470.6 14540.1 14543.6 14549.3 14637.5 14781.5 15109.5 15176.8 15205.4 15207.5 10216.9 10317.6 10590.3 10672.0 10841.4 3767.0 3791.5 3793.7 3941.0 3960.5 66918.0 67817.0 68190.0 84914.0 86583.6 10209.0 10701.8 10846.8 11226.4 11413.3 22893.1 22940.0 22956.0 23010.0 23108.1 8205.8 8265.6 8304.9 8395.2 8530.0 4235.7 4389.2 4395.1 4470.0 4536.7 3434.5 3561.8 3566.7 3571.5 3572.1 578.8 585.5 587.8 595.2 595.5 611.4 635.5 654.9 683.5 717.8 8495.7 8967.1 9085.9 9233.3 9493.0 676.2 716.5 717.6 738.2 749.2 4404.6 4470.2 4477.9 4511.6 4516.7 68402.0 68576.7 69392.3 69535.3 120901.4 107255.0 110792.4 111163.4 113782.4 117381.0 94082.0 96099.5 96859.5 97711.0 98471.0 8431.5 8440.8 8444.0 8649.4 8715.2 45670.8 49606.8 50391.0 51992.2 56314.0 49725.0 50038.2 54199.0 72835.6 76827.2 11112.4 11284.5 11505.3 11773.2 12159.4 13159.8 13189.7 13341.5 13416.8 14482.0 8051.7 12639.2 12900.0 13065.6 13112.5 13842.3 13865.2 13996.9 14102.2 14367.9 12862.7 12902.2 12978.0 13051.8 13692.9 10519.6 10755.4 11129.7 11234.7 11280.5 11481.6 11552.7 11590.8 11591.8 11650.3 09:44:29 INFO - PROCESS | 17069 | -------- Summary: end -------- 09:44:29 INFO - PROCESS | 17069 | 09:44:30 INFO - TEST-INFO | 17069: exit 0 09:44:30 INFO - TEST-OK | dromaeo_css | took 1115540ms 09:44:30 INFO - TEST-START | kraken 09:44:30 INFO - operating with platform_type : linux_ 09:44:30 INFO - Initialising browser for kraken test... 09:44:30 INFO - TEST-INFO | started process 17373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFStgUI/profile http://localhost:57445/getInfo.html) 09:44:34 INFO - PROCESS | 17373 | __metrics Screen width/height:1600/1200 09:44:34 INFO - PROCESS | 17373 | colorDepth:24 09:44:34 INFO - PROCESS | 17373 | Browser inner width/height: 1024/697 09:44:34 INFO - PROCESS | 17373 | __metrics 09:44:35 INFO - PROCESS | 17373 | 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" 09:44:35 INFO - PROCESS | 17373 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:35 INFO - PROCESS | 17373 | console.error: PushService: 09:44:35 INFO - PROCESS | 17373 | stateChangeProcessEnqueue: Error transitioning state 09:44:35 INFO - PROCESS | 17373 | UnknownError 09:44:36 INFO - TEST-INFO | 17373: exit 0 09:44:36 INFO - Browser initialized. 09:44:36 INFO - Running cycle 1/1 for kraken test... 09:44:36 INFO - TEST-INFO | started process 17457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFStgUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:48 INFO - PROCESS | 17457 | RSS: Main: 173826048 09:44:48 INFO - PROCESS | 17457 | 09:44:51 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57445/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:52 INFO - PROCESS | 17457 | RSS: Main: 232456192 09:44:52 INFO - PROCESS | 17457 | 09:44:54 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57445/tests/kraken/driver.html?testName=audio-dft) 09:44:55 INFO - PROCESS | 17457 | RSS: Main: 217038848 09:44:55 INFO - PROCESS | 17457 | 09:44:58 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57445/tests/kraken/driver.html?testName=audio-fft) 09:44:59 INFO - PROCESS | 17457 | RSS: Main: 298332160 09:44:59 INFO - PROCESS | 17457 | 09:45:01 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57445/tests/kraken/driver.html?testName=audio-oscillator) 09:45:01 INFO - PROCESS | 17457 | RSS: Main: 208187392 09:45:01 INFO - PROCESS | 17457 | 09:45:03 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57445/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:04 INFO - PROCESS | 17457 | RSS: Main: 213127168 09:45:04 INFO - PROCESS | 17457 | 09:45:07 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57445/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:08 INFO - PROCESS | 17457 | RSS: Main: 249974784 09:45:08 INFO - PROCESS | 17457 | 09:45:11 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57445/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:11 INFO - PROCESS | 17457 | RSS: Main: 248471552 09:45:11 INFO - PROCESS | 17457 | 09:45:14 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57445/tests/kraken/driver.html?testName=json-parse-financial) 09:45:15 INFO - PROCESS | 17457 | RSS: Main: 248348672 09:45:15 INFO - PROCESS | 17457 | 09:45:16 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57445/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:17 INFO - PROCESS | 17457 | RSS: Main: 210735104 09:45:17 INFO - PROCESS | 17457 | 09:45:19 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:19 INFO - PROCESS | 17457 | RSS: Main: 218292224 09:45:19 INFO - PROCESS | 17457 | 09:45:21 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:22 INFO - PROCESS | 17457 | RSS: Main: 222642176 09:45:22 INFO - PROCESS | 17457 | 09:45:25 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:25 INFO - PROCESS | 17457 | RSS: Main: 223449088 09:45:25 INFO - PROCESS | 17457 | 09:45:28 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:29 INFO - PROCESS | 17457 | RSS: Main: 221474816 09:45:29 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | Cycle 1(1): loaded http://localhost:57445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57445/tests/kraken/driver.html?testName=ai-astar) 09:45:30 INFO - PROCESS | 17457 | RSS: Main: 272547840 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | __start_tp_report 09:45:30 INFO - PROCESS | 17457 | _x_x_mozilla_page_load 09:45:30 INFO - PROCESS | 17457 | _x_x_mozilla_page_load_details 09:45:30 INFO - PROCESS | 17457 | |i|pagename|runs| 09:45:30 INFO - PROCESS | 17457 | |0;ai-astar;107;110;110;110;110;110;111;110;110;110 09:45:30 INFO - PROCESS | 17457 | |1;audio-beat-detection;142;122;119;156;125;117;118;117;145;118 09:45:30 INFO - PROCESS | 17457 | |2;audio-dft;162;162;163;161;162;161;164;162;161;162 09:45:30 INFO - PROCESS | 17457 | |3;audio-fft;76;76;75;105;77;76;87;76;97;77 09:45:30 INFO - PROCESS | 17457 | |4;audio-oscillator;83;84;113;84;83;82;104;82;82;107 09:45:30 INFO - PROCESS | 17457 | |5;imaging-gaussian-blur;118;117;117;117;117;116;117;117;116;118 09:45:30 INFO - PROCESS | 17457 | |6;imaging-darkroom;147;147;146;146;147;148;146;147;147;146 09:45:30 INFO - PROCESS | 17457 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;95 09:45:30 INFO - PROCESS | 17457 | |8;json-parse-financial;53;49;49;50;51;51;51;52;51;53 09:45:30 INFO - PROCESS | 17457 | |9;json-stringify-tinderbox;61;60;60;61;60;60;60;61;60;60 09:45:30 INFO - PROCESS | 17457 | |10;stanford-crypto-aes;79;79;88;82;78;85;81;79;87;78 09:45:30 INFO - PROCESS | 17457 | |11;stanford-crypto-ccm;123;121;122;125;124;141;124;122;161;124 09:45:30 INFO - PROCESS | 17457 | |12;stanford-crypto-pbkdf2;167;163;167;167;167;160;165;162;162;163 09:45:30 INFO - PROCESS | 17457 | |13;stanford-crypto-sha256-iterative;65;73;66;65;65;67;64;71;65;64 09:45:30 INFO - PROCESS | 17457 | __end_tp_report 09:45:30 INFO - PROCESS | 17457 | __start_cc_report 09:45:30 INFO - PROCESS | 17457 | _x_x_mozilla_cycle_collect,1620 09:45:30 INFO - PROCESS | 17457 | __end_cc_report 09:45:30 INFO - PROCESS | 17457 | __startTimestamp1474908330969__endTimestamp 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | ------- Summary: start ------- 09:45:30 INFO - PROCESS | 17457 | Number of tests: 14 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:0.33 09:45:30 INFO - PROCESS | 17457 | Values: 107.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:123.50 stddev:14.29 (11.6%) stddev-sans-first:14.21 09:45:30 INFO - PROCESS | 17457 | Values: 142.0 122.0 119.0 156.0 125.0 117.0 118.0 117.0 145.0 118.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 09:45:30 INFO - PROCESS | 17457 | Values: 162.0 162.0 163.0 161.0 162.0 161.0 164.0 162.0 161.0 162.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.50 stddev:10.65 (13.9%) stddev-sans-first:11.06 09:45:30 INFO - PROCESS | 17457 | Values: 76.0 76.0 75.0 105.0 77.0 76.0 87.0 76.0 97.0 77.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.50 stddev:12.36 (15.0%) stddev-sans-first:12.81 09:45:30 INFO - PROCESS | 17457 | Values: 83.0 84.0 113.0 84.0 83.0 82.0 104.0 82.0 82.0 107.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 09:45:30 INFO - PROCESS | 17457 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 118.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:45:30 INFO - PROCESS | 17457 | Values: 147.0 147.0 146.0 146.0 147.0 148.0 146.0 147.0 147.0 146.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:45:30 INFO - PROCESS | 17457 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.41 (2.8%) stddev-sans-first:1.30 09:45:30 INFO - PROCESS | 17457 | Values: 53.0 49.0 49.0 50.0 51.0 51.0 51.0 52.0 51.0 53.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 09:45:30 INFO - PROCESS | 17457 | Values: 61.0 60.0 60.0 61.0 60.0 60.0 60.0 61.0 60.0 60.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.50 stddev:3.78 (4.6%) stddev-sans-first:3.89 09:45:30 INFO - PROCESS | 17457 | Values: 79.0 79.0 88.0 82.0 78.0 85.0 81.0 79.0 87.0 78.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:124.00 stddev:12.72 (10.3%) stddev-sans-first:13.32 09:45:30 INFO - PROCESS | 17457 | Values: 123.0 121.0 122.0 125.0 124.0 141.0 124.0 122.0 161.0 124.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:166.00 stddev:2.63 (1.6%) stddev-sans-first:2.60 09:45:30 INFO - PROCESS | 17457 | Values: 167.0 163.0 167.0 167.0 167.0 160.0 165.0 162.0 162.0 163.0 09:45:30 INFO - PROCESS | 17457 | 09:45:30 INFO - PROCESS | 17457 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:65.50 stddev:3.06 (4.7%) stddev-sans-first:3.20 09:45:30 INFO - PROCESS | 17457 | Values: 65.0 73.0 66.0 65.0 65.0 67.0 64.0 71.0 65.0 64.0 09:45:30 INFO - PROCESS | 17457 | -------- Summary: end -------- 09:45:30 INFO - PROCESS | 17457 | 09:45:32 INFO - TEST-INFO | 17457: exit 0 09:45:32 INFO - TEST-OK | kraken | took 61751ms 09:45:32 INFO - SUITE-END | took 1177s 09:45:32 INFO - Completed test suite (00:19:37) 09:45:32 INFO - javascript benchmark 09:45:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2964.8814047438095, 3040.8023478473897, 3044.832534210618, 3064.862081206348, 3096.3652451247494, 5099.260607211952, 5192.636515443921, 5207.453217412174, 5265.789368425263, 5320.201969704542, 5214.270002199695, 5220.582353411718, 5232.058229518685, 5236.266922630825, 5261.447548007452, 4718.9292160617615, 4730.0, 4838.854834354975, 4879.268109783526, 4931.852044438672, 4899.118158731427, 4941.950580494185, 4958.330625365584, 4987.1521841286885, 5029.421616514092, 4687.437507499105, 4731.881702957419, 4736.360591320162, 4796.592289655384, 4834.58905992991, 4826.831060912887, 4940.55535001848, 4944.159492886218, 4944.802207911715, 4952.504749525055, 4784.545468180518, 4833.419989601235, 4836.879078023042, 4846.103470857903, 4892.779824907888, 5302.575793936476, 5311.123664595337, 5317.202419637047, 5328.49379308965, 5328.706921119337, 5495.313085864267, 5531.032069387881, 5554.694491802949, 5597.076482380402, 5602.13166959122, 5682.17608446777, 5708.71456427177, 5714.885702285931, 5734.569907256972, 5772.3938986406665, 5301.204819277101, 5305.124654432053, 5309.283246761715, 5311.760970756325, 5377.032134215879, 5527.640703354269, 5628.155776633538, 5746.9712651436475, 5796.217510636095, 5801.9129713054335, 5575.888482230333, 5611.046122159243, 5613.46672066153, 5664.037113690682, 5674.858128546819, 5673.886522269531, 5677.460641239076, 5679.346875109415, 5679.574031947621, 5681.914771278434, 5420.268263784417, 5452.836414907559, 5548.528375088082, 5676.517496012885, 5683.658980461186, 5590.329160500684, 5644.266245388073, 5652.519535839499, 5701.629394089371, 5713.942860571424, 4350.58669426404, 4352.934705979413, 4368.694191406571, 4402.603765661106, 4406.515283318832, 3879.3792993120965, 3880.9029774255305, 3895.045713800137, 3909.9413508797393, 3961.8613348532663, 5259.60552958522, 5310.840674779763, 5323.1216849219445, 5388.164834450667, 5393.056215162331, 5688.687122208235, 5692.971535142381, 5693.943060569424, 5707.0583353747, 5751.597388182787, 5378.489043540857, 5383.327084114486, 5383.623146379794, 5390.272313237741, 5391.32608423947, 4768.284757286435, 4790.257510085942, 4797.328374027639, 4817.0606731687685, 4913.950860491421, 5704.3725190228215, 5713.171590119409, 5719.227904232958, 5778.797742079091, 5779.479846813807, 5537.2524709165355, 5583.330000399978, 5584.86037849057, 5588.497035266845, 5590.692511911721, 5602.299712535933, 5633.295838020247, 5661.2923384576925, 5724.685142317046, 5758.2514273144225, 5562.527185189304, 5612.438756124355, 5616.7191640416995, 5668.0364338063455, 5678.290213723285, 5681.0910254359105, 5690.544756419394, 5691.345495268097, 5701.315842098975, 5705.030144875464, 5385.865353366197, 5424.538914192338, 5562.860928476821, 5568.192612071308, 5569.832905012856, 5410.48600382963, 5452.04589196881, 5469.945300546943, 5497.367802702581, 5567.415421380697, 5371.677699338053, 5410.026195284887, 5410.945890541044, 5416.8104116355735, 5435.266239057677, 5422.969635769191, 5497.230387745799, 5527.972360138174, 5535.750891209825, 5543.528800051879, 5330.2804121443105, 5378.381486129145, 5385.730713464232, 5405.594580406407, 5503.284573005483], "value": 5206.329536017607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.8442126465021, 552.5662355051282, 561.1162419189777, 594.9405059494051, 608.297416483961, 27611.5858262126, 42752.14495710084, 43768.562314376846, 43843.56156438435, 43873.78063109684, 44332.3350149748, 44669.55330446694, 44734.10531789371, 44744.0, 44786.0, 8888.466691998468, 9033.0, 9039.548022598876, 9040.412373195753, 9044.638214471413, 8718.825623487526, 8837.160469755363, 8846.5134417607, 8850.114988501131, 8867.334949878752, 8953.686620968267, 8966.955165224164, 9005.279577633773, 9005.504697241682, 9008.504532250723, 8946.776330591721, 8983.371164018521, 8989.955050224773, 8993.010768815426, 8993.325500587416, 8851.380403371766, 8944.329175311877, 8951.104889511062, 8952.507612081334, 8955.731328060168, 41891.790541047405, 42143.0, 42269.1546169078, 42273.36589951153, 42297.36553951693, 3444.7588668793196, 3488.494168345576, 3555.822208889545, 3778.67881230093, 3934.744241624314, 31864.362712745846, 31907.202319941956, 32398.35203295921, 32404.351912961843, 32782.34435311281, 3964.1278918637854, 3965.286248475273, 3972.3644216925154, 3991.8802435926677, 4059.837606495766, 359914.0, 360003.0, 360029.0, 360892.19553902326, 361018.0, 56384.0, 56766.71616641973, 56769.71615141898, 56816.43183568111, 56824.0, 40094.59905400967, 40615.79692101521, 58188.70905645445, 59339.70330148322, 59591.40408595945, 15791.763123553155, 16503.752443713354, 16524.173791310386, 16728.83271167297, 16731.414400496167, 12962.416691248916, 13053.673658158432, 13057.477700892048, 13059.34703264833, 13063.412146453242, 11431.942840285745, 11581.189316747916, 15982.60043498922, 16084.265674835306, 16136.596585085232, 6080.7871724490315, 6326.905096423558, 6554.574807321226, 6649.135612370457, 6781.287964763629, 887.7691800132012, 983.7404040504598, 987.6148302162162, 1004.1916257412853, 1045.5713157605346, 32020.519692204634, 32536.0, 32676.346473070407, 32698.346033079204, 33049.66950330514, 1042.1975079189133, 1069.2889228662852, 1092.4919912240846, 1105.5190991918541, 1175.6061719324123, 15402.768958465633, 16272.83727162737, 16442.260098295606, 16491.049512063815, 16617.50147495577, 491632.0, 505760.0, 507344.0, 511298.0, 512023.0, 55763.49064292116, 56177.43822561722, 56219.43780562142, 56245.7187714067, 56280.155797663065, 1341.2824139085542, 1356.5455572383362, 1379.593020059085, 1388.6389538719804, 1393.4008376398247, 28426.0, 28780.856095719388, 30313.393732125674, 30407.087787366414, 31054.844725776227, 47075.29387059265, 47379.0, 47435.288470672276, 47450.28824567565, 47458.76270618625, 346548.0, 347927.0, 348077.0, 348191.0, 348702.7954021597, 21339.35981920545, 21853.125874964822, 26842.194734157227, 27738.861305693343, 27784.305392365353, 44743.55256447524, 44910.55089449064, 45036.54963450455, 45324.64026079091, 45547.0, 38776.0, 39192.0, 39534.0, 41008.38487422751, 41119.7944010278, 37245.813770930974, 40277.79861100676, 40664.0, 41909.161816762884, 42558.787206063775, 39339.80330098331, 39758.602413976645, 39964.0, 40055.59944400635, 40442.1911561773, 31867.0, 34496.31007379788, 35109.47335790016, 35490.0, 36545.0, 28114.578281326205, 28179.154625361272, 28397.574036389884, 28519.42961140807, 28533.28666783347], "value": 19305.289393241805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.845661735306, 391.75515302935685, 402.585337102784, 403.2177575503523, 419.5217452104599, 13333.466661333536, 17185.57036074099, 18108.909455452722, 19930.60138797225, 19940.102695378708, 13662.385192666328, 15150.393984240618, 17419.390321338757, 17666.646667066652, 17776.11119444029, 5171.198464238049, 5578.665280083188, 5600.18797274395, 5604.131359639242, 5614.775408983656, 5562.721863906789, 5584.1902924075985, 5669.546436285108, 5672.205891175218, 5673.943260567404, 5477.1510415885605, 5606.607537472379, 5613.859653508654, 5616.719164041802, 5617.101263797793, 5513.365962914276, 5597.860053498654, 5618.15727640853, 5622.634528755638, 5625.1843482694985, 5033.245013248005, 5058.013687330972, 5075.3402057732255, 5077.060743762416, 5079.695218286877, 22185.667214991787, 22897.656535151986, 23075.307740767803, 23152.18967336152, 23183.304500865, 2079.7712251652306, 2280.7605201453775, 2289.1301305503966, 2322.314917099443, 2381.868997205153, 9851.458169800659, 9988.95005524975, 9997.950010249902, 10168.79662406755, 10532.42071686057, 1752.4567384110967, 1760.9295628174857, 1793.6771381151389, 1835.7980622131554, 1866.1415748755453, 74658.25341746568, 80989.59505202495, 81280.0, 82631.9999999994, 83775.0, 10305.433201173857, 10492.737681558023, 10593.993570610779, 10886.564537418573, 10929.56281748721, 15158.166300853338, 15173.0, 15177.772333415007, 15231.162286074372, 15261.0, 6598.1422415085735, 6869.931300687029, 6906.654667266717, 7868.449208555347, 8129.333486635343, 6476.708548115346, 6715.865682686319, 6721.092652491949, 6926.134233220848, 6975.337342952412, 4397.670174736908, 4457.8216871324785, 4565.908681826345, 4601.6548758842555, 4641.86074417768, 1894.981050189508, 1902.4387805597382, 1979.140142494111, 2017.3746138697052, 2030.5532782787764, 854.9358798090044, 904.9502277374676, 923.7459698582943, 930.2604429478581, 1053.89461053894, 17225.1387430628, 18360.632787344177, 18686.626267474574, 18934.928915614626, 19071.618567628848, 961.9855702164473, 974.084360700953, 977.8875429325718, 1010.5806090472519, 1050.138886113395, 9828.21374290055, 10524.105451036748, 10714.035736783728, 10722.982993011654, 10808.081313088318, 453218.0, 464396.0, 464634.0, 466723.6663816727, 503582.0, 66976.0, 96119.51940240254, 97540.51229743806, 99046.00953990368, 101426.49286753518, 986.980260394788, 1005.2912696548915, 1030.845373194027, 1042.124615323117, 1044.806710758512, 17069.31722731077, 17399.78900341268, 17564.38524651631, 17730.645387092445, 17877.0, 41566.58433415627, 42535.57464425316, 42667.999999998756, 42710.5728942719, 46105.07789844251, 60024.39975600188, 60529.09206361996, 60865.391346087745, 61024.69487652533, 61915.0, 8360.414770965974, 8399.0, 8465.238128568459, 8708.782280442787, 8810.779730506789, 12126.272423654256, 12873.356332183166, 12903.870961290642, 13358.933205333911, 13550.186988780704, 10913.945430272797, 11095.88904110981, 11394.715132121763, 11578.247413918069, 11813.114016448973, 10550.155987520826, 11131.610393636183, 11237.662870113909, 11316.60391886313, 11764.882351176379, 11466.827997579876, 11663.708407289885, 11764.117691173367, 11961.770322013183, 11978.76042479128, 8307.543085130375, 8391.370647201606, 8767.21095101444, 11185.272957258077, 11919.702007449883, 11236.550537978716, 11647.30116193031, 12132.272063676208, 12179.0, 12583.685407864876], "value": 8993.874550954968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.590605100317, 1460.6348412896773, 1517.9924100379496, 1578.7079390312792, 1692.7884014498195, 8021.799455013627, 8988.550572471382, 9433.056694330571, 9433.81132377352, 9713.174380177694, 9473.100055494717, 9550.283728720338, 9561.904380956188, 9566.330356875022, 9569.617215311397, 2431.6960379952507, 2449.3386785567886, 2449.473363226906, 2449.9020039198413, 2457.58221102413, 2375.4417711837705, 2398.244552965819, 2449.289705985262, 2454.6563481112657, 2456.0, 2340.2511196417154, 2353.399883029825, 2377.512609914972, 2405.987970060156, 2414.6498757680124, 2332.626779715246, 2333.673285739998, 2341.718993720756, 2346.378209774411, 2375.691160149187, 2315.872627005514, 2318.0, 2320.6867072945106, 2321.0831721470095, 2324.465372964211, 8922.598483068212, 9323.72028839136, 9351.76620584484, 9364.110409511153, 9488.905110948872, 5430.728463576806, 5659.066254068074, 5664.150377443417, 5696.231008813798, 5702.77188912443, 3520.6695764210167, 3533.5583052118486, 3535.416656251741, 3567.0, 3589.300086483137, 1014.3862962907408, 1019.6074511313124, 1034.5086084110062, 1035.3891204189565, 1038.5897570459701, 13099.86900130996, 13122.737545249138, 13386.531471398454, 13389.0, 13404.262765547988, 4502.5047244803045, 4649.18639238132, 4697.154512187771, 4851.708897466164, 4855.5387238212315, 10279.383237005804, 10299.742506437398, 10310.896891030994, 10316.329438586468, 10321.174306055498, 5434.076207044733, 5454.781808727606, 5471.753771080232, 5474.671519708831, 5505.669659820343, 4209.7474151551005, 4416.293393057095, 4551.544845515422, 4567.018091110427, 5106.770195341219, 3732.682721968663, 3874.496315479026, 3912.256671232457, 3912.921741565153, 3929.292727309112, 1177.4819079604947, 1224.0758227538151, 1225.4301749686438, 1238.139493052338, 1242.7328124453104, 831.3556993330218, 918.0910898210857, 922.4511415707643, 927.7773334399695, 943.193569498083, 6063.393660633901, 6084.969575152096, 6224.470919971853, 6225.097360882737, 6543.574667646683, 456.58678895599536, 468.83590743240273, 471.32600381454165, 476.7258826174894, 487.7683100527292, 4109.547949725587, 4264.530901600883, 4290.141971605692, 4292.635126014261, 4327.956720432819, 11579.826302605468, 11648.70878228034, 11748.765024699458, 11886.049116070693, 11892.762144757056, 11595.362255075883, 11746.70633234159, 11772.88227117735, 11791.646250612324, 11826.231294965799, 8640.740777776677, 8777.385583009256, 8810.515421651742, 8811.251043661232, 8814.471131732116, 6225.62646241227, 6274.6548939808745, 6303.1175635412, 6305.117283580211, 6310.873782524415, 10650.201234907569, 10789.352638841694, 10850.403227822546, 10858.565657373616, 10944.671659849899, 9170.908290917005, 11057.225994180651, 11099.112071034458, 11182.217244792786, 11251.0, 7452.701891924262, 7664.80837979055, 7678.424118191269, 7688.500247483896, 7718.807029824299, 8765.298776097768, 8783.692570759993, 8819.735407937773, 8834.072422395557, 8907.153820387053, 7835.725749598737, 7916.643751031333, 7929.286364227247, 7969.6015199240965, 8012.959935200287, 7880.014998125234, 7883.329916957123, 7915.208479152038, 7926.286634202949, 8078.6364613593705, 7221.4222862171955, 7367.373773229336, 7416.740414085697, 7641.617919104134, 7646.388288936983, 4988.351514303117, 5086.21163719624, 5090.363704536933, 5096.311997880387, 5106.0, 4957.35554377943, 5119.74401279942, 5145.588352931682, 5331.333583302087, 5351.892962140658], "value": 4668.045796498264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.90192942117375, 334.86772724773715, 336.885458943959, 340.72060910053756, 342.41276211297617, 5113.33526641537, 5238.423773384925, 5262.368515778107, 5270.81406683497, 5317.49483799039, 5041.0, 5103.540681338679, 5151.304573882525, 5160.838811267463, 5187.23633964452, 4147.506897516907, 4155.542890282067, 4156.314208155666, 4162.188373267214, 4176.624103830647, 3970.4441378207075, 4124.917501649965, 4159.937600935973, 4174.895627609304, 4198.727082739628, 4121.752694838305, 4132.607402296777, 4136.751794892316, 4139.586041395866, 4161.646260067898, 4117.447182746716, 4121.340585506319, 4126.958730412687, 4145.54399016108, 4155.709100362976, 3622.1850083731215, 3714.3685573452576, 3717.20080182762, 3725.9627403725885, 3730.198007428416, 5091.23631455281, 5092.134337162691, 5097.388313402378, 5100.846974590768, 5105.412877519096, 4746.810127594927, 4771.141194584973, 4779.068081724065, 4793.113274044313, 4817.807287708488, 5320.787168513255, 5407.675539467606, 5455.063452474394, 5456.236126942231, 5483.60016789593, 4031.3348297530874, 4033.81847816846, 4053.8041277823113, 4059.6955228357992, 4071.7760523171214, 5666.724986877919, 5719.828405147852, 5721.942780572224, 5723.255976723041, 5727.1695604137585, 4023.2355852387955, 4122.34042553196, 4129.442525259112, 4170.72890262132, 4183.226103170923, 4196.958030419718, 4201.474815648044, 4209.852655157055, 4214.093969796509, 4224.683148763855, 4751.144793937125, 4758.191107511731, 4762.666613337033, 4765.976170119127, 4785.569298763058, 5414.864628384322, 5513.7794488220825, 5539.861503462365, 5544.889102217933, 5569.972150139223, 1375.4910683047337, 1393.2615713671566, 1412.498563010137, 1437.3891096284037, 1450.5285782120852, 997.1275134257525, 1014.1937159957852, 1030.644427672452, 1035.5805898611075, 1038.7610849504506, 5185.744201272459, 5196.506331898464, 5216.869578260498, 5242.850431323215, 5275.4724527547705, 5487.451254874481, 5543.25166102571, 5553.445794691401, 5565.332160140809, 5568.749406276727, 5076.213186956028, 5132.46109158533, 5149.658847552109, 5277.182036784305, 5290.894182116336, 2542.580474221733, 2566.5636841736577, 2598.9610155847677, 2636.220551127981, 2647.2455350225478, 4993.775280112403, 5014.598832093424, 5026.522480364432, 5029.636071046602, 5072.797088116507, 5021.895183059721, 5072.0, 5372.892542149213, 5768.682722450221, 5785.971070144622, 5729.369769325371, 5731.885362292647, 5737.340205876294, 5740.339860915965, 5751.338596061423, 5475.534579560623, 5640.520555752807, 5648.915266271091, 5662.235598194191, 5741.540676745767, 5530.62631794613, 5531.806386776443, 5562.159732281169, 5568.081266590967, 5590.720463976866, 5688.175214593944, 5710.257666503494, 5722.799702010409, 5732.140178973187, 5738.282714660668, 3998.5601583826337, 4035.9192816142927, 4040.7373520721058, 4049.7367671101283, 4106.281400754916, 5340.5994550408095, 5492.148716948719, 5597.44025597437, 5677.602567820213, 5684.971575142098, 5358.383785864676, 5382.165764306539, 5390.137577987503, 5409.215663728816, 5520.66875987442, 5468.781248750164, 5476.616636835383, 5505.889882202414, 5517.724113794375, 5521.089020311603, 5294.894102117859, 5432.511074003359, 5449.891002180014, 5454.481824226692, 5530.917036244379, 5502.789386335, 5511.559075273888, 5511.807086752105, 5533.335999680065, 5534.972325138348, 5176.964607078675, 5411.972940135274, 5440.918386224289, 5440.972795135999, 5444.455554444524], "value": 4181.8834629552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9590272535008, 755.5957562703954, 779.1935346915943, 779.9220077992202, 825.4510750351017, 14856.33146508407, 16113.113778742165, 16345.754813677804, 16347.34610615574, 16426.83573164268, 15212.23938803061, 15398.538043858674, 15441.69116617667, 15443.845561544382, 15452.15013174275, 542.9782808687647, 556.8524341049605, 783.5416281475316, 789.3527307607764, 792.4690457393531, 812.3501199040774, 813.8779183122549, 814.9633266503022, 815.3029160068145, 815.6451943404609, 468.15498026062943, 860.8837806896083, 861.1517655109712, 862.6290695001147, 862.8188080503102, 470.57648116695077, 800.5596921693045, 801.5951944268165, 808.5391326943644, 831.8294749576322, 620.8044465993243, 622.2657264427974, 622.9719662615194, 623.7286780250605, 623.7349126621168, 14470.565883023526, 14540.127592344494, 14543.636409089751, 14549.272536373244, 14637.487687930978, 14781.482648107372, 15109.54671359861, 15176.848231517764, 15205.391784328614, 15207.543773686808, 10216.948915255376, 10317.638882639072, 10590.31162974412, 10672.03951644348, 10841.403722795243, 3766.9811650941842, 3791.545014598238, 3793.696504279651, 3940.980295098535, 3960.4653371794725, 66918.0, 67817.0, 68189.9999999995, 84914.0, 86583.56708216481, 10209.0, 10701.83947240792, 10846.78306433867, 11226.382548959886, 11413.315201087962, 22893.08427662875, 22940.0, 22956.0, 23010.0, 23108.075676972734, 8205.79485512855, 8265.628046737911, 8304.875426868603, 8395.202455766814, 8530.019047809457, 4235.709188932081, 4389.1660584488845, 4395.110327360245, 4469.955300447019, 4536.682432229778, 3434.5191673165778, 3561.8397172127316, 3566.661167189113, 3571.4821350904494, 3572.1426857554, 578.7684926029538, 585.4847733994143, 587.7854583077232, 595.1578516399333, 595.5295316699759, 611.4466407900857, 635.4725577770532, 654.8690261947535, 683.4668958212602, 717.7810767715897, 8495.74512764618, 8967.072079502808, 9085.909140908638, 9233.307501937381, 9492.952535237418, 676.2324761395851, 716.4984510842431, 717.5658726470515, 738.1879932074783, 749.1871319618166, 4404.6256068233915, 4470.240059189946, 4477.910441791211, 4511.571400716926, 4516.661250406232, 68402.0, 68576.6571167141, 69392.30607693858, 69535.3046469539, 120901.39549302198, 107255.0, 110792.44603776929, 111163.44418277856, 113782.43108784403, 117381.0, 94082.0, 96099.51950240343, 96859.51570242245, 97711.0, 98471.0, 8431.494110353398, 8440.831183376175, 8444.0, 8649.3512986525, 8715.215630593277, 45670.771646141555, 49606.751966239935, 50391.0, 51992.22011669752, 56314.029008984486, 49725.0, 50038.249426257906, 54199.01905395083, 72835.63582182056, 76827.23172768201, 11112.388818615054, 11284.548618055185, 11505.309681419141, 11773.234739741889, 12159.392030398269, 13159.802602960772, 13189.670258243621, 13341.533046343331, 13416.798748018982, 14482.0, 8051.677932882619, 12639.241645501299, 12900.0, 13065.608031759062, 13112.475500979854, 13842.30788460593, 13865.168089914638, 13996.860031399556, 14102.224377659328, 14367.856321436651, 12862.678433038875, 12902.225866448043, 12978.0, 13051.804222936853, 13692.931535342259, 10519.579216831242, 10755.408452535186, 11129.66611001639, 11234.719132021764, 11280.548778048786, 11481.598144064918, 11552.711182220175, 11590.826137608112, 11591.826122608, 11650.30098194111], "value": 7255.05508951146, "unit": "score"}], "name": "dromaeo_css", "value": 7099.445131798086, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 119.0, 156.0, 125.0, 117.0, 118.0, 117.0, 145.0, 118.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 162.0, 161.0, 164.0, 162.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 105.0, 77.0, 76.0, 87.0, 76.0, 97.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 84.0, 83.0, 82.0, 104.0, 82.0, 82.0, 107.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 49.0, 49.0, 50.0, 51.0, 51.0, 51.0, 52.0, 51.0, 53.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 88.0, 82.0, 78.0, 85.0, 81.0, 79.0, 87.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 122.0, 125.0, 124.0, 141.0, 124.0, 122.0, 161.0, 124.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 167.0, 167.0, 167.0, 160.0, 165.0, 162.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 66.0, 65.0, 65.0, 67.0, 64.0, 71.0, 65.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1483.6, "alertThreshold": 2.0}]} 09:45:32 INFO - Return code: 0 09:45:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:32 INFO - # TBPL SUCCESS # 09:45:32 INFO - Running post-action listener: _resource_record_post_action 09:45:32 INFO - [mozharness: 2016-09-26 16:45:32.766511Z] Finished run-tests step (success) 09:45:32 INFO - Running post-run listener: _resource_record_post_run 09:45:32 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409255936; Read time: 12; Write time: 309352 09:45:32 INFO - TinderboxPrint: CPU usage
13.0% 09:45:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:45:32 INFO - TinderboxPrint: I/O write bytes / time
409,255,936 / 309,352 09:45:32 INFO - TinderboxPrint: CPU idle
8,294.4 (87.0%) 09:45:32 INFO - TinderboxPrint: CPU user
1,190.5 (12.5%) 09:45:32 INFO - TinderboxPrint: Swap in / out
0 / 0 09:45:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120225792; Read time: 0; Write time: 79420 09:45:32 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288002048; Read time: 0; Write time: 229912 09:45:33 INFO - Running post-run listener: _upload_blobber_files 09:45:33 INFO - Blob upload gear active. 09:45:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:33 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 09:45:33 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:33 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:34 INFO - (blobuploader) - INFO - Done attempting. 09:45:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:35 INFO - (blobuploader) - INFO - Done attempting. 09:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:40 INFO - (blobuploader) - INFO - Done attempting. 09:45:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:40 INFO - Return code: 0 09:45:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9d9dc464b2ba122c2815848ad135ea51f6e8cee522a9c830e4f005799f5da7cbf9527cca827bd9d24d85330df359a140e430c55a9e037a21823cd3e79d34acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a38488327de2904568c8eb8cfb218774ec3fe260c77e7d21aaeeb4616a10c21feafa85d671c1f9aeaa7e023cd48b6840e139716384112cb9b8342f2943c2d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ffc7e1c28804bc573a9cf9d26e0e6135f2a76e270166e989c5207b9318b676b82742a27453f6c10ed5caa8307872615ab568b6c81fa63f98e15a8db962019fb"} 09:45:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:40 INFO - Contents: 09:45:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9d9dc464b2ba122c2815848ad135ea51f6e8cee522a9c830e4f005799f5da7cbf9527cca827bd9d24d85330df359a140e430c55a9e037a21823cd3e79d34acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a38488327de2904568c8eb8cfb218774ec3fe260c77e7d21aaeeb4616a10c21feafa85d671c1f9aeaa7e023cd48b6840e139716384112cb9b8342f2943c2d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ffc7e1c28804bc573a9cf9d26e0e6135f2a76e270166e989c5207b9318b676b82742a27453f6c10ed5caa8307872615ab568b6c81fa63f98e15a8db962019fb"} 09:45:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:40 INFO - Copying logs to upload dir... 09:45:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.765641 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-26 09:45:40.042240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 09:45:40.045534) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418 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/sha512/f9d9dc464b2ba122c2815848ad135ea51f6e8cee522a9c830e4f005799f5da7cbf9527cca827bd9d24d85330df359a140e430c55a9e037a21823cd3e79d34acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a38488327de2904568c8eb8cfb218774ec3fe260c77e7d21aaeeb4616a10c21feafa85d671c1f9aeaa7e023cd48b6840e139716384112cb9b8342f2943c2d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ffc7e1c28804bc573a9cf9d26e0e6135f2a76e270166e989c5207b9318b676b82742a27453f6c10ed5caa8307872615ab568b6c81fa63f98e15a8db962019fb"} build_url:https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/AMk3y-8VR_KBKtlMwJ3Xgw/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/sha512/f9d9dc464b2ba122c2815848ad135ea51f6e8cee522a9c830e4f005799f5da7cbf9527cca827bd9d24d85330df359a140e430c55a9e037a21823cd3e79d34acc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a38488327de2904568c8eb8cfb218774ec3fe260c77e7d21aaeeb4616a10c21feafa85d671c1f9aeaa7e023cd48b6840e139716384112cb9b8342f2943c2d37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ffc7e1c28804bc573a9cf9d26e0e6135f2a76e270166e989c5207b9318b676b82742a27453f6c10ed5caa8307872615ab568b6c81fa63f98e15a8db962019fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 09:45:40.070864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:45:40.071193) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474906295.414691-1782368418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:45:40.155837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 09:45:40.156138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 09:45:40.156421) ========= ========= Total master_lag: 0.16 =========