builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1476912944.03 results: success (0) buildid: 20161019115222 builduid: b2d71adc09884e9b882dd74d1444f536 revision: 33bc172941df74d989e77412854cae45682f5501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.031646) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.032141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.032424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.047130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.047450) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 14:35:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-19 14:35:44 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.141130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.141416) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.194920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:44.195277) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33bc172941df74d989e77412854cae45682f5501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33bc172941df74d989e77412854cae45682f5501 --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=d6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 14:35:44,964 truncating revision to first 12 chars 2016-10-19 14:35:44,964 Setting DEBUG logging. 2016-10-19 14:35:44,965 attempt 1/10 2016-10-19 14:35:44,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33bc172941df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 14:35:45,561 unpacking tar archive at: mozilla-aurora-33bc172941df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.940083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:45.148941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:45.149248) ========= script_repo_revision: 33bc172941df74d989e77412854cae45682f5501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:45.149661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:45.149935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:35:45.160346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-19 14:35:45.160719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:35:46 INFO - MultiFileLogger online at 20161019 14:35:46 in /builds/slave/test 14:35:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:35:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:35:46 INFO - {'append_to_log': False, 14:35:46 INFO - 'base_work_dir': '/builds/slave/test', 14:35:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:35:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:35:46 INFO - 'branch': 'Mozilla-Aurora', 14:35:46 INFO - 'buildbot_json_path': 'buildprops.json', 14:35:46 INFO - 'config_files': ('talos/linux_config.py',), 14:35:46 INFO - 'default_actions': ('clobber', 14:35:46 INFO - 'read-buildbot-config', 14:35:46 INFO - 'download-and-extract', 14:35:46 INFO - 'populate-webroot', 14:35:46 INFO - 'create-virtualenv', 14:35:46 INFO - 'install', 14:35:46 INFO - 'run-tests'), 14:35:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:35:46 INFO - 'download_minidump_stackwalk': True, 14:35:46 INFO - 'download_symbols': 'ondemand', 14:35:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:35:46 INFO - 'tooltool.py': '/tools/tooltool.py', 14:35:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:35:46 INFO - '/tools/misc-python/virtualenv.py')}, 14:35:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:35:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:35:46 INFO - 'installer_path': 'installer.exe', 14:35:46 INFO - 'log_level': 'info', 14:35:46 INFO - 'log_name': 'talos', 14:35:46 INFO - 'log_to_console': True, 14:35:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:35:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:35:46 INFO - 'opt_config_files': (), 14:35:46 INFO - 'pip_index': False, 14:35:46 INFO - 'sps_profile': False, 14:35:46 INFO - 'sps_profile_interval': 0, 14:35:46 INFO - 'suite': 'dromaeojs', 14:35:46 INFO - 'system_bits': '32', 14:35:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:35:46 INFO - 'title': 'talos-linux64-ix-034', 14:35:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:35:46 INFO - 'use_talos_json': True, 14:35:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:35:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:35:46 INFO - 'work_dir': 'build'} 14:35:46 INFO - [mozharness: 2016-10-19 21:35:46.024950Z] Running clobber step. 14:35:46 INFO - Running pre-action listener: _resource_record_pre_action 14:35:46 INFO - Running main action method: clobber 14:35:46 INFO - rmtree: /builds/slave/test/build 14:35:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:35:46 INFO - Running post-action listener: _resource_record_post_action 14:35:46 INFO - [mozharness: 2016-10-19 21:35:46.489541Z] Finished clobber step (success) 14:35:46 INFO - [mozharness: 2016-10-19 21:35:46.489643Z] Running read-buildbot-config step. 14:35:46 INFO - Running pre-action listener: _resource_record_pre_action 14:35:46 INFO - Running main action method: read_buildbot_config 14:35:46 INFO - Using buildbot properties: 14:35:46 INFO - { 14:35:46 INFO - "project": "", 14:35:46 INFO - "product": "firefox", 14:35:46 INFO - "script_repo_revision": "production", 14:35:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:35:46 INFO - "repository": "", 14:35:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:35:46 INFO - "buildid": "20161019115222", 14:35:46 INFO - "pgo_build": "True", 14:35:46 INFO - "basedir": "/builds/slave/test", 14:35:46 INFO - "buildnumber": 823, 14:35:46 INFO - "slavename": "talos-linux64-ix-034", 14:35:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:35:46 INFO - "platform": "ubuntu64_hw", 14:35:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:35:46 INFO - "branch": "mozilla-aurora", 14:35:46 INFO - "repo_path": "releases/mozilla-aurora", 14:35:46 INFO - "revision": "33bc172941df74d989e77412854cae45682f5501", 14:35:46 INFO - "stage_platform": "linux64-pgo", 14:35:46 INFO - "builduid": "b2d71adc09884e9b882dd74d1444f536", 14:35:46 INFO - "slavebuilddir": "test" 14:35:46 INFO - } 14:35:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 14:35:46 INFO - Running post-action listener: _resource_record_post_action 14:35:46 INFO - [mozharness: 2016-10-19 21:35:46.492178Z] Finished read-buildbot-config step (success) 14:35:46 INFO - [mozharness: 2016-10-19 21:35:46.492268Z] Running download-and-extract step. 14:35:46 INFO - Running pre-action listener: _resource_record_pre_action 14:35:46 INFO - Running main action method: download_and_extract 14:35:46 INFO - mkdir: /builds/slave/test/build/tests 14:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:46 INFO - trying https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:35:46 INFO - Downloading https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:35:47 INFO - Downloaded 1361 bytes. 14:35:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:35:47 INFO - Using the following test package requirements: 14:35:47 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:35:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:35:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:35:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'jsshell-linux-x86_64.zip'], 14:35:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:35:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:35:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:35:47 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:35:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:35:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:35:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:35:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:35:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:35:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:35:47 INFO - Fetch https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:35:47 INFO - Expected file size: 21908458 14:35:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:35:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:35:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:35:51 INFO - Fetch https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:35:55 INFO - Expected file size: 21908458 14:36:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 14:36:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:36:00 INFO - Fetch https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:36:00 INFO - Expected file size: 14414081 14:36: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')]} 14:36:01 INFO - trying https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:36:01 INFO - Downloading https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:36:02 INFO - Downloaded 64008413 bytes. 14:36:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:36:02 INFO - mkdir: /builds/slave/test/properties 14:36:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:36:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:36:02 INFO - Contents: 14:36:02 INFO - build_url:https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:36:03 INFO - Running post-action listener: _resource_record_post_action 14:36:03 INFO - Running post-action listener: set_extra_try_arguments 14:36:03 INFO - [mozharness: 2016-10-19 21:36:03.185621Z] Finished download-and-extract step (success) 14:36:03 INFO - [mozharness: 2016-10-19 21:36:03.185850Z] Running populate-webroot step. 14:36:03 INFO - Running pre-action listener: _resource_record_pre_action 14:36:03 INFO - Running main action method: populate_webroot 14:36:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:36:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:36:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:36:03 INFO - '--tppagecycles', 14:36:03 INFO - '7'], 14:36:03 INFO - 'tests': ['tsvgm']}}, 14:36:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:36:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:36:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:36:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:36:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:36:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:36:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['damp', 'tps']}, 14:36:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'tests': ['damp', 'tps']}, 14:36:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['dromaeo_dom']}, 14:36:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:36:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['basic_compositor_video']}, 14:36:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:36:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['a11yr', 14:36:03 INFO - 'ts_paint', 14:36:03 INFO - 'tpaint', 14:36:03 INFO - 'sessionrestore', 14:36:03 INFO - 'sessionrestore_no_auto_restore', 14:36:03 INFO - 'tabpaint']}, 14:36:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:36:03 INFO - 'ts_paint', 14:36:03 INFO - 'tpaint', 14:36:03 INFO - 'sessionrestore', 14:36:03 INFO - 'sessionrestore_no_auto_restore', 14:36:03 INFO - 'tabpaint']}, 14:36:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:36:03 INFO - 'ts_paint', 14:36:03 INFO - 'tpaint', 14:36:03 INFO - 'sessionrestore', 14:36:03 INFO - 'sessionrestore_no_auto_restore', 14:36:03 INFO - 'tabpaint']}, 14:36:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:36:03 INFO - 'ts_paint', 14:36:03 INFO - 'tpaint', 14:36:03 INFO - 'sessionrestore', 14:36:03 INFO - 'sessionrestore_no_auto_restore', 14:36:03 INFO - 'tabpaint']}, 14:36:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['a11yr', 14:36:03 INFO - 'ts_paint', 14:36:03 INFO - 'tpaint', 14:36:03 INFO - 'sessionrestore', 14:36:03 INFO - 'sessionrestore_no_auto_restore', 14:36:03 INFO - 'tabpaint']}, 14:36:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['a11yr', 14:36:03 INFO - 'ts_paint', 14:36:03 INFO - 'tpaint', 14:36:03 INFO - 'sessionrestore', 14:36:03 INFO - 'sessionrestore_no_auto_restore', 14:36:03 INFO - 'tabpaint']}, 14:36:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['tsvgx', 14:36:03 INFO - 'tsvgr_opacity', 14:36:03 INFO - 'tart', 14:36:03 INFO - 'tscrollx', 14:36:03 INFO - 'cart']}, 14:36:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:36:03 INFO - 'tsvgr_opacity', 14:36:03 INFO - 'tart', 14:36:03 INFO - 'tscrollx', 14:36:03 INFO - 'cart']}, 14:36:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'talos_options': ['--disable-e10s'], 14:36:03 INFO - 'tests': ['tp5o']}, 14:36:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'tests': ['tp5o']}, 14:36:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'talos_options': ['--disable-e10s', 14:36:03 INFO - '--xperf_path', 14:36:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:36:03 INFO - 'tests': ['tp5n']}, 14:36:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:36:03 INFO - 'talos_options': ['--xperf_path', 14:36:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:36:03 INFO - 'tests': ['tp5n']}}, 14:36:03 INFO - 'talos.zip': {'path': '', 14:36:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:36:03 INFO - Running post-action listener: _resource_record_post_action 14:36:03 INFO - [mozharness: 2016-10-19 21:36:03.205175Z] Finished populate-webroot step (success) 14:36:03 INFO - [mozharness: 2016-10-19 21:36:03.205263Z] Running create-virtualenv step. 14:36:03 INFO - Running pre-action listener: _resource_record_pre_action 14:36:03 INFO - Running main action method: create_virtualenv 14:36:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:36:03 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 14:36:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:36:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:36:03 INFO - Using real prefix '/usr' 14:36:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:36:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:36:05 INFO - Installing pip.................done. 14:36:05 INFO - Return code: 0 14:36:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:36:05 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')]} 14:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:05 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')]} 14:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:05 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:05 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 14:36:05 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 14:36:05 INFO - Using env: {'DISPLAY': ':0', 14:36:05 INFO - 'HOME': '/home/cltbld', 14:36:05 INFO - 'LANG': 'en_US.UTF-8', 14:36:05 INFO - 'LANGUAGE': 'en_US:en', 14:36:05 INFO - 'LOGNAME': 'cltbld', 14:36:05 INFO - 'MAIL': '/var/mail/cltbld', 14:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:05 INFO - 'MOZ_NO_REMOTE': '1', 14:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:05 INFO - 'NO_EM_RESTART': '1', 14:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:05 INFO - 'PWD': '/builds/slave/test', 14:36:05 INFO - 'SHELL': '/bin/bash', 14:36:05 INFO - 'SHLVL': '1', 14:36:05 INFO - 'TERM': 'linux', 14:36:05 INFO - 'TMOUT': '86400', 14:36:05 INFO - 'USER': 'cltbld', 14:36:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:05 INFO - '_': '/tools/buildbot/bin/python'} 14:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:05 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 14:36:05 INFO - Cleaning up... 14:36:05 INFO - Return code: 0 14:36:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:36:05 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')]} 14:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:05 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')]} 14:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:05 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:05 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 14:36:05 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 14:36:06 INFO - Using env: {'DISPLAY': ':0', 14:36:06 INFO - 'HOME': '/home/cltbld', 14:36:06 INFO - 'LANG': 'en_US.UTF-8', 14:36:06 INFO - 'LANGUAGE': 'en_US:en', 14:36:06 INFO - 'LOGNAME': 'cltbld', 14:36:06 INFO - 'MAIL': '/var/mail/cltbld', 14:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:06 INFO - 'MOZ_NO_REMOTE': '1', 14:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:06 INFO - 'NO_EM_RESTART': '1', 14:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:06 INFO - 'PWD': '/builds/slave/test', 14:36:06 INFO - 'SHELL': '/bin/bash', 14:36:06 INFO - 'SHLVL': '1', 14:36:06 INFO - 'TERM': 'linux', 14:36:06 INFO - 'TMOUT': '86400', 14:36:06 INFO - 'USER': 'cltbld', 14:36:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:06 INFO - '_': '/tools/buildbot/bin/python'} 14:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:06 INFO - Downloading/unpacking psutil>=3.1.1 14:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:36:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:36:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:36:08 INFO - Installing collected packages: psutil 14:36:08 INFO - Running setup.py install for psutil 14:36:08 INFO - building 'psutil._psutil_linux' extension 14:36:08 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 14:36:08 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 14:36:08 INFO - building 'psutil._psutil_posix' extension 14:36:08 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 14:36:08 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 14:36:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:36:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:36:08 INFO - Successfully installed psutil 14:36:08 INFO - Cleaning up... 14:36:08 INFO - Return code: 0 14:36:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:08 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:08 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 14:36:08 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 14:36:08 INFO - Using env: {'DISPLAY': ':0', 14:36:08 INFO - 'HOME': '/home/cltbld', 14:36:08 INFO - 'LANG': 'en_US.UTF-8', 14:36:08 INFO - 'LANGUAGE': 'en_US:en', 14:36:08 INFO - 'LOGNAME': 'cltbld', 14:36:08 INFO - 'MAIL': '/var/mail/cltbld', 14:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:08 INFO - 'MOZ_NO_REMOTE': '1', 14:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:08 INFO - 'NO_EM_RESTART': '1', 14:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:08 INFO - 'PWD': '/builds/slave/test', 14:36:08 INFO - 'SHELL': '/bin/bash', 14:36:08 INFO - 'SHLVL': '1', 14:36:08 INFO - 'TERM': 'linux', 14:36:08 INFO - 'TMOUT': '86400', 14:36:08 INFO - 'USER': 'cltbld', 14:36:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:08 INFO - '_': '/tools/buildbot/bin/python'} 14:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:36:08 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 14:36:08 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 14:36:08 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 14:36:08 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 14:36:08 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 14:36:08 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 14:36:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:36:10 INFO - Installing collected packages: mozsystemmonitor 14:36:10 INFO - Running setup.py install for mozsystemmonitor 14:36:11 INFO - Successfully installed mozsystemmonitor 14:36:11 INFO - Cleaning up... 14:36:11 INFO - Return code: 0 14:36:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:11 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:11 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 14:36:11 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 14:36:11 INFO - Using env: {'DISPLAY': ':0', 14:36:11 INFO - 'HOME': '/home/cltbld', 14:36:11 INFO - 'LANG': 'en_US.UTF-8', 14:36:11 INFO - 'LANGUAGE': 'en_US:en', 14:36:11 INFO - 'LOGNAME': 'cltbld', 14:36:11 INFO - 'MAIL': '/var/mail/cltbld', 14:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:11 INFO - 'MOZ_NO_REMOTE': '1', 14:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:11 INFO - 'NO_EM_RESTART': '1', 14:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:11 INFO - 'PWD': '/builds/slave/test', 14:36:11 INFO - 'SHELL': '/bin/bash', 14:36:11 INFO - 'SHLVL': '1', 14:36:11 INFO - 'TERM': 'linux', 14:36:11 INFO - 'TMOUT': '86400', 14:36:11 INFO - 'USER': 'cltbld', 14:36:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:11 INFO - '_': '/tools/buildbot/bin/python'} 14:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:11 INFO - Downloading/unpacking jsonschema==2.5.1 14:36:11 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 14:36:11 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 14:36:11 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 14:36:11 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 14:36:11 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 14:36:11 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 14:36:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:36:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:36:13 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 14:36:13 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 14:36:13 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 14:36:13 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 14:36:13 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 14:36:13 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 14:36:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:36:13 INFO - warning: no files found matching '*.txt' 14:36:13 INFO - no previously-included directories found matching 'build' 14:36:13 INFO - no previously-included directories found matching 'dist' 14:36:13 INFO - no previously-included directories found matching '.git*' 14:36:13 INFO - Installing collected packages: jsonschema, functools32 14:36:13 INFO - Running setup.py install for functools32 14:36:13 INFO - warning: no files found matching '*.txt' 14:36:13 INFO - no previously-included directories found matching 'build' 14:36:13 INFO - no previously-included directories found matching 'dist' 14:36:13 INFO - no previously-included directories found matching '.git*' 14:36:13 INFO - Successfully installed jsonschema functools32 14:36:13 INFO - Cleaning up... 14:36:13 INFO - Return code: 0 14:36:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:36: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')]} 14:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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')]} 14:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:13 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:13 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 14:36:13 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 14:36:13 INFO - Using env: {'DISPLAY': ':0', 14:36:13 INFO - 'HOME': '/home/cltbld', 14:36:13 INFO - 'LANG': 'en_US.UTF-8', 14:36:13 INFO - 'LANGUAGE': 'en_US:en', 14:36:13 INFO - 'LOGNAME': 'cltbld', 14:36:13 INFO - 'MAIL': '/var/mail/cltbld', 14:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:13 INFO - 'MOZ_NO_REMOTE': '1', 14:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:13 INFO - 'NO_EM_RESTART': '1', 14:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:13 INFO - 'PWD': '/builds/slave/test', 14:36:13 INFO - 'SHELL': '/bin/bash', 14:36:13 INFO - 'SHLVL': '1', 14:36:13 INFO - 'TERM': 'linux', 14:36:13 INFO - 'TMOUT': '86400', 14:36:13 INFO - 'USER': 'cltbld', 14:36:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:13 INFO - '_': '/tools/buildbot/bin/python'} 14:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:36:13 INFO - Cleaning up... 14:36:13 INFO - Return code: 0 14:36:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:36: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')]} 14:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36: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')]} 14:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:13 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:13 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 14:36:13 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 14:36:13 INFO - Using env: {'DISPLAY': ':0', 14:36:13 INFO - 'HOME': '/home/cltbld', 14:36:13 INFO - 'LANG': 'en_US.UTF-8', 14:36:13 INFO - 'LANGUAGE': 'en_US:en', 14:36:13 INFO - 'LOGNAME': 'cltbld', 14:36:13 INFO - 'MAIL': '/var/mail/cltbld', 14:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:13 INFO - 'MOZ_NO_REMOTE': '1', 14:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:13 INFO - 'NO_EM_RESTART': '1', 14:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:13 INFO - 'PWD': '/builds/slave/test', 14:36:13 INFO - 'SHELL': '/bin/bash', 14:36:13 INFO - 'SHLVL': '1', 14:36:13 INFO - 'TERM': 'linux', 14:36:13 INFO - 'TMOUT': '86400', 14:36:13 INFO - 'USER': 'cltbld', 14:36:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:13 INFO - '_': '/tools/buildbot/bin/python'} 14:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:36:14 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 14:36:14 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 14:36:14 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 14:36:14 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 14:36:14 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 14:36:14 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 14:36:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:36:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:36:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 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 14:36:16 INFO - Downloading docopt-0.6.1.tar.gz 14:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:36:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:36:16 INFO - Running setup.py install for blobuploader 14:36:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:36:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:36:16 INFO - Running setup.py install for requests 14:36:17 INFO - Running setup.py install for docopt 14:36:17 INFO - Successfully installed blobuploader requests docopt 14:36:17 INFO - Cleaning up... 14:36:17 INFO - Return code: 0 14:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:17 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')]} 14:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:17 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')]} 14:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:17 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:17 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 14:36:17 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 14:36:17 INFO - Using env: {'DISPLAY': ':0', 14:36:17 INFO - 'HOME': '/home/cltbld', 14:36:17 INFO - 'LANG': 'en_US.UTF-8', 14:36:17 INFO - 'LANGUAGE': 'en_US:en', 14:36:17 INFO - 'LOGNAME': 'cltbld', 14:36:17 INFO - 'MAIL': '/var/mail/cltbld', 14:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:17 INFO - 'MOZ_NO_REMOTE': '1', 14:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:17 INFO - 'NO_EM_RESTART': '1', 14:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:17 INFO - 'PWD': '/builds/slave/test', 14:36:17 INFO - 'SHELL': '/bin/bash', 14:36:17 INFO - 'SHLVL': '1', 14:36:17 INFO - 'TERM': 'linux', 14:36:17 INFO - 'TMOUT': '86400', 14:36:17 INFO - 'USER': 'cltbld', 14:36:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:17 INFO - '_': '/tools/buildbot/bin/python'} 14:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:36:17 INFO - Running setup.py (path:/tmp/pip-zwn_aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:36:17 INFO - Running setup.py (path:/tmp/pip-5J4PtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:36:17 INFO - Running setup.py (path:/tmp/pip-wrbUW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:36:17 INFO - Running setup.py (path:/tmp/pip-CSfx4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:36:17 INFO - Running setup.py (path:/tmp/pip-TxTgGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:36:18 INFO - Running setup.py (path:/tmp/pip-_QWHqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:36:18 INFO - Running setup.py (path:/tmp/pip-ny4GA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:36:18 INFO - Running setup.py (path:/tmp/pip-KFKdp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:36:18 INFO - Running setup.py (path:/tmp/pip-yfX71h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:36:18 INFO - Running setup.py (path:/tmp/pip-d3nByI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:36:18 INFO - Running setup.py (path:/tmp/pip-4rEJ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:36:18 INFO - Running setup.py (path:/tmp/pip-E1GEdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:36:18 INFO - Running setup.py (path:/tmp/pip-YG_dft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:36:18 INFO - Running setup.py (path:/tmp/pip-Obawol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:18 INFO - Running setup.py (path:/tmp/pip-IuhSyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:36:18 INFO - Running setup.py (path:/tmp/pip-gQNKiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:36:18 INFO - Running setup.py (path:/tmp/pip-Po1txB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:36:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:36:18 INFO - Running setup.py install for manifestparser 14:36:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Running setup.py install for mozcrash 14:36:19 INFO - Running setup.py install for mozdebug 14:36:19 INFO - Running setup.py install for mozdevice 14:36:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Running setup.py install for mozfile 14:36:19 INFO - Running setup.py install for mozhttpd 14:36:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Running setup.py install for mozinfo 14:36:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Running setup.py install for mozInstall 14:36:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Running setup.py install for mozleak 14:36:19 INFO - Running setup.py install for mozlog 14:36:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:36:19 INFO - Running setup.py install for moznetwork 14:36:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:36:20 INFO - Running setup.py install for mozprocess 14:36:20 INFO - Running setup.py install for mozprofile 14:36:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:36:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:36:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:36:20 INFO - Running setup.py install for mozrunner 14:36:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:36:20 INFO - Running setup.py install for mozscreenshot 14:36:20 INFO - Running setup.py install for moztest 14:36:20 INFO - Running setup.py install for mozversion 14:36:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:36:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:36:20 INFO - Cleaning up... 14:36:20 INFO - Return code: 0 14:36:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:20 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:20 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 14:36:20 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 14:36:20 INFO - Using env: {'DISPLAY': ':0', 14:36:20 INFO - 'HOME': '/home/cltbld', 14:36:20 INFO - 'LANG': 'en_US.UTF-8', 14:36:20 INFO - 'LANGUAGE': 'en_US:en', 14:36:20 INFO - 'LOGNAME': 'cltbld', 14:36:20 INFO - 'MAIL': '/var/mail/cltbld', 14:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:20 INFO - 'MOZ_NO_REMOTE': '1', 14:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:20 INFO - 'NO_EM_RESTART': '1', 14:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:20 INFO - 'PWD': '/builds/slave/test', 14:36:20 INFO - 'SHELL': '/bin/bash', 14:36:20 INFO - 'SHLVL': '1', 14:36:20 INFO - 'TERM': 'linux', 14:36:20 INFO - 'TMOUT': '86400', 14:36:20 INFO - 'USER': 'cltbld', 14:36:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:20 INFO - '_': '/tools/buildbot/bin/python'} 14:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:36:20 INFO - Running setup.py (path:/tmp/pip-_clquP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:36:20 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)) 14:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:36:20 INFO - Running setup.py (path:/tmp/pip-wrhZvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:36:21 INFO - Running setup.py (path:/tmp/pip-VZn6O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:36:21 INFO - Running setup.py (path:/tmp/pip-Eo0nUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:36:21 INFO - Running setup.py (path:/tmp/pip-4usYP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:36:21 INFO - Running setup.py (path:/tmp/pip-IChgql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:36:21 INFO - Running setup.py (path:/tmp/pip-rcSJt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:36:21 INFO - Running setup.py (path:/tmp/pip-8AhHet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:36:21 INFO - Running setup.py (path:/tmp/pip-L332K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:36:21 INFO - Running setup.py (path:/tmp/pip-UEqI3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:36:21 INFO - Running setup.py (path:/tmp/pip-42u5I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:36:21 INFO - Running setup.py (path:/tmp/pip-oBsCJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:36:21 INFO - Running setup.py (path:/tmp/pip-WpSl68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:36:21 INFO - Running setup.py (path:/tmp/pip-t4iGCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:36:21 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)) 14:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:21 INFO - Running setup.py (path:/tmp/pip-OEkmF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:22 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)) 14:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:36:22 INFO - Running setup.py (path:/tmp/pip-eT2aq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:36:22 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)) 14:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:36:22 INFO - Running setup.py (path:/tmp/pip-aCMhTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:36:22 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)) 14:36:22 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)) 14:36:22 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)) 14:36:22 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)) 14:36:22 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)) 14:36:22 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)) 14:36:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:24 INFO - Downloading blessings-1.6.tar.gz 14:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:36:24 INFO - Installing collected packages: blessings 14:36:24 INFO - Running setup.py install for blessings 14:36:24 INFO - Successfully installed blessings 14:36:24 INFO - Cleaning up... 14:36:24 INFO - Return code: 0 14:36:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:36:24 INFO - Reading from file tmpfile_stdout 14:36:24 INFO - Current package versions: 14:36:24 INFO - argparse == 1.2.1 14:36:24 INFO - blessings == 1.6 14:36:24 INFO - blobuploader == 1.2.4 14:36:24 INFO - docopt == 0.6.1 14:36:24 INFO - functools32 == 3.2.3-2 14:36:24 INFO - jsonschema == 2.5.1 14:36:24 INFO - manifestparser == 1.1 14:36:24 INFO - mozInstall == 1.12 14:36:24 INFO - mozcrash == 0.17 14:36:24 INFO - mozdebug == 0.1 14:36:24 INFO - mozdevice == 0.48 14:36:24 INFO - mozfile == 1.2 14:36:24 INFO - mozhttpd == 0.7 14:36:24 INFO - mozinfo == 0.9 14:36:24 INFO - mozleak == 0.1 14:36:24 INFO - mozlog == 3.4 14:36:24 INFO - moznetwork == 0.27 14:36:24 INFO - mozprocess == 0.23 14:36:24 INFO - mozprofile == 0.28 14:36:24 INFO - mozrunner == 6.12 14:36:24 INFO - mozscreenshot == 0.1 14:36:24 INFO - mozsystemmonitor == 0.3 14:36:24 INFO - moztest == 0.7 14:36:24 INFO - mozversion == 1.4 14:36:24 INFO - psutil == 3.1.1 14:36:24 INFO - requests == 1.2.3 14:36:24 INFO - wsgiref == 0.1.2 14:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:24 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')]} 14:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:24 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')]} 14:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:24 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:24 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 14:36:24 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 14:36:24 INFO - Using env: {'DISPLAY': ':0', 14:36:24 INFO - 'HOME': '/home/cltbld', 14:36:24 INFO - 'LANG': 'en_US.UTF-8', 14:36:24 INFO - 'LANGUAGE': 'en_US:en', 14:36:24 INFO - 'LOGNAME': 'cltbld', 14:36:24 INFO - 'MAIL': '/var/mail/cltbld', 14:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:24 INFO - 'MOZ_NO_REMOTE': '1', 14:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:24 INFO - 'NO_EM_RESTART': '1', 14:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:24 INFO - 'PWD': '/builds/slave/test', 14:36:24 INFO - 'SHELL': '/bin/bash', 14:36:24 INFO - 'SHLVL': '1', 14:36:24 INFO - 'TERM': 'linux', 14:36:24 INFO - 'TMOUT': '86400', 14:36:24 INFO - 'USER': 'cltbld', 14:36:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:24 INFO - '_': '/tools/buildbot/bin/python'} 14:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 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)) 14:36:24 INFO - Cleaning up... 14:36:24 INFO - Return code: 0 14:36:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:36:24 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')]} 14:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:24 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')]} 14:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:24 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 0x7fe35aadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', '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 14:36:24 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 14:36:24 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 14:36:24 INFO - Using env: {'DISPLAY': ':0', 14:36:24 INFO - 'HOME': '/home/cltbld', 14:36:24 INFO - 'LANG': 'en_US.UTF-8', 14:36:24 INFO - 'LANGUAGE': 'en_US:en', 14:36:24 INFO - 'LOGNAME': 'cltbld', 14:36:24 INFO - 'MAIL': '/var/mail/cltbld', 14:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:24 INFO - 'MOZ_NO_REMOTE': '1', 14:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:24 INFO - 'NO_EM_RESTART': '1', 14:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:24 INFO - 'PWD': '/builds/slave/test', 14:36:24 INFO - 'SHELL': '/bin/bash', 14:36:24 INFO - 'SHLVL': '1', 14:36:24 INFO - 'TERM': 'linux', 14:36:24 INFO - 'TMOUT': '86400', 14:36:24 INFO - 'USER': 'cltbld', 14:36:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:24 INFO - '_': '/tools/buildbot/bin/python'} 14:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:36:24 INFO - Cleaning up... 14:36:24 INFO - Return code: 0 14:36:24 INFO - Running post-action listener: _resource_record_post_action 14:36:24 INFO - Running post-action listener: _start_resource_monitoring 14:36:25 INFO - Starting resource monitoring. 14:36:25 INFO - [mozharness: 2016-10-19 21:36:25.012406Z] Finished create-virtualenv step (success) 14:36:25 INFO - [mozharness: 2016-10-19 21:36:25.012918Z] Running install step. 14:36:25 INFO - Running pre-action listener: _resource_record_pre_action 14:36:25 INFO - Running main action method: install 14:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:36:25 INFO - Reading from file tmpfile_stdout 14:36:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:36:25 INFO - Reading from file tmpfile_stdout 14:36:25 INFO - Output received: 14:36:25 INFO - Usage: mozinstall [options] installer 14:36:25 INFO - Options: 14:36:25 INFO - -h, --help show this help message and exit 14:36:25 INFO - -d DEST, --destination=DEST 14:36:25 INFO - Directory to install application into. [default: 14:36:25 INFO - "/builds/slave/test"] 14:36:25 INFO - --app=APP Application being installed. [default: firefox] 14:36:25 INFO - mkdir: /builds/slave/test/build/application 14:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:36:41 INFO - Reading from file tmpfile_stdout 14:36:41 INFO - Output received: 14:36:41 INFO - /builds/slave/test/build/application/firefox/firefox 14:36:41 INFO - Running post-action listener: _resource_record_post_action 14:36:41 INFO - [mozharness: 2016-10-19 21:36:41.300821Z] Finished install step (success) 14:36:41 INFO - [mozharness: 2016-10-19 21:36:41.301064Z] Running run-tests step. 14:36:41 INFO - Running pre-action listener: _resource_record_pre_action 14:36:41 INFO - Running main action method: run_tests 14:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:36:41 INFO - Python 2.7.3 14:36:41 INFO - Return code: 0 14:36:41 INFO - grabbing minidump binary from tooltool 14:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:41 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 0x29d3f60>, '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 0x29d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:36:41 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 14:36:41 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 14:36:41 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 14:36:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:36:41 INFO - Return code: 0 14:36:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 14:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 14:36:41 INFO - Using env: {'DISPLAY': ':0', 14:36:41 INFO - 'HOME': '/home/cltbld', 14:36:41 INFO - 'LANG': 'en_US.UTF-8', 14:36:41 INFO - 'LANGUAGE': 'en_US:en', 14:36:41 INFO - 'LOGNAME': 'cltbld', 14:36:41 INFO - 'MAIL': '/var/mail/cltbld', 14:36:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:36:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:41 INFO - 'MOZ_NO_REMOTE': '1', 14:36:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:41 INFO - 'NO_EM_RESTART': '1', 14:36:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:41 INFO - 'PWD': '/builds/slave/test', 14:36:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:36:41 INFO - 'SHELL': '/bin/bash', 14:36:41 INFO - 'SHLVL': '1', 14:36:41 INFO - 'TERM': 'linux', 14:36:41 INFO - 'TMOUT': '86400', 14:36:41 INFO - 'USER': 'cltbld', 14:36:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733', 14:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:41 INFO - '_': '/tools/buildbot/bin/python'} 14:36:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 14:36:41 INFO - mozversion application_buildid: 20161019115222 14:36:41 INFO - mozversion application_changeset: 33bc172941df74d989e77412854cae45682f5501 14:36:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:36:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:36:41 INFO - mozversion application_name: Firefox 14:36:41 INFO - mozversion application_remotingname: firefox-dev 14:36:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:36:41 INFO - mozversion application_vendor: Mozilla 14:36:41 INFO - mozversion application_version: 51.0a2 14:36:41 INFO - mozversion platform_buildid: 20161019115222 14:36:41 INFO - mozversion platform_changeset: 33bc172941df74d989e77412854cae45682f5501 14:36:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:36:41 INFO - mozversion platform_version: 51.0a2 14:36:41 INFO - using testdate: 1476913001 14:36:41 INFO - actual date: 1476913001 14:36:41 INFO - starting webserver on 'localhost:55175' 14:36:41 INFO - SUITE-START | Running 2 tests 14:36:41 INFO - TEST-START | dromaeo_css 14:36:41 INFO - operating with platform_type : linux_ 14:36:41 INFO - Initialising browser for dromaeo_css test... 14:36:41 INFO - TEST-INFO | started process 13878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp205TPE/profile http://localhost:55175/getInfo.html) 14:36:46 INFO - PROCESS | 13878 | __metrics Screen width/height:1600/1200 14:36:46 INFO - PROCESS | 13878 | colorDepth:24 14:36:46 INFO - PROCESS | 13878 | Browser inner width/height: 1024/697 14:36:46 INFO - PROCESS | 13878 | __metrics 14:36:46 INFO - PROCESS | 13878 | 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" 14:36:46 INFO - PROCESS | 13878 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:36:47 INFO - PROCESS | 13878 | console.error: PushService: 14:36:47 INFO - PROCESS | 13878 | stateChangeProcessEnqueue: Error transitioning state 14:36:47 INFO - PROCESS | 13878 | UnknownError 14:36:47 INFO - TEST-INFO | 13878: exit 0 14:36:47 INFO - Browser initialized. 14:36:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:36:47 INFO - TEST-INFO | started process 13969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp205TPE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:59 INFO - PROCESS | 13969 | RSS: Main: 144871424 14:36:59 INFO - PROCESS | 13969 | 14:37:50 INFO - PROCESS | 13969 | 1476913070818 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] 14:40:00 INFO - PROCESS | 13969 | Cycle 1(1): loaded http://localhost:55175/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55175/tests/dromaeo/cssquery-ext.html) 14:40:01 INFO - PROCESS | 13969 | RSS: Main: 268152832 14:40:01 INFO - PROCESS | 13969 | 14:43:03 INFO - PROCESS | 13969 | Cycle 1(1): loaded http://localhost:55175/tests/dromaeo/cssquery-ext.html (next: http://localhost:55175/tests/dromaeo/cssquery-jquery.html) 14:43:04 INFO - PROCESS | 13969 | RSS: Main: 237563904 14:43:04 INFO - PROCESS | 13969 | 14:46:06 INFO - PROCESS | 13969 | Cycle 1(1): loaded http://localhost:55175/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55175/tests/dromaeo/cssquery-mootools.html) 14:46:06 INFO - PROCESS | 13969 | RSS: Main: 221372416 14:46:06 INFO - PROCESS | 13969 | 14:49:08 INFO - PROCESS | 13969 | Cycle 1(1): loaded http://localhost:55175/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55175/tests/dromaeo/cssquery-prototype.html) 14:49:09 INFO - PROCESS | 13969 | RSS: Main: 173498368 14:49:09 INFO - PROCESS | 13969 | 14:52:11 INFO - PROCESS | 13969 | Cycle 1(1): loaded http://localhost:55175/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55175/tests/dromaeo/cssquery-yui.html) 14:52:12 INFO - PROCESS | 13969 | RSS: Main: 175497216 14:52:12 INFO - PROCESS | 13969 | 14:55:14 INFO - PROCESS | 13969 | Cycle 1(1): loaded http://localhost:55175/tests/dromaeo/cssquery-yui.html (next: http://localhost:55175/tests/dromaeo/cssquery-dojo.html) 14:55:15 INFO - PROCESS | 13969 | RSS: Main: 256368640 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | __start_tp_report 14:55:15 INFO - PROCESS | 13969 | _x_x_mozilla_page_load 14:55:15 INFO - PROCESS | 13969 | _x_x_mozilla_page_load_details 14:55:15 INFO - PROCESS | 13969 | |i|pagename|runs| 14:55:15 INFO - PROCESS | 13969 | |0;dojo.html;3143.827089510077;3167.8732850685965;3197.28061186233;3226.8547915343806;3230.1117192771985;5587.385387607365;5653.943460565393;5665.1785491103865;5680.545556355492;5687.488126068653;5680.147977803332;5754.769809207637;5758.510526605243;5765.740541675625;5801.970990145054;5146.948530514694;5175.611829112813;5177.430482646906;5209.947900521003;5251.973740131294;5084.593232541388;5236.397814251352;5250.579953603703;5253.921191182136;5290.761915713783;5056.988602279541;5075.162598171298;5090.745462726867;5098.949010509903;5163.870903227412;5161.535461808437;5171.095058364809;5239.816606418795;5242.135047717122;5276.287701160332;4926.75366231687;5068.493150684939;5132.358455193101;5194.194899790538;5213.9217911730975;5507.752151153208;5544.944550554524;5546.972265138648;5574.163875418679;5594.0769772987405;5989.610675306091;5998.25021872266;6115.5413343998935;6115.724792384309;6117.480014198798;5962.403759624046;6113.23584551931;6123.418275263887;6131.877362452726;6132.264128304588;5594.720263986825;5597.916031259534;5625.437456254383;5647.068233741386;5676.375598684142;6222.471089957314;6237.220347456568;6248.656323902138;6248.781292654735;6255.093011513305;5841.532677385799;5991.910121348184;5994.940050599525;6003.459688627957;6013.729382177725;5990.041593345044;6026.276846778414;6086.056661217518;6086.2087928569;6092.086187071975;6052.394760523913;6057.666828324484;6059.939400605937;6064.181335519736;6070.605410648293;5969.194158788508;6009.06859436788;6028.698565071729;6064.969675151596;6133.172021777003;4680.508546602626;4683.578477937002;4684.039771846831;4684.227102528044;4709.788059537329;4149.647279981175;4161.875143745692;4171.5828417158045;4172.311568591209;4197.538270790211;5646.520045796071;5687.829365119053;5705.828825135252;5745.482906538432;5753.798617048383;6111.379037751179;6115.635867915819;6127.252959893121;6133.51829027926;6134.038624681888;5774.855628609234;5777.277840269966;5787.39232380594;5789;5802.47777700009;5120.385553733576;5197.558207552401;5211.843644690665;5286.920696189561;5291.444398338196;6178.505719542426;6300.527460440394;6301.905471417841;6302.212223472066;6307.180066591405;6075.726592303446;6079.148919151411;6086.360932102066;6094.695265236809;6096.5732398733435;5999.790007349722;6134.938650613437;6258.43674069336;6273.404026617464;6284.120223168668;5936.5844390892225;5958.433948774859;5970.671613061323;6020.518358531394;6034.547408944434;6116.602420842631;6122.877542449215;6123.479504242189;6128.050152226412;6130.356312587114;5720;5983.700814959322;5997.340292567901;6006.48944839676;6006.48944839676;5809.215755873072;5812;5834.066549352084;5865.501432378295;5964.552658550713;5817.621854579439;5856.882862342644;5860.0330945395235;5866;5876.823695289148;5957.374475680164;5967.254093238345;5969.432903874125;5971.253593300838;5971.402859714168;5617.708166853151;5719.170720245458;5773.278340207474;5801.419858014334;5836.883262334644 14:55:15 INFO - PROCESS | 13969 | |1;ext.html;582.8863371642528;631.8325643704418;642.1202951955821;649.8472858878163;654.3325807676167;33321.33357332855;44706.32940505891;45464.318035229495;45697;45712.999999999956;45931;46310.7684461578;46347;46388.76805615976;46391.0721785565;8320.62557184925;9199.999999999984;9350.205232555207;9351.532423378838;9382.765430864249;8365.874511882326;8639.568021598927;8650.87023694645;10803.351798892092;11015.394153321564;11205.943970280137;11258;11259.718507037307;11267.380294083821;11284;11108.222424430292;11170.609028683957;11178.27341222822;11178.329300242012;11181.273217240854;10879.075278601329;10928.071113955324;11014.50434730439;11017.889821101766;11023.779524409547;44650.33024504635;44977.325340119925;45008;45014;45081.54918450839;3844.5386553613466;3916.549596796348;4032.334664780308;4088.2845502037026;4372.519022907478;33789.6621033789;33821.15447113817;33943.830280848684;34303.656963430294;34561.827190863885;4507.729536227836;4576.771161441915;4656.65075119364;4657.976710116428;4780.402449693788;254422;254781;255541;255569;256204;59979;60104;60137.69931150404;60193.39806601878;60239.39760602426;39903.201935961115;40729.59270407317;41046.589534104874;43321.78339108284;43341.783291083346;19391.4182574523;19540;19552.804471955384;19569.315073972342;19580.21679132819;15061.246937653073;15118.244087795567;15141;15161.469348572968;15163.393464261306;18349;18797.718034229496;19807.900960495106;20369.185232590826;20591.794082058987;7445.25547445262;7468.925310746931;7620.847583048308;7729.458937874408;7746.92253077462;987.7678745494803;1010.1767059846349;1083.5774048121239;1119.8600174978128;1133.5465813674432;34367;35059.824700876336;35073.29853402918;35109.29781404409;35298.29403411917;1187.8158885372782;1229.8647148813623;1242.6520574239228;1264.0772236267576;1280.9295488748207;17370.565735856453;18117.09414529268;18435.72346414805;18445.90777046133;18518.81481185198;594282;598137;598634;602986;603323;61851.38148618546;62674.686626566574;62794.37205627885;62797.68601156965;62920.68539657273;1333.7865941449322;1387.1191793211383;1390.1520072755611;1462.5831637983335;1476.047949072842;32783.836080820394;35402.82298588491;35665.28669426545;37614.24771504609;37784.43323350097;56360.436395635516;57085.42914570801;57120.428795713175;57162.7141864288;57211.713941430025;526645;528182;528884;528911;531247;30974.690253097182;31864.044078677678;32141.1964700875;32250.193745156557;32300.67699322977;49213.94259398955;49416.25875611941;49420.258696118864;49533.257001145736;50399.24401134059;41715;42072.789636051624;42449;43010;43207.567924321615;40560.59439405686;40922.38616420697;42218;42451.3632295522;42929.35605965851;40868.59131408648;41973.029739127975;42034.78982605068;42386.152276954905;42949;34755.652443476254;37125.628743712216;37169.44245836369;37706.8114659425;38188.2362352757;28790;28950.565741514314;29147.417051658424;29148.708512915447;29259.41481170407 14:55:15 INFO - PROCESS | 13969 | |2;jquery.html;396.9563348031718;409.5842719639566;432.59552318582126;434.2986077484862;434.884755539782;14962.551123466299;19806.7028994565;20427.285045023425;20447.97760111992;21294.254701085465;20737;20903.37289881302;20968.26611068613;20970.161193552238;21308.36074917751;5915.645061296314;5970.850728731784;6132.2028136342215;6170.2904166021035;6182.659953702545;5987.1019347097845;6081;6103.45068943795;6106.084087386883;6115.388461153893;5950.404959504037;6140.1096840958035;6211.192544969148;6316.873662526747;6319.90520142196;5910;6032.306284777219;6282.465990390822;6293.276273228592;6303.432691057827;5880.9411905880825;5909.674967876765;5911.113333000041;5912.408759124096;5914.083317085859;14148.292585370691;15385.46150884725;23184.60892346448;24021.879890600434;24898.751012489825;2347.190219374313;2428.138011006085;2562.5899856022947;2709.7425744554234;2944.514155164395;10866.130709543218;11097.3896435696;11311.717207069807;11406.71483212918;11510.30938143714;1930.7296978423033;1945.873518221311;1978.2581531925528;1991.7294284515663;2100.579884023186;78564;85037.29925401519;89461.10538894658;89623;92401.53799231027;11396.088312934946;11712.88287117135;11773.411329433495;11954.701132471584;11986.76026479483;17119.400820971205;17130.571735706708;17150.57123571896;17163.570910727332;17180.312787488612;9160.404573702688;9201.585928633227;9262.768430789285;9328.533573321307;9405.247580193569;8763.474191548528;8892.555372231363;8934.731958041139;9150.496722680184;9189.448633082036;5101.489851014943;5148.871278218;5165.741712914414;5251;5291.656042357235;1973.5855470351387;2021.6563184258712;2054.589082183569;2060.330392622404;2144.7507026854328;958.9136977671903;1013.5135135135029;1016.8118898003893;1025.487256371814;1046.9633562825265;19427.90286048589;20223.19107235694;20658.58682826335;20994.005569470875;21198.15207391718;1005.818952588541;1043.1811028342715;1075.499892549968;1113.6046703420332;1119.630521927762;11045.28205666629;11324.263922844988;11385.37380444067;11394.25937314072;11551.653450396501;538359;558263;559305;561320;575014;98682.5065874666;100726.49636751915;101409;103477.96522034834;104524;1077.946102694862;1103.1395511501041;1114.793763153819;1135.03522006294;1138.4250953268547;17780.733289000418;18004.459866204033;18044.90977545104;18329.633407331512;18443.170057347183;41144.1771164581;44462.77768611136;45132.09735805331;46713.29930050984;46970.53029469798;59074;60846.39153608407;61842.690786545776;62086.37913620806;62772.37227627848;8793.472391656522;9071.146936389001;9074.183323500916;9131.863022054542;9363.625454981724;10124.848127278245;12970.02724795663;13427.395767190304;13453.46186152543;13775.517856875362;12046.518139274682;12237.877621223673;12516.687082822638;12529;12654;5663.150527420755;10209.84685229737;11484.540618375171;12076;12373.814392784296;11331.490082946451;12584.874151258371;12613.87386126127;12674.493020279086;12854.67863303425;9327.626894924128;9436.85844712316;9487.905120948702;9615.423074615546;9619.759506012406;11775.646730598095;12316.384180790745;12358.62924112278;12433.502659893504;12702.110852240254 14:55:15 INFO - PROCESS | 13969 | |3;mootools.html;1408.8379836318827;1551.8758499320052;1590.6580085281664;1731.9047452390114;1814.6915024445834;7879.527228366302;8174.754757357281;8346.207110324516;8421.999999999985;8704.73885783426;8514.91485085149;8607.612657430414;8618.569071546413;8620.65517379304;8625.956870215656;2386.284114765572;2412.7225369082516;2413.78275955164;2419.1049311754678;2424.4181396464896;2367.917122900699;2418.830681852271;2430.878456077198;2435.841670291434;2436.5370579589908;2401.351635058542;2405.747396523366;2419.3830573203895;2431.6352547117986;2433.85396876188;2331.895064722083;2348.248560460653;2353.95292094158;2366.1954935322074;2382.7617238276207;2370.9051637934463;2410.7227668818136;2415.1546958564536;2417.552752740731;2419.008206635271;9120.726378208665;9209.125133112344;9213.90786092144;9215.354925155241;9215.400998935114;5447.210154527611;5587.916181257285;5598.440155984369;5695.943040569583;5716.456936591017;3500.194955160302;3539.823008849573;3590.838412271428;3642.271545690846;3662.9084272893124;1141.2923987127951;1148.62095508482;1157.1841851494676;1169.222467059413;1187.0859438232599;12638.178518396275;12685.36573171347;12702.047346449146;12715;12725.681857953532;4519.54804519552;4629.8148074077335;4708.128996135726;4746.762661866893;4749.311349854252;10142;10147.7463063424;10150.086492215736;10153.441560714084;10173.08442240202;5453.182022696627;5471.72641367938;5479.013777520085;5503.091989821714;5518.668879867221;4416.315471101984;4591.334256532784;4962.578180854595;5105.310783044241;5148.2020286855595;4050.8177132029127;4090.406891000788;4137.213929353474;4202.936955945664;4222.345536441795;1221.1757063981777;1222.9388530573435;1267.2016629523525;1279.718461938372;1298.7012987012852;916.5417291354323;993.2171751705706;1011.22135955314;1033.0908800255727;1050.810854046279;6012.969935150296;6274.435300822948;6332;6358.1416508771645;6447.903856344433;462.25807578836157;471.9528047195253;472.06766635893837;477.85664300709647;494.868859752166;4305.095929854703;4317.201317756225;4393.560643935645;4424.491183513873;4534.6599005074095;10811.567537298577;10975.341479511255;11046.281991670516;11051.17116216287;11052;10853.457327133612;10940.617078402218;10981.17641176915;11005.119590432747;11013.559457621606;8384.53885036329;8501.319894408432;8516.616752246164;8521.82956340882;8527.10465401124;6034.939650603614;6073.952830890488;6112.847178820565;6154.476869466145;6164;10021.74945626336;10214.744631384276;10300.072993430627;10319.277650564389;10348.793024139626;10406.70692150325;10463.529141188512;10573.947130264607;10632.787344252916;10667.786644267226;7628.275313845176;7628.275313845176;7629.3133617974645;7684.538927664358;7691.807704807425;8851.69019084329;8900.510471924106;8924.68763593271;8929;8935.195832375117;8059.234372734581;8073.515589064675;8092.676292948451;8173.591320434073;8262.793430164294;7894.328982036591;7934.20657934202;7971.242731940456;7991.480553763987;8000.119986801331;6992.79021629352;7097.787066388017;7232.385247254042;7379.262073792578;7392.223816499405;5357.276767636475;5362.356517217959;5385;5489.286392768914;5491.258680078138;5549.472800083986;5574.219609254626;5599.916001260066;5665.886682266414;5689.772409103755 14:55:15 INFO - PROCESS | 13969 | |4;prototype.html;349.52639173919334;352.35870715298154;356.26609185078723;362.5196614485807;364.1933118143312;5462.945370546293;5479.890402191959;5517.36550296716;5517.668939863611;5521.641093328931;5416.593755468336;5439.4832490913395;5458.890822183564;5461.2354270402175;5465.644733092357;3749.568799588041;4043.3934909763475;4227.302495088306;4332.566743325674;4340.262155433568;4333.58830911063;4341.435613370258;4343.631755996867;4344.391785150082;4351.804168812411;4262.893427664302;4306.375575541545;4308.181445525356;4311.28863737483;4345.69580129391;4120.64018873771;4137.234611596849;4200.432941552882;4316.64025831862;4353.956460435386;3836.443715661241;3837.846486140551;3873.360895452275;3874.1476875087437;3887;5303.867403314948;5319.5478384337375;5326.893462130774;5341.759620817073;5370.140777475585;4823.879403014917;4941.332920055783;4974.37820272466;4990.675606085593;4991.376077990251;5676.545876329925;5684.147377893308;5707.600467967244;5742.511886489653;5766.241296404595;4279.700420970534;4281.379200016011;4285.528591854893;4286.549912259199;4291.828326866922;5669.971650141764;5751.367349591542;5819.6508209507565;5952.571382868124;5957.6127551709;4243.6605071594195;4372.366006928977;4388.341748737715;4389.407429996973;4394.12117576486;4429.82280708768;4433.135538569948;4436.3123715824095;4443.911121777546;4447.310666846644;4880.829170978998;4964.478729733398;4983.875403114951;4996.850094497171;5020.648554601216;5677.120046392815;5757.9424205757405;5768.653880767168;5780.67044579749;5784.681842498619;1520.3082597418147;1539.2611546457763;1541.3295216580823;1542.0362273579012;1546.4432804190483;957.5882370580578;994.4033579852176;1007.7833265847878;1008.5663164839043;1011.4942528735633;4886;4893.877653058631;4894.975525122423;4896.755162241873;4930.876728081755;5182.352205974254;5210.687358758487;5215.1838007475535;5215.7913683453;5221.947780522146;4532.886677833015;4780.872511732316;4891.508090032503;4904.705717656952;4906.435759887588;2736.9726302737117;2744.3687951771203;2748.8900443982416;2768.363276446388;2782.791290653209;5324.866878327995;5337.973310133424;5353.250544923714;5355.571554275649;5367.785288588413;5095.082885080721;5164.664296820694;5220.504052115043;5233.39815921174;5297.443768404339;5268.235141227655;5275.973620131875;5280.894382112337;5301.761420736076;5313.442088580643;5166.4316925137455;5176.343570057696;5180.870478237924;5195.792168313225;5210.847437300378;4950.925736113889;5151.948480515147;5188.247704082963;5193.818216362409;5215.774293041057;5366.060939335679;5809.680467574324;5939.940600594112;5940.554458415722;6119.418655227746;4340.153670034313;4367.934480982724;4388.407564978687;4396.560343965578;4401.735895846259;5732.757759258202;5905.99598068338;5908.7045647718305;5921.542559837619;5937.664025594207;5650.208970744017;5743.195952566728;5746.482816546363;5796.782675638163;5806.796762113306;5762.213713748752;5772.39389864075;5779.757352169304;5780.768769249183;5841.883162336814;5567.805126820542;5772.383732554891;5780.653160810365;5805.419458054161;5821.738021789114;5842.1820945068575;5842.7662893485485;5846.327672317738;5885.911711324248;5891.499222565958;5547.639403438763;5708.743106560131;5718.456746609066;5738.0777439558215;5738.942610573841 14:55:15 INFO - PROCESS | 13969 | |5;yui.html;789.9486533375331;791.3550456378051;804.5988443215608;888.5646033443606;917.7889085510333;15830.208489575518;16850.66298674026;16860.66278674426;16872.915635421807;16906.154692265398;14699;15221.771673424908;15368.462103826369;15391.84608153918;15415.84584154158;718.8777907755668;736.2416710787898;838.3460900497606;854.786303424144;858.159004175908;838.5932822581043;860.9096044915287;867.1328671328671;872.6771094694972;875.2341701011615;914.4833169259347;916.294453270981;916.6287653500343;917.1882883647986;917.2295271971543;742.6658003898267;759.3924860111944;909.636145541782;909.8453262945316;909.9636014559443;642.0369445831253;656.7044829826597;662.3872917551294;663.6582160187507;664.5348256220665;16333.509994700178;16369.59076023097;16374.263158157792;16374.590635234095;16407.753883691756;14786.40854365824;15169.848301516953;15549.144797036159;15728.37086516538;15933.123678197695;13375.665608359772;13634.93182534081;13952.86047139536;14163.150210987375;14176.362063707158;4578.702384345007;4644.489106198315;4674.69614475058;4681.321208424793;4796.784144713496;67504.6624766873;68609.31390686079;70268.2973170272;70713.2928670717;83888.58055709743;12175.573854915212;12290.446929888176;12323.137380383467;12771.297578633264;12992.090553661154;22741.658875116886;22769.430764230696;22788.08847646109;22799.31602051941;22811.087556497885;8961.59672814725;8996.325275604357;9020.954895225614;9075.311720698255;9379.108984646447;5123.462036486189;5171.3535808024;5215.24378965048;5263.078961181778;5436.211749296409;3642.2897534980953;3781.1870447853844;3783.0353259918543;3784.129650180474;3785.6971442284553;652.0968458684661;652.2531701202097;652.3281020548842;659.3406593406594;667.1693741292122;744.4342299852043;766.7201471462987;772.82997740497;784.7802615267734;804.5373910001772;9743.561539730728;9936.950315248378;9986.950065249772;10066.949665251774;10780.730481738019;753.6608526163249;767.8349154931716;770.2182284980637;776.7630872583916;798.9480683755653;4636.976815115903;4805.783739731721;4813.302071199656;4822.300766388924;4943.110240156806;78306.21693782989;79369;98353;130721;131434;109221.45389273162;110233.44883275533;111386;113432;115291;79087;99104;99243.50378248208;100606;101049.49475252724;8725.781855453664;9012;9015.098490150933;9026.684066057656;9028.729138125867;42486.78756606197;55690;60646.393536065836;61447;61628.691856540434;54235;70972.29027709864;71208;72061;79468;13604.523841665494;13644.727105458034;13781.242031688353;14046.227457489937;14086.295685215904;14770;14913.552593422215;15581.688366232385;15666.37334506607;15920.363185472916;11062;14189.00730785721;14907;15007.174605396807;15133.243337832844;14723.484678036217;15159.848401515843;15171.848281517043;15243.466478673638;15452.150131742863;13694.383752730952;13990.16059036461;14567.198804065878;14574.781378279546;15007.774883376977;11412.942935285602;11605.535778568763;11958.58144964922;11994.280343179436;12142.696432589257;11430.314181149157;11680;11762.353070580857;11820.23168494045;11997.220180688228 14:55:15 INFO - PROCESS | 13969 | __end_tp_report 14:55:15 INFO - PROCESS | 13969 | __start_cc_report 14:55:15 INFO - PROCESS | 13969 | _x_x_mozilla_cycle_collect,966 14:55:15 INFO - PROCESS | 13969 | __end_cc_report 14:55:15 INFO - PROCESS | 13969 | __startTimestamp1476914115108__endTimestamp 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | ------- Summary: start ------- 14:55:15 INFO - PROCESS | 13969 | Number of tests: 6 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | [#0] dojo.html Cycles:165 Average:5632.87 Median:5817.62 stddev:645.34 (11.1%) stddev-sans-first:617.08 14:55:15 INFO - PROCESS | 13969 | Values: 3143.8 3167.9 3197.3 3226.9 3230.1 5587.4 5653.9 5665.2 5680.5 5687.5 5680.1 5754.8 5758.5 5765.7 5802.0 5146.9 5175.6 5177.4 5209.9 5252.0 5084.6 5236.4 5250.6 5253.9 5290.8 5057.0 5075.2 5090.7 5098.9 5163.9 5161.5 5171.1 5239.8 5242.1 5276.3 4926.8 5068.5 5132.4 5194.2 5213.9 5507.8 5544.9 5547.0 5574.2 5594.1 5989.6 5998.3 6115.5 6115.7 6117.5 5962.4 6113.2 6123.4 6131.9 6132.3 5594.7 5597.9 5625.4 5647.1 5676.4 6222.5 6237.2 6248.7 6248.8 6255.1 5841.5 5991.9 5994.9 6003.5 6013.7 5990.0 6026.3 6086.1 6086.2 6092.1 6052.4 6057.7 6059.9 6064.2 6070.6 5969.2 6009.1 6028.7 6065.0 6133.2 4680.5 4683.6 4684.0 4684.2 4709.8 4149.6 4161.9 4171.6 4172.3 4197.5 5646.5 5687.8 5705.8 5745.5 5753.8 6111.4 6115.6 6127.3 6133.5 6134.0 5774.9 5777.3 5787.4 5789.0 5802.5 5120.4 5197.6 5211.8 5286.9 5291.4 6178.5 6300.5 6301.9 6302.2 6307.2 6075.7 6079.1 6086.4 6094.7 6096.6 5999.8 6134.9 6258.4 6273.4 6284.1 5936.6 5958.4 5970.7 6020.5 6034.5 6116.6 6122.9 6123.5 6128.1 6130.4 5720.0 5983.7 5997.3 6006.5 6006.5 5809.2 5812.0 5834.1 5865.5 5964.6 5817.6 5856.9 5860.0 5866.0 5876.8 5957.4 5967.3 5969.4 5971.3 5971.4 5617.7 5719.2 5773.3 5801.4 5836.9 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | [#1] ext.html Cycles:180 Average:62861.79 Median:22296.46 stddev:129148.57 (579.2%) stddev-sans-first:129426.22 14:55:15 INFO - PROCESS | 13969 | Values: 582.9 631.8 642.1 649.8 654.3 33321.3 44706.3 45464.3 45697.0 45713.0 45931.0 46310.8 46347.0 46388.8 46391.1 8320.6 9200.0 9350.2 9351.5 9382.8 8365.9 8639.6 8650.9 10803.4 11015.4 11205.9 11258.0 11259.7 11267.4 11284.0 11108.2 11170.6 11178.3 11178.3 11181.3 10879.1 10928.1 11014.5 11017.9 11023.8 44650.3 44977.3 45008.0 45014.0 45081.5 3844.5 3916.5 4032.3 4088.3 4372.5 33789.7 33821.2 33943.8 34303.7 34561.8 4507.7 4576.8 4656.7 4658.0 4780.4 254422.0 254781.0 255541.0 255569.0 256204.0 59979.0 60104.0 60137.7 60193.4 60239.4 39903.2 40729.6 41046.6 43321.8 43341.8 19391.4 19540.0 19552.8 19569.3 19580.2 15061.2 15118.2 15141.0 15161.5 15163.4 18349.0 18797.7 19807.9 20369.2 20591.8 7445.3 7468.9 7620.8 7729.5 7746.9 987.8 1010.2 1083.6 1119.9 1133.5 34367.0 35059.8 35073.3 35109.3 35298.3 1187.8 1229.9 1242.7 1264.1 1280.9 17370.6 18117.1 18435.7 18445.9 18518.8 594282.0 598137.0 598634.0 602986.0 603323.0 61851.4 62674.7 62794.4 62797.7 62920.7 1333.8 1387.1 1390.2 1462.6 1476.0 32783.8 35402.8 35665.3 37614.2 37784.4 56360.4 57085.4 57120.4 57162.7 57211.7 526645.0 528182.0 528884.0 528911.0 531247.0 30974.7 31864.0 32141.2 32250.2 32300.7 49213.9 49416.3 49420.3 49533.3 50399.2 41715.0 42072.8 42449.0 43010.0 43207.6 40560.6 40922.4 42218.0 42451.4 42929.4 40868.6 41973.0 42034.8 42386.2 42949.0 34755.7 37125.6 37169.4 37706.8 38188.2 28790.0 28950.6 29147.4 29148.7 29259.4 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | [#2] jquery.html Cycles:180 Average:31866.37 Median:21246.20 stddev:92026.57 (433.1%) stddev-sans-first:92254.40 14:55:15 INFO - PROCESS | 13969 | Values: 397.0 409.6 432.6 434.3 434.9 14962.6 19806.7 20427.3 20448.0 21294.3 20737.0 20903.4 20968.3 20970.2 21308.4 5915.6 5970.9 6132.2 6170.3 6182.7 5987.1 6081.0 6103.5 6106.1 6115.4 5950.4 6140.1 6211.2 6316.9 6319.9 5910.0 6032.3 6282.5 6293.3 6303.4 5880.9 5909.7 5911.1 5912.4 5914.1 14148.3 15385.5 23184.6 24021.9 24898.8 2347.2 2428.1 2562.6 2709.7 2944.5 10866.1 11097.4 11311.7 11406.7 11510.3 1930.7 1945.9 1978.3 1991.7 2100.6 78564.0 85037.3 89461.1 89623.0 92401.5 11396.1 11712.9 11773.4 11954.7 11986.8 17119.4 17130.6 17150.6 17163.6 17180.3 9160.4 9201.6 9262.8 9328.5 9405.2 8763.5 8892.6 8934.7 9150.5 9189.4 5101.5 5148.9 5165.7 5251.0 5291.7 1973.6 2021.7 2054.6 2060.3 2144.8 958.9 1013.5 1016.8 1025.5 1047.0 19427.9 20223.2 20658.6 20994.0 21198.2 1005.8 1043.2 1075.5 1113.6 1119.6 11045.3 11324.3 11385.4 11394.3 11551.7 538359.0 558263.0 559305.0 561320.0 575014.0 98682.5 100726.5 101409.0 103478.0 104524.0 1077.9 1103.1 1114.8 1135.0 1138.4 17780.7 18004.5 18044.9 18329.6 18443.2 41144.2 44462.8 45132.1 46713.3 46970.5 59074.0 60846.4 61842.7 62086.4 62772.4 8793.5 9071.1 9074.2 9131.9 9363.6 10124.8 12970.0 13427.4 13453.5 13775.5 12046.5 12237.9 12516.7 12529.0 12654.0 5663.2 10209.8 11484.5 12076.0 12373.8 11331.5 12584.9 12613.9 12674.5 12854.7 9327.6 9436.9 9487.9 9615.4 9619.8 11775.6 12316.4 12358.6 12433.5 12702.1 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | [#3] mootools.html Cycles:180 Average:5936.82 Median:2526.80 stddev:3347.54 (132.5%) stddev-sans-first:3339.63 14:55:15 INFO - PROCESS | 13969 | Values: 1408.8 1551.9 1590.7 1731.9 1814.7 7879.5 8174.8 8346.2 8422.0 8704.7 8514.9 8607.6 8618.6 8620.7 8626.0 2386.3 2412.7 2413.8 2419.1 2424.4 2367.9 2418.8 2430.9 2435.8 2436.5 2401.4 2405.7 2419.4 2431.6 2433.9 2331.9 2348.2 2354.0 2366.2 2382.8 2370.9 2410.7 2415.2 2417.6 2419.0 9120.7 9209.1 9213.9 9215.4 9215.4 5447.2 5587.9 5598.4 5695.9 5716.5 3500.2 3539.8 3590.8 3642.3 3662.9 1141.3 1148.6 1157.2 1169.2 1187.1 12638.2 12685.4 12702.0 12715.0 12725.7 4519.5 4629.8 4708.1 4746.8 4749.3 10142.0 10147.7 10150.1 10153.4 10173.1 5453.2 5471.7 5479.0 5503.1 5518.7 4416.3 4591.3 4962.6 5105.3 5148.2 4050.8 4090.4 4137.2 4202.9 4222.3 1221.2 1222.9 1267.2 1279.7 1298.7 916.5 993.2 1011.2 1033.1 1050.8 6013.0 6274.4 6332.0 6358.1 6447.9 462.3 472.0 472.1 477.9 494.9 4305.1 4317.2 4393.6 4424.5 4534.7 10811.6 10975.3 11046.3 11051.2 11052.0 10853.5 10940.6 10981.2 11005.1 11013.6 8384.5 8501.3 8516.6 8521.8 8527.1 6034.9 6074.0 6112.8 6154.5 6164.0 10021.7 10214.7 10300.1 10319.3 10348.8 10406.7 10463.5 10573.9 10632.8 10667.8 7628.3 7628.3 7629.3 7684.5 7691.8 8851.7 8900.5 8924.7 8929.0 8935.2 8059.2 8073.5 8092.7 8173.6 8262.8 7894.3 7934.2 7971.2 7991.5 8000.1 6992.8 7097.8 7232.4 7379.3 7392.2 5357.3 5362.4 5385.0 5489.3 5491.3 5549.5 5574.2 5599.9 5665.9 5689.8 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | [#4] prototype.html Cycles:180 Average:4697.45 Median:5185.30 stddev:1335.62 (25.8%) stddev-sans-first:1298.89 14:55:15 INFO - PROCESS | 13969 | Values: 349.5 352.4 356.3 362.5 364.2 5462.9 5479.9 5517.4 5517.7 5521.6 5416.6 5439.5 5458.9 5461.2 5465.6 3749.6 4043.4 4227.3 4332.6 4340.3 4333.6 4341.4 4343.6 4344.4 4351.8 4262.9 4306.4 4308.2 4311.3 4345.7 4120.6 4137.2 4200.4 4316.6 4354.0 3836.4 3837.8 3873.4 3874.1 3887.0 5303.9 5319.5 5326.9 5341.8 5370.1 4823.9 4941.3 4974.4 4990.7 4991.4 5676.5 5684.1 5707.6 5742.5 5766.2 4279.7 4281.4 4285.5 4286.5 4291.8 5670.0 5751.4 5819.7 5952.6 5957.6 4243.7 4372.4 4388.3 4389.4 4394.1 4429.8 4433.1 4436.3 4443.9 4447.3 4880.8 4964.5 4983.9 4996.9 5020.6 5677.1 5757.9 5768.7 5780.7 5784.7 1520.3 1539.3 1541.3 1542.0 1546.4 957.6 994.4 1007.8 1008.6 1011.5 4886.0 4893.9 4895.0 4896.8 4930.9 5182.4 5210.7 5215.2 5215.8 5221.9 4532.9 4780.9 4891.5 4904.7 4906.4 2737.0 2744.4 2748.9 2768.4 2782.8 5324.9 5338.0 5353.3 5355.6 5367.8 5095.1 5164.7 5220.5 5233.4 5297.4 5268.2 5276.0 5280.9 5301.8 5313.4 5166.4 5176.3 5180.9 5195.8 5210.8 4950.9 5151.9 5188.2 5193.8 5215.8 5366.1 5809.7 5939.9 5940.6 6119.4 4340.2 4367.9 4388.4 4396.6 4401.7 5732.8 5906.0 5908.7 5921.5 5937.7 5650.2 5743.2 5746.5 5796.8 5806.8 5762.2 5772.4 5779.8 5780.8 5841.9 5567.8 5772.4 5780.7 5805.4 5821.7 5842.2 5842.8 5846.3 5885.9 5891.5 5547.6 5708.7 5718.5 5738.1 5738.9 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - PROCESS | 13969 | [#5] yui.html Cycles:180 Average:21457.53 Median:4678.01 stddev:30577.76 (653.6%) stddev-sans-first:30624.16 14:55:15 INFO - PROCESS | 13969 | Values: 789.9 791.4 804.6 888.6 917.8 15830.2 16850.7 16860.7 16872.9 16906.2 14699.0 15221.8 15368.5 15391.8 15415.8 718.9 736.2 838.3 854.8 858.2 838.6 860.9 867.1 872.7 875.2 914.5 916.3 916.6 917.2 917.2 742.7 759.4 909.6 909.8 910.0 642.0 656.7 662.4 663.7 664.5 16333.5 16369.6 16374.3 16374.6 16407.8 14786.4 15169.8 15549.1 15728.4 15933.1 13375.7 13634.9 13952.9 14163.2 14176.4 4578.7 4644.5 4674.7 4681.3 4796.8 67504.7 68609.3 70268.3 70713.3 83888.6 12175.6 12290.4 12323.1 12771.3 12992.1 22741.7 22769.4 22788.1 22799.3 22811.1 8961.6 8996.3 9021.0 9075.3 9379.1 5123.5 5171.4 5215.2 5263.1 5436.2 3642.3 3781.2 3783.0 3784.1 3785.7 652.1 652.3 652.3 659.3 667.2 744.4 766.7 772.8 784.8 804.5 9743.6 9937.0 9987.0 10066.9 10780.7 753.7 767.8 770.2 776.8 798.9 4637.0 4805.8 4813.3 4822.3 4943.1 78306.2 79369.0 98353.0 130721.0 131434.0 109221.5 110233.4 111386.0 113432.0 115291.0 79087.0 99104.0 99243.5 100606.0 101049.5 8725.8 9012.0 9015.1 9026.7 9028.7 42486.8 55690.0 60646.4 61447.0 61628.7 54235.0 70972.3 71208.0 72061.0 79468.0 13604.5 13644.7 13781.2 14046.2 14086.3 14770.0 14913.6 15581.7 15666.4 15920.4 11062.0 14189.0 14907.0 15007.2 15133.2 14723.5 15159.8 15171.8 15243.5 15452.2 13694.4 13990.2 14567.2 14574.8 15007.8 11412.9 11605.5 11958.6 11994.3 12142.7 11430.3 11680.0 11762.4 11820.2 11997.2 14:55:15 INFO - PROCESS | 13969 | -------- Summary: end -------- 14:55:15 INFO - PROCESS | 13969 | 14:55:15 INFO - TEST-INFO | 13969: exit 0 14:55:15 INFO - TEST-OK | dromaeo_css | took 1114104ms 14:55:15 INFO - TEST-START | kraken 14:55:15 INFO - operating with platform_type : linux_ 14:55:15 INFO - Initialising browser for kraken test... 14:55:15 INFO - TEST-INFO | started process 14289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcHHxK/profile http://localhost:55175/getInfo.html) 14:55:20 INFO - PROCESS | 14289 | __metrics Screen width/height:1600/1200 14:55:20 INFO - PROCESS | 14289 | colorDepth:24 14:55:20 INFO - PROCESS | 14289 | Browser inner width/height: 1024/697 14:55:20 INFO - PROCESS | 14289 | __metrics 14:55:20 INFO - PROCESS | 14289 | 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" 14:55:20 INFO - PROCESS | 14289 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:55:21 INFO - PROCESS | 14289 | console.error: PushService: 14:55:21 INFO - PROCESS | 14289 | stateChangeProcessEnqueue: Error transitioning state 14:55:21 INFO - PROCESS | 14289 | UnknownError 14:55:21 INFO - TEST-INFO | 14289: exit 0 14:55:21 INFO - Browser initialized. 14:55:21 INFO - Running cycle 1/1 for kraken test... 14:55:21 INFO - TEST-INFO | started process 14378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwcHHxK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:33 INFO - PROCESS | 14378 | RSS: Main: 144879616 14:55:33 INFO - PROCESS | 14378 | 14:55:36 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55175/tests/kraken/driver.html?testName=audio-beat-detection) 14:55:36 INFO - PROCESS | 14378 | RSS: Main: 186437632 14:55:36 INFO - PROCESS | 14378 | 14:55:39 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55175/tests/kraken/driver.html?testName=audio-dft) 14:55:40 INFO - PROCESS | 14378 | RSS: Main: 175689728 14:55:40 INFO - PROCESS | 14378 | 14:55:42 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55175/tests/kraken/driver.html?testName=audio-fft) 14:55:43 INFO - PROCESS | 14378 | RSS: Main: 266981376 14:55:43 INFO - PROCESS | 14378 | 14:55:45 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55175/tests/kraken/driver.html?testName=audio-oscillator) 14:55:46 INFO - PROCESS | 14378 | RSS: Main: 173441024 14:55:46 INFO - PROCESS | 14378 | 14:55:48 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55175/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:55:48 INFO - PROCESS | 14378 | RSS: Main: 174993408 14:55:48 INFO - PROCESS | 14378 | 14:55:51 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55175/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:52 INFO - PROCESS | 14378 | RSS: Main: 211001344 14:55:52 INFO - PROCESS | 14378 | 14:55:55 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55175/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:56 INFO - PROCESS | 14378 | RSS: Main: 210452480 14:55:56 INFO - PROCESS | 14378 | 14:55:58 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55175/tests/kraken/driver.html?testName=json-parse-financial) 14:55:59 INFO - PROCESS | 14378 | RSS: Main: 209559552 14:55:59 INFO - PROCESS | 14378 | 14:56:01 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55175/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:56:01 INFO - PROCESS | 14378 | RSS: Main: 171835392 14:56:01 INFO - PROCESS | 14378 | 14:56:03 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:56:03 INFO - PROCESS | 14378 | RSS: Main: 178126848 14:56:03 INFO - PROCESS | 14378 | 14:56:05 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:56:06 INFO - PROCESS | 14378 | RSS: Main: 188485632 14:56:06 INFO - PROCESS | 14378 | 14:56:08 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:56:09 INFO - PROCESS | 14378 | RSS: Main: 197144576 14:56:09 INFO - PROCESS | 14378 | 14:56:12 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:56:12 INFO - PROCESS | 14378 | RSS: Main: 193568768 14:56:12 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:55175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55175/tests/kraken/driver.html?testName=ai-astar) 14:56:14 INFO - PROCESS | 14378 | RSS: Main: 245698560 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | __start_tp_report 14:56:14 INFO - PROCESS | 14378 | _x_x_mozilla_page_load 14:56:14 INFO - PROCESS | 14378 | _x_x_mozilla_page_load_details 14:56:14 INFO - PROCESS | 14378 | |i|pagename|runs| 14:56:14 INFO - PROCESS | 14378 | |0;ai-astar;108;112;110;112;111;111;110;110;110;109 14:56:14 INFO - PROCESS | 14378 | |1;audio-beat-detection;151;118;116;175;117;118;116;119;152;122 14:56:14 INFO - PROCESS | 14378 | |2;audio-dft;166;161;160;159;162;164;162;160;161;161 14:56:14 INFO - PROCESS | 14378 | |3;audio-fft;76;76;74;104;75;76;81;75;104;75 14:56:14 INFO - PROCESS | 14378 | |4;audio-oscillator;82;82;112;82;82;81;110;83;82;105 14:56:14 INFO - PROCESS | 14378 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;116;117 14:56:14 INFO - PROCESS | 14378 | |6;imaging-darkroom;146;148;146;146;146;147;146;147;145;146 14:56:14 INFO - PROCESS | 14378 | |7;imaging-desaturate;95;94;96;95;95;95;95;95;95;95 14:56:14 INFO - PROCESS | 14378 | |8;json-parse-financial;49;49;50;49;49;49;50;49;49;51 14:56:14 INFO - PROCESS | 14378 | |9;json-stringify-tinderbox;57;60;59;61;59;59;59;60;60;59 14:56:14 INFO - PROCESS | 14378 | |10;stanford-crypto-aes;72;76;76;78;73;74;73;79;73;72 14:56:14 INFO - PROCESS | 14378 | |11;stanford-crypto-ccm;130;138;128;119;118;118;115;120;160;118 14:56:14 INFO - PROCESS | 14378 | |12;stanford-crypto-pbkdf2;153;152;150;154;152;155;153;155;151;150 14:56:14 INFO - PROCESS | 14378 | |13;stanford-crypto-sha256-iterative;61;63;63;62;66;63;59;66;61;62 14:56:14 INFO - PROCESS | 14378 | __end_tp_report 14:56:14 INFO - PROCESS | 14378 | __start_cc_report 14:56:14 INFO - PROCESS | 14378 | _x_x_mozilla_cycle_collect,1585 14:56:14 INFO - PROCESS | 14378 | __end_cc_report 14:56:14 INFO - PROCESS | 14378 | __startTimestamp1476914174826__endTimestamp 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | ------- Summary: start ------- 14:56:14 INFO - PROCESS | 14378 | Number of tests: 14 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:1.25 (1.1%) stddev-sans-first:1.01 14:56:14 INFO - PROCESS | 14378 | Values: 108.0 112.0 110.0 112.0 111.0 111.0 110.0 110.0 110.0 109.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:120.50 stddev:21.04 (17.5%) stddev-sans-first:20.95 14:56:14 INFO - PROCESS | 14378 | Values: 151.0 118.0 116.0 175.0 117.0 118.0 116.0 119.0 152.0 122.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.07 (1.3%) stddev-sans-first:1.45 14:56:14 INFO - PROCESS | 14378 | Values: 166.0 161.0 160.0 159.0 162.0 164.0 162.0 160.0 161.0 161.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.50 stddev:11.96 (15.8%) stddev-sans-first:12.51 14:56:14 INFO - PROCESS | 14378 | Values: 76.0 76.0 74.0 104.0 75.0 76.0 81.0 75.0 104.0 75.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.16 (16.0%) stddev-sans-first:13.63 14:56:14 INFO - PROCESS | 14378 | Values: 82.0 82.0 112.0 82.0 82.0 81.0 110.0 83.0 82.0 105.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:56:14 INFO - PROCESS | 14378 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:56:14 INFO - PROCESS | 14378 | Values: 146.0 148.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 146.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:56:14 INFO - PROCESS | 14378 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 14:56:14 INFO - PROCESS | 14378 | Values: 49.0 49.0 50.0 49.0 49.0 49.0 50.0 49.0 49.0 51.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:1.06 (1.8%) stddev-sans-first:0.73 14:56:14 INFO - PROCESS | 14378 | Values: 57.0 60.0 59.0 61.0 59.0 59.0 59.0 60.0 60.0 59.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:2.50 (3.3%) stddev-sans-first:2.47 14:56:14 INFO - PROCESS | 14378 | Values: 72.0 76.0 76.0 78.0 73.0 74.0 73.0 79.0 73.0 72.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:124.00 stddev:13.81 (11.1%) stddev-sans-first:14.59 14:56:14 INFO - PROCESS | 14378 | Values: 130.0 138.0 128.0 119.0 118.0 118.0 115.0 120.0 160.0 118.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.00 stddev:1.84 (1.2%) stddev-sans-first:1.94 14:56:14 INFO - PROCESS | 14378 | Values: 153.0 152.0 150.0 154.0 152.0 155.0 153.0 155.0 151.0 150.0 14:56:14 INFO - PROCESS | 14378 | 14:56:14 INFO - PROCESS | 14378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:2.17 (3.4%) stddev-sans-first:2.22 14:56:14 INFO - PROCESS | 14378 | Values: 61.0 63.0 63.0 62.0 66.0 63.0 59.0 66.0 61.0 62.0 14:56:14 INFO - PROCESS | 14378 | -------- Summary: end -------- 14:56:14 INFO - PROCESS | 14378 | 14:56:15 INFO - TEST-INFO | 14378: exit 0 14:56:15 INFO - TEST-OK | kraken | took 60156ms 14:56:15 INFO - SUITE-END | took 1174s 14:56:15 INFO - Completed test suite (00:19:34) 14:56:15 INFO - javascript benchmark 14:56:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.827089510077, 3167.8732850685965, 3197.28061186233, 3226.8547915343806, 3230.1117192771985, 5587.385387607365, 5653.943460565393, 5665.1785491103865, 5680.545556355492, 5687.488126068653, 5680.147977803332, 5754.769809207637, 5758.510526605243, 5765.740541675625, 5801.970990145054, 5146.948530514694, 5175.611829112813, 5177.430482646906, 5209.947900521003, 5251.973740131294, 5084.593232541388, 5236.397814251352, 5250.579953603703, 5253.921191182136, 5290.761915713783, 5056.988602279541, 5075.162598171298, 5090.745462726867, 5098.949010509903, 5163.870903227412, 5161.535461808437, 5171.095058364809, 5239.816606418795, 5242.135047717122, 5276.287701160332, 4926.75366231687, 5068.493150684939, 5132.358455193101, 5194.194899790538, 5213.9217911730975, 5507.752151153208, 5544.944550554524, 5546.972265138648, 5574.163875418679, 5594.0769772987405, 5989.610675306091, 5998.25021872266, 6115.5413343998935, 6115.724792384309, 6117.480014198798, 5962.403759624046, 6113.23584551931, 6123.418275263887, 6131.877362452726, 6132.264128304588, 5594.720263986825, 5597.916031259534, 5625.437456254383, 5647.068233741386, 5676.375598684142, 6222.471089957314, 6237.220347456568, 6248.656323902138, 6248.781292654735, 6255.093011513305, 5841.532677385799, 5991.910121348184, 5994.940050599525, 6003.459688627957, 6013.729382177725, 5990.041593345044, 6026.276846778414, 6086.056661217518, 6086.2087928569, 6092.086187071975, 6052.394760523913, 6057.666828324484, 6059.939400605937, 6064.181335519736, 6070.605410648293, 5969.194158788508, 6009.06859436788, 6028.698565071729, 6064.969675151596, 6133.172021777003, 4680.508546602626, 4683.578477937002, 4684.039771846831, 4684.227102528044, 4709.788059537329, 4149.647279981175, 4161.875143745692, 4171.5828417158045, 4172.311568591209, 4197.538270790211, 5646.520045796071, 5687.829365119053, 5705.828825135252, 5745.482906538432, 5753.798617048383, 6111.379037751179, 6115.635867915819, 6127.252959893121, 6133.51829027926, 6134.038624681888, 5774.855628609234, 5777.277840269966, 5787.39232380594, 5789.0, 5802.47777700009, 5120.385553733576, 5197.558207552401, 5211.843644690665, 5286.920696189561, 5291.444398338196, 6178.505719542426, 6300.527460440394, 6301.905471417841, 6302.212223472066, 6307.180066591405, 6075.726592303446, 6079.148919151411, 6086.360932102066, 6094.695265236809, 6096.5732398733435, 5999.790007349722, 6134.938650613437, 6258.43674069336, 6273.404026617464, 6284.120223168668, 5936.5844390892225, 5958.433948774859, 5970.671613061323, 6020.518358531394, 6034.547408944434, 6116.602420842631, 6122.877542449215, 6123.479504242189, 6128.050152226412, 6130.356312587114, 5720.0, 5983.700814959322, 5997.340292567901, 6006.48944839676, 6006.48944839676, 5809.215755873072, 5812.0, 5834.066549352084, 5865.501432378295, 5964.552658550713, 5817.621854579439, 5856.882862342644, 5860.0330945395235, 5866.0, 5876.823695289148, 5957.374475680164, 5967.254093238345, 5969.432903874125, 5971.253593300838, 5971.402859714168, 5617.708166853151, 5719.170720245458, 5773.278340207474, 5801.419858014334, 5836.883262334644], "value": 5588.319080862834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.8863371642528, 631.8325643704418, 642.1202951955821, 649.8472858878163, 654.3325807676167, 33321.33357332855, 44706.32940505891, 45464.318035229495, 45697.0, 45712.999999999956, 45931.0, 46310.7684461578, 46347.0, 46388.76805615976, 46391.0721785565, 8320.62557184925, 9199.999999999984, 9350.205232555207, 9351.532423378838, 9382.765430864249, 8365.874511882326, 8639.568021598927, 8650.87023694645, 10803.351798892092, 11015.394153321564, 11205.943970280137, 11258.0, 11259.718507037307, 11267.380294083821, 11284.0, 11108.222424430292, 11170.609028683957, 11178.27341222822, 11178.329300242012, 11181.273217240854, 10879.075278601329, 10928.071113955324, 11014.50434730439, 11017.889821101766, 11023.779524409547, 44650.33024504635, 44977.325340119925, 45008.0, 45014.0, 45081.54918450839, 3844.5386553613466, 3916.549596796348, 4032.334664780308, 4088.2845502037026, 4372.519022907478, 33789.6621033789, 33821.15447113817, 33943.830280848684, 34303.656963430294, 34561.827190863885, 4507.729536227836, 4576.771161441915, 4656.65075119364, 4657.976710116428, 4780.402449693788, 254422.0, 254781.0, 255541.0, 255569.0, 256204.0, 59979.0, 60104.0, 60137.69931150404, 60193.39806601878, 60239.39760602426, 39903.201935961115, 40729.59270407317, 41046.589534104874, 43321.78339108284, 43341.783291083346, 19391.4182574523, 19540.0, 19552.804471955384, 19569.315073972342, 19580.21679132819, 15061.246937653073, 15118.244087795567, 15141.0, 15161.469348572968, 15163.393464261306, 18349.0, 18797.718034229496, 19807.900960495106, 20369.185232590826, 20591.794082058987, 7445.25547445262, 7468.925310746931, 7620.847583048308, 7729.458937874408, 7746.92253077462, 987.7678745494803, 1010.1767059846349, 1083.5774048121239, 1119.8600174978128, 1133.5465813674432, 34367.0, 35059.824700876336, 35073.29853402918, 35109.29781404409, 35298.29403411917, 1187.8158885372782, 1229.8647148813623, 1242.6520574239228, 1264.0772236267576, 1280.9295488748207, 17370.565735856453, 18117.09414529268, 18435.72346414805, 18445.90777046133, 18518.81481185198, 594282.0, 598137.0, 598634.0, 602986.0, 603323.0, 61851.38148618546, 62674.686626566574, 62794.37205627885, 62797.68601156965, 62920.68539657273, 1333.7865941449322, 1387.1191793211383, 1390.1520072755611, 1462.5831637983335, 1476.047949072842, 32783.836080820394, 35402.82298588491, 35665.28669426545, 37614.24771504609, 37784.43323350097, 56360.436395635516, 57085.42914570801, 57120.428795713175, 57162.7141864288, 57211.713941430025, 526645.0, 528182.0, 528884.0, 528911.0, 531247.0, 30974.690253097182, 31864.044078677678, 32141.1964700875, 32250.193745156557, 32300.67699322977, 49213.94259398955, 49416.25875611941, 49420.258696118864, 49533.257001145736, 50399.24401134059, 41715.0, 42072.789636051624, 42449.0, 43010.0, 43207.567924321615, 40560.59439405686, 40922.38616420697, 42218.0, 42451.3632295522, 42929.35605965851, 40868.59131408648, 41973.029739127975, 42034.78982605068, 42386.152276954905, 42949.0, 34755.652443476254, 37125.628743712216, 37169.44245836369, 37706.8114659425, 38188.2362352757, 28790.0, 28950.565741514314, 29147.417051658424, 29148.708512915447, 29259.41481170407], "value": 21369.85923687268, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.9563348031718, 409.5842719639566, 432.59552318582126, 434.2986077484862, 434.884755539782, 14962.551123466299, 19806.7028994565, 20427.285045023425, 20447.97760111992, 21294.254701085465, 20737.0, 20903.37289881302, 20968.26611068613, 20970.161193552238, 21308.36074917751, 5915.645061296314, 5970.850728731784, 6132.2028136342215, 6170.2904166021035, 6182.659953702545, 5987.1019347097845, 6081.0, 6103.45068943795, 6106.084087386883, 6115.388461153893, 5950.404959504037, 6140.1096840958035, 6211.192544969148, 6316.873662526747, 6319.90520142196, 5910.0, 6032.306284777219, 6282.465990390822, 6293.276273228592, 6303.432691057827, 5880.9411905880825, 5909.674967876765, 5911.113333000041, 5912.408759124096, 5914.083317085859, 14148.292585370691, 15385.46150884725, 23184.60892346448, 24021.879890600434, 24898.751012489825, 2347.190219374313, 2428.138011006085, 2562.5899856022947, 2709.7425744554234, 2944.514155164395, 10866.130709543218, 11097.3896435696, 11311.717207069807, 11406.71483212918, 11510.30938143714, 1930.7296978423033, 1945.873518221311, 1978.2581531925528, 1991.7294284515663, 2100.579884023186, 78564.0, 85037.29925401519, 89461.10538894658, 89623.0, 92401.53799231027, 11396.088312934946, 11712.88287117135, 11773.411329433495, 11954.701132471584, 11986.76026479483, 17119.400820971205, 17130.571735706708, 17150.57123571896, 17163.570910727332, 17180.312787488612, 9160.404573702688, 9201.585928633227, 9262.768430789285, 9328.533573321307, 9405.247580193569, 8763.474191548528, 8892.555372231363, 8934.731958041139, 9150.496722680184, 9189.448633082036, 5101.489851014943, 5148.871278218, 5165.741712914414, 5251.0, 5291.656042357235, 1973.5855470351387, 2021.6563184258712, 2054.589082183569, 2060.330392622404, 2144.7507026854328, 958.9136977671903, 1013.5135135135029, 1016.8118898003893, 1025.487256371814, 1046.9633562825265, 19427.90286048589, 20223.19107235694, 20658.58682826335, 20994.005569470875, 21198.15207391718, 1005.818952588541, 1043.1811028342715, 1075.499892549968, 1113.6046703420332, 1119.630521927762, 11045.28205666629, 11324.263922844988, 11385.37380444067, 11394.25937314072, 11551.653450396501, 538359.0, 558263.0, 559305.0, 561320.0, 575014.0, 98682.5065874666, 100726.49636751915, 101409.0, 103477.96522034834, 104524.0, 1077.946102694862, 1103.1395511501041, 1114.793763153819, 1135.03522006294, 1138.4250953268547, 17780.733289000418, 18004.459866204033, 18044.90977545104, 18329.633407331512, 18443.170057347183, 41144.1771164581, 44462.77768611136, 45132.09735805331, 46713.29930050984, 46970.53029469798, 59074.0, 60846.39153608407, 61842.690786545776, 62086.37913620806, 62772.37227627848, 8793.472391656522, 9071.146936389001, 9074.183323500916, 9131.863022054542, 9363.625454981724, 10124.848127278245, 12970.02724795663, 13427.395767190304, 13453.46186152543, 13775.517856875362, 12046.518139274682, 12237.877621223673, 12516.687082822638, 12529.0, 12654.0, 5663.150527420755, 10209.84685229737, 11484.540618375171, 12076.0, 12373.814392784296, 11331.490082946451, 12584.874151258371, 12613.87386126127, 12674.493020279086, 12854.67863303425, 9327.626894924128, 9436.85844712316, 9487.905120948702, 9615.423074615546, 9619.759506012406, 11775.646730598095, 12316.384180790745, 12358.62924112278, 12433.502659893504, 12702.110852240254], "value": 9782.939990015499, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.8379836318827, 1551.8758499320052, 1590.6580085281664, 1731.9047452390114, 1814.6915024445834, 7879.527228366302, 8174.754757357281, 8346.207110324516, 8421.999999999985, 8704.73885783426, 8514.91485085149, 8607.612657430414, 8618.569071546413, 8620.65517379304, 8625.956870215656, 2386.284114765572, 2412.7225369082516, 2413.78275955164, 2419.1049311754678, 2424.4181396464896, 2367.917122900699, 2418.830681852271, 2430.878456077198, 2435.841670291434, 2436.5370579589908, 2401.351635058542, 2405.747396523366, 2419.3830573203895, 2431.6352547117986, 2433.85396876188, 2331.895064722083, 2348.248560460653, 2353.95292094158, 2366.1954935322074, 2382.7617238276207, 2370.9051637934463, 2410.7227668818136, 2415.1546958564536, 2417.552752740731, 2419.008206635271, 9120.726378208665, 9209.125133112344, 9213.90786092144, 9215.354925155241, 9215.400998935114, 5447.210154527611, 5587.916181257285, 5598.440155984369, 5695.943040569583, 5716.456936591017, 3500.194955160302, 3539.823008849573, 3590.838412271428, 3642.271545690846, 3662.9084272893124, 1141.2923987127951, 1148.62095508482, 1157.1841851494676, 1169.222467059413, 1187.0859438232599, 12638.178518396275, 12685.36573171347, 12702.047346449146, 12715.0, 12725.681857953532, 4519.54804519552, 4629.8148074077335, 4708.128996135726, 4746.762661866893, 4749.311349854252, 10142.0, 10147.7463063424, 10150.086492215736, 10153.441560714084, 10173.08442240202, 5453.182022696627, 5471.72641367938, 5479.013777520085, 5503.091989821714, 5518.668879867221, 4416.315471101984, 4591.334256532784, 4962.578180854595, 5105.310783044241, 5148.2020286855595, 4050.8177132029127, 4090.406891000788, 4137.213929353474, 4202.936955945664, 4222.345536441795, 1221.1757063981777, 1222.9388530573435, 1267.2016629523525, 1279.718461938372, 1298.7012987012852, 916.5417291354323, 993.2171751705706, 1011.22135955314, 1033.0908800255727, 1050.810854046279, 6012.969935150296, 6274.435300822948, 6332.0, 6358.1416508771645, 6447.903856344433, 462.25807578836157, 471.9528047195253, 472.06766635893837, 477.85664300709647, 494.868859752166, 4305.095929854703, 4317.201317756225, 4393.560643935645, 4424.491183513873, 4534.6599005074095, 10811.567537298577, 10975.341479511255, 11046.281991670516, 11051.17116216287, 11052.0, 10853.457327133612, 10940.617078402218, 10981.17641176915, 11005.119590432747, 11013.559457621606, 8384.53885036329, 8501.319894408432, 8516.616752246164, 8521.82956340882, 8527.10465401124, 6034.939650603614, 6073.952830890488, 6112.847178820565, 6154.476869466145, 6164.0, 10021.74945626336, 10214.744631384276, 10300.072993430627, 10319.277650564389, 10348.793024139626, 10406.70692150325, 10463.529141188512, 10573.947130264607, 10632.787344252916, 10667.786644267226, 7628.275313845176, 7628.275313845176, 7629.3133617974645, 7684.538927664358, 7691.807704807425, 8851.69019084329, 8900.510471924106, 8924.68763593271, 8929.0, 8935.195832375117, 8059.234372734581, 8073.515589064675, 8092.676292948451, 8173.591320434073, 8262.793430164294, 7894.328982036591, 7934.20657934202, 7971.242731940456, 7991.480553763987, 8000.119986801331, 6992.79021629352, 7097.787066388017, 7232.385247254042, 7379.262073792578, 7392.223816499405, 5357.276767636475, 5362.356517217959, 5385.0, 5489.286392768914, 5491.258680078138, 5549.472800083986, 5574.219609254626, 5599.916001260066, 5665.886682266414, 5689.772409103755], "value": 4687.759336981505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.52639173919334, 352.35870715298154, 356.26609185078723, 362.5196614485807, 364.1933118143312, 5462.945370546293, 5479.890402191959, 5517.36550296716, 5517.668939863611, 5521.641093328931, 5416.593755468336, 5439.4832490913395, 5458.890822183564, 5461.2354270402175, 5465.644733092357, 3749.568799588041, 4043.3934909763475, 4227.302495088306, 4332.566743325674, 4340.262155433568, 4333.58830911063, 4341.435613370258, 4343.631755996867, 4344.391785150082, 4351.804168812411, 4262.893427664302, 4306.375575541545, 4308.181445525356, 4311.28863737483, 4345.69580129391, 4120.64018873771, 4137.234611596849, 4200.432941552882, 4316.64025831862, 4353.956460435386, 3836.443715661241, 3837.846486140551, 3873.360895452275, 3874.1476875087437, 3887.0, 5303.867403314948, 5319.5478384337375, 5326.893462130774, 5341.759620817073, 5370.140777475585, 4823.879403014917, 4941.332920055783, 4974.37820272466, 4990.675606085593, 4991.376077990251, 5676.545876329925, 5684.147377893308, 5707.600467967244, 5742.511886489653, 5766.241296404595, 4279.700420970534, 4281.379200016011, 4285.528591854893, 4286.549912259199, 4291.828326866922, 5669.971650141764, 5751.367349591542, 5819.6508209507565, 5952.571382868124, 5957.6127551709, 4243.6605071594195, 4372.366006928977, 4388.341748737715, 4389.407429996973, 4394.12117576486, 4429.82280708768, 4433.135538569948, 4436.3123715824095, 4443.911121777546, 4447.310666846644, 4880.829170978998, 4964.478729733398, 4983.875403114951, 4996.850094497171, 5020.648554601216, 5677.120046392815, 5757.9424205757405, 5768.653880767168, 5780.67044579749, 5784.681842498619, 1520.3082597418147, 1539.2611546457763, 1541.3295216580823, 1542.0362273579012, 1546.4432804190483, 957.5882370580578, 994.4033579852176, 1007.7833265847878, 1008.5663164839043, 1011.4942528735633, 4886.0, 4893.877653058631, 4894.975525122423, 4896.755162241873, 4930.876728081755, 5182.352205974254, 5210.687358758487, 5215.1838007475535, 5215.7913683453, 5221.947780522146, 4532.886677833015, 4780.872511732316, 4891.508090032503, 4904.705717656952, 4906.435759887588, 2736.9726302737117, 2744.3687951771203, 2748.8900443982416, 2768.363276446388, 2782.791290653209, 5324.866878327995, 5337.973310133424, 5353.250544923714, 5355.571554275649, 5367.785288588413, 5095.082885080721, 5164.664296820694, 5220.504052115043, 5233.39815921174, 5297.443768404339, 5268.235141227655, 5275.973620131875, 5280.894382112337, 5301.761420736076, 5313.442088580643, 5166.4316925137455, 5176.343570057696, 5180.870478237924, 5195.792168313225, 5210.847437300378, 4950.925736113889, 5151.948480515147, 5188.247704082963, 5193.818216362409, 5215.774293041057, 5366.060939335679, 5809.680467574324, 5939.940600594112, 5940.554458415722, 6119.418655227746, 4340.153670034313, 4367.934480982724, 4388.407564978687, 4396.560343965578, 4401.735895846259, 5732.757759258202, 5905.99598068338, 5908.7045647718305, 5921.542559837619, 5937.664025594207, 5650.208970744017, 5743.195952566728, 5746.482816546363, 5796.782675638163, 5806.796762113306, 5762.213713748752, 5772.39389864075, 5779.757352169304, 5780.768769249183, 5841.883162336814, 5567.805126820542, 5772.383732554891, 5780.653160810365, 5805.419458054161, 5821.738021789114, 5842.1820945068575, 5842.7662893485485, 5846.327672317738, 5885.911711324248, 5891.499222565958, 5547.639403438763, 5708.743106560131, 5718.456746609066, 5738.0777439558215, 5738.942610573841], "value": 4282.099496554054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.9486533375331, 791.3550456378051, 804.5988443215608, 888.5646033443606, 917.7889085510333, 15830.208489575518, 16850.66298674026, 16860.66278674426, 16872.915635421807, 16906.154692265398, 14699.0, 15221.771673424908, 15368.462103826369, 15391.84608153918, 15415.84584154158, 718.8777907755668, 736.2416710787898, 838.3460900497606, 854.786303424144, 858.159004175908, 838.5932822581043, 860.9096044915287, 867.1328671328671, 872.6771094694972, 875.2341701011615, 914.4833169259347, 916.294453270981, 916.6287653500343, 917.1882883647986, 917.2295271971543, 742.6658003898267, 759.3924860111944, 909.636145541782, 909.8453262945316, 909.9636014559443, 642.0369445831253, 656.7044829826597, 662.3872917551294, 663.6582160187507, 664.5348256220665, 16333.509994700178, 16369.59076023097, 16374.263158157792, 16374.590635234095, 16407.753883691756, 14786.40854365824, 15169.848301516953, 15549.144797036159, 15728.37086516538, 15933.123678197695, 13375.665608359772, 13634.93182534081, 13952.86047139536, 14163.150210987375, 14176.362063707158, 4578.702384345007, 4644.489106198315, 4674.69614475058, 4681.321208424793, 4796.784144713496, 67504.6624766873, 68609.31390686079, 70268.2973170272, 70713.2928670717, 83888.58055709743, 12175.573854915212, 12290.446929888176, 12323.137380383467, 12771.297578633264, 12992.090553661154, 22741.658875116886, 22769.430764230696, 22788.08847646109, 22799.31602051941, 22811.087556497885, 8961.59672814725, 8996.325275604357, 9020.954895225614, 9075.311720698255, 9379.108984646447, 5123.462036486189, 5171.3535808024, 5215.24378965048, 5263.078961181778, 5436.211749296409, 3642.2897534980953, 3781.1870447853844, 3783.0353259918543, 3784.129650180474, 3785.6971442284553, 652.0968458684661, 652.2531701202097, 652.3281020548842, 659.3406593406594, 667.1693741292122, 744.4342299852043, 766.7201471462987, 772.82997740497, 784.7802615267734, 804.5373910001772, 9743.561539730728, 9936.950315248378, 9986.950065249772, 10066.949665251774, 10780.730481738019, 753.6608526163249, 767.8349154931716, 770.2182284980637, 776.7630872583916, 798.9480683755653, 4636.976815115903, 4805.783739731721, 4813.302071199656, 4822.300766388924, 4943.110240156806, 78306.21693782989, 79369.0, 98353.0, 130721.0, 131434.0, 109221.45389273162, 110233.44883275533, 111386.0, 113432.0, 115291.0, 79087.0, 99104.0, 99243.50378248208, 100606.0, 101049.49475252724, 8725.781855453664, 9012.0, 9015.098490150933, 9026.684066057656, 9028.729138125867, 42486.78756606197, 55690.0, 60646.393536065836, 61447.0, 61628.691856540434, 54235.0, 70972.29027709864, 71208.0, 72061.0, 79468.0, 13604.523841665494, 13644.727105458034, 13781.242031688353, 14046.227457489937, 14086.295685215904, 14770.0, 14913.552593422215, 15581.688366232385, 15666.37334506607, 15920.363185472916, 11062.0, 14189.00730785721, 14907.0, 15007.174605396807, 15133.243337832844, 14723.484678036217, 15159.848401515843, 15171.848281517043, 15243.466478673638, 15452.150131742863, 13694.383752730952, 13990.16059036461, 14567.198804065878, 14574.781378279546, 15007.774883376977, 11412.942935285602, 11605.535778568763, 11958.58144964922, 11994.280343179436, 12142.696432589257, 11430.314181149157, 11680.0, 11762.353070580857, 11820.23168494045, 11997.220180688228], "value": 7987.975021592265, "unit": "score"}], "name": "dromaeo_css", "value": 7564.430383474519, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 110.0, 112.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 116.0, 175.0, 117.0, 118.0, 116.0, 119.0, 152.0, 122.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 160.0, 159.0, 162.0, 164.0, 162.0, 160.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 104.0, 75.0, 76.0, 81.0, 75.0, 104.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 82.0, 82.0, 81.0, 110.0, 83.0, 82.0, 105.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 49.0, 49.0, 49.0, 50.0, 49.0, 49.0, 51.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 59.0, 61.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 76.0, 78.0, 73.0, 74.0, 73.0, 79.0, 73.0, 72.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 128.0, 119.0, 118.0, 118.0, 115.0, 120.0, 160.0, 118.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 150.0, 154.0, 152.0, 155.0, 153.0, 155.0, 151.0, 150.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 62.0, 66.0, 63.0, 59.0, 66.0, 61.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1456.8, "alertThreshold": 2.0}]} 14:56:16 INFO - Return code: 0 14:56:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:56:16 INFO - # TBPL SUCCESS # 14:56:16 INFO - Running post-action listener: _resource_record_post_action 14:56:16 INFO - [mozharness: 2016-10-19 21:56:16.150476Z] Finished run-tests step (success) 14:56:16 INFO - Running post-run listener: _resource_record_post_run 14:56:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 1994752; Write bytes: 356524032; Read time: 52; Write time: 268132 14:56:16 INFO - TinderboxPrint: CPU usage
13.0% 14:56:16 INFO - TinderboxPrint: I/O read bytes / time
1,994,752 / 52 14:56:16 INFO - TinderboxPrint: I/O write bytes / time
356,524,032 / 268,132 14:56:16 INFO - TinderboxPrint: CPU idle
8,268.0 (87.0%) 14:56:16 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 14:56:16 INFO - TinderboxPrint: Swap in / out
0 / 0 14:56:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108171264; Read time: 0; Write time: 127256 14:56:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248352768; Read time: 12; Write time: 140876 14:56:16 INFO - Running post-run listener: _upload_blobber_files 14:56:16 INFO - Blob upload gear active. 14:56:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:56:16 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 14:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:56:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:56:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:56:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:56:17 INFO - (blobuploader) - INFO - Done attempting. 14:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:56:18 INFO - (blobuploader) - INFO - Done attempting. 14:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:56:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:56:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:56:24 INFO - (blobuploader) - INFO - Done attempting. 14:56:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:56:24 INFO - Return code: 0 14:56:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:56:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:56:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a966838aea6dfa928c44dc5c3cd3ef8f27e1398547c600cc16eb9424a69b8b6fe23d124dfc006111de89caff1f67ba008c644bc532880739bb8467d02585111d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8584a417478ee9edfef02586d57ce746ec2debb74531a15e390265433c1ab05caef1b7a53cc38ebd8257192f9c10e6c4eac8227669c44ed7ce32a74e4b21dd14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b06de550d7e814b373dc8b8c5c9a49de24ba1422224f91e34223cb1006fe8d6e828c7c35e547818d5d27ff621c06b3aff18496defcdc106b37175680c85cef"} 14:56:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:56:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:56:24 INFO - Contents: 14:56:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a966838aea6dfa928c44dc5c3cd3ef8f27e1398547c600cc16eb9424a69b8b6fe23d124dfc006111de89caff1f67ba008c644bc532880739bb8467d02585111d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8584a417478ee9edfef02586d57ce746ec2debb74531a15e390265433c1ab05caef1b7a53cc38ebd8257192f9c10e6c4eac8227669c44ed7ce32a74e4b21dd14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b06de550d7e814b373dc8b8c5c9a49de24ba1422224f91e34223cb1006fe8d6e828c7c35e547818d5d27ff621c06b3aff18496defcdc106b37175680c85cef"} 14:56:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:56:24 INFO - Copying logs to upload dir... 14:56:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:56:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.829173 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-19 14:56:24.010783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 14:56:24.014197) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a966838aea6dfa928c44dc5c3cd3ef8f27e1398547c600cc16eb9424a69b8b6fe23d124dfc006111de89caff1f67ba008c644bc532880739bb8467d02585111d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8584a417478ee9edfef02586d57ce746ec2debb74531a15e390265433c1ab05caef1b7a53cc38ebd8257192f9c10e6c4eac8227669c44ed7ce32a74e4b21dd14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b06de550d7e814b373dc8b8c5c9a49de24ba1422224f91e34223cb1006fe8d6e828c7c35e547818d5d27ff621c06b3aff18496defcdc106b37175680c85cef"} build_url:https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/V1ueEkPUT--zzCWv7hUCMQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a966838aea6dfa928c44dc5c3cd3ef8f27e1398547c600cc16eb9424a69b8b6fe23d124dfc006111de89caff1f67ba008c644bc532880739bb8467d02585111d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8584a417478ee9edfef02586d57ce746ec2debb74531a15e390265433c1ab05caef1b7a53cc38ebd8257192f9c10e6c4eac8227669c44ed7ce32a74e4b21dd14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b06de550d7e814b373dc8b8c5c9a49de24ba1422224f91e34223cb1006fe8d6e828c7c35e547818d5d27ff621c06b3aff18496defcdc106b37175680c85cef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 14:56:24.040180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:56:24.040541) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476910466.305072-1290770733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:56:24.124931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 14:56:24.125280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 14:56:24.125645) ========= ========= Total master_lag: 0.18 =========