builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1481126398.16 results: success (0) buildid: 20161207062538 builduid: b56b1ebfee5743d2bd842d23b787158f revision: 93266100e27057f116effff38f70d8563533097b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.162414) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.162826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.163140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.186085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.186358) ========= 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=3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 07:59:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-12-07 07:59:59 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082302 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.312643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.312972) ========= 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=3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019197 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.363724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.364081) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93266100e27057f116effff38f70d8563533097b --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 93266100e27057f116effff38f70d8563533097b --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=3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 07:59:59,905 truncating revision to first 12 chars 2016-12-07 07:59:59,905 Setting DEBUG logging. 2016-12-07 07:59:59,905 attempt 1/10 2016-12-07 07:59:59,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/93266100e270?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 08:00:00,199 unpacking tar archive at: mozilla-aurora-93266100e270/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.994131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.994438) ========= script_repo_revision: 93266100e27057f116effff38f70d8563533097b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.994845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.995120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:59.003006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-07 07:59:59.003276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:00 INFO - MultiFileLogger online at 20161207 08:00:00 in /builds/slave/test 08:00:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:00:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:00 INFO - {'append_to_log': False, 08:00:00 INFO - 'base_work_dir': '/builds/slave/test', 08:00:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:00:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:00 INFO - 'branch': 'Mozilla-Aurora', 08:00:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:00 INFO - 'config_files': ('talos/linux_config.py',), 08:00:00 INFO - 'default_actions': ('clobber', 08:00:00 INFO - 'read-buildbot-config', 08:00:00 INFO - 'download-and-extract', 08:00:00 INFO - 'populate-webroot', 08:00:00 INFO - 'create-virtualenv', 08:00:00 INFO - 'install', 08:00:00 INFO - 'run-tests'), 08:00:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:00 INFO - 'download_minidump_stackwalk': True, 08:00:00 INFO - 'download_symbols': 'ondemand', 08:00:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:00 INFO - 'installer_path': 'installer.exe', 08:00:00 INFO - 'log_level': 'info', 08:00:00 INFO - 'log_name': 'talos', 08:00:00 INFO - 'log_to_console': True, 08:00:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:00 INFO - 'opt_config_files': (), 08:00:00 INFO - 'pip_index': False, 08:00:00 INFO - 'sps_profile': False, 08:00:00 INFO - 'sps_profile_interval': 0, 08:00:00 INFO - 'suite': 'dromaeojs-e10s', 08:00:00 INFO - 'system_bits': '32', 08:00:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:00 INFO - 'title': 'talos-linux64-ix-059', 08:00:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:00 INFO - 'use_talos_json': True, 08:00:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:00 INFO - 'work_dir': 'build'} 08:00:00 INFO - [mozharness: 2016-12-07 16:00:00.636626Z] Running clobber step. 08:00:00 INFO - Running pre-action listener: _resource_record_pre_action 08:00:00 INFO - Running main action method: clobber 08:00:00 INFO - rmtree: /builds/slave/test/build 08:00:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:01 INFO - Running post-action listener: _resource_record_post_action 08:00:01 INFO - [mozharness: 2016-12-07 16:00:01.098113Z] Finished clobber step (success) 08:00:01 INFO - [mozharness: 2016-12-07 16:00:01.098214Z] Running read-buildbot-config step. 08:00:01 INFO - Running pre-action listener: _resource_record_pre_action 08:00:01 INFO - Running main action method: read_buildbot_config 08:00:01 INFO - Using buildbot properties: 08:00:01 INFO - { 08:00:01 INFO - "project": "", 08:00:01 INFO - "product": "firefox", 08:00:01 INFO - "script_repo_revision": "production", 08:00:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:00:01 INFO - "repository": "", 08:00:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:00:01 INFO - "buildid": "20161207062538", 08:00:01 INFO - "pgo_build": "True", 08:00:01 INFO - "basedir": "/builds/slave/test", 08:00:01 INFO - "buildnumber": 700, 08:00:01 INFO - "slavename": "talos-linux64-ix-059", 08:00:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:00:01 INFO - "platform": "ubuntu64_hw", 08:00:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:00:01 INFO - "branch": "mozilla-aurora", 08:00:01 INFO - "repo_path": "releases/mozilla-aurora", 08:00:01 INFO - "revision": "93266100e27057f116effff38f70d8563533097b", 08:00:01 INFO - "stage_platform": "linux64-pgo", 08:00:01 INFO - "builduid": "b56b1ebfee5743d2bd842d23b787158f", 08:00:01 INFO - "slavebuilddir": "test" 08:00:01 INFO - } 08:00:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:00:01 INFO - Running post-action listener: _resource_record_post_action 08:00:01 INFO - [mozharness: 2016-12-07 16:00:01.100647Z] Finished read-buildbot-config step (success) 08:00:01 INFO - [mozharness: 2016-12-07 16:00:01.100736Z] Running download-and-extract step. 08:00:01 INFO - Running pre-action listener: _resource_record_pre_action 08:00:01 INFO - Running main action method: download_and_extract 08:00:01 INFO - mkdir: /builds/slave/test/build/tests 08:00: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')]} 08:00:01 INFO - trying https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - Downloading https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:01 INFO - Downloaded 1361 bytes. 08:00:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:00:01 INFO - Using the following test package requirements: 08:00:01 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:00:01 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:01 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:00:01 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'jsshell-linux-x86_64.zip'], 08:00:01 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:01 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:00:01 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:00:01 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:00:01 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:01 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:00:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:01 INFO - Fetch https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:00:02 INFO - Http code: 200 08:00:02 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 08:00:02 INFO - x-amz-cf-id: QX2IjzGieu9Y095CTgGdzNdUTEHIjTrCXCtH22_YK6buhNyCOgOraQ== 08:00:02 INFO - x-amz-version-id: M9jX77fv.BTXxe08riFk04YAw9vbPURj 08:00:02 INFO - Expected file size: 21954855 08:00:02 INFO - Obtained file size: 21954855 08:00:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:06 INFO - Fetch https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:00:07 INFO - Http code: 200 08:00:07 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:00:07 INFO - x-amz-cf-id: rTASGTyO_G7rbY_JpdFnkvAwQTRTmlu1Io7VKCzgK4SF0CTIQ-GcpA== 08:00:07 INFO - x-amz-version-id: M9jX77fv.BTXxe08riFk04YAw9vbPURj 08:00:07 INFO - Expected file size: 21954855 08:00:07 INFO - Obtained file size: 21954855 08:00:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:00:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:11 INFO - Fetch https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:00:12 INFO - Http code: 200 08:00:12 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 08:00:12 INFO - x-amz-cf-id: F1ekRLn-0JkDOr3MFIJFUN1E62qppjBFOUi4kFCNl5s4oufWuBuSCA== 08:00:12 INFO - x-amz-version-id: 6VVY2a0V.8czFybp_ekT3z9bal1.VsgU 08:00:12 INFO - Expected file size: 14409038 08:00:12 INFO - Obtained file size: 14409038 08:00:12 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')]} 08:00:12 INFO - trying https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - Downloading https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:13 INFO - Downloaded 64015339 bytes. 08:00:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:13 INFO - mkdir: /builds/slave/test/properties 08:00:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:13 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:13 INFO - Contents: 08:00:13 INFO - build_url:https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:14 INFO - Running post-action listener: _resource_record_post_action 08:00:14 INFO - Running post-action listener: set_extra_try_arguments 08:00:14 INFO - [mozharness: 2016-12-07 16:00:14.507481Z] Finished download-and-extract step (success) 08:00:14 INFO - [mozharness: 2016-12-07 16:00:14.507708Z] Running populate-webroot step. 08:00:14 INFO - Running pre-action listener: _resource_record_pre_action 08:00:14 INFO - Running main action method: populate_webroot 08:00:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:14 INFO - '--tppagecycles', 08:00:14 INFO - '7'], 08:00:14 INFO - 'tests': ['tsvgm']}}, 08:00:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['damp', 'tps']}, 08:00:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'tests': ['damp', 'tps']}, 08:00:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['dromaeo_dom']}, 08:00:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['basic_compositor_video']}, 08:00:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:00:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['a11yr', 08:00:14 INFO - 'ts_paint', 08:00:14 INFO - 'tpaint', 08:00:14 INFO - 'sessionrestore', 08:00:14 INFO - 'sessionrestore_no_auto_restore', 08:00:14 INFO - 'tabpaint']}, 08:00:14 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:14 INFO - 'ts_paint', 08:00:14 INFO - 'tpaint', 08:00:14 INFO - 'sessionrestore', 08:00:14 INFO - 'sessionrestore_no_auto_restore', 08:00:14 INFO - 'tabpaint']}, 08:00:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:14 INFO - 'ts_paint', 08:00:14 INFO - 'tpaint', 08:00:14 INFO - 'sessionrestore', 08:00:14 INFO - 'sessionrestore_no_auto_restore', 08:00:14 INFO - 'tabpaint']}, 08:00:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:14 INFO - 'ts_paint', 08:00:14 INFO - 'tpaint', 08:00:14 INFO - 'sessionrestore', 08:00:14 INFO - 'sessionrestore_no_auto_restore', 08:00:14 INFO - 'tabpaint']}, 08:00:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['a11yr', 08:00:14 INFO - 'ts_paint', 08:00:14 INFO - 'tpaint', 08:00:14 INFO - 'sessionrestore', 08:00:14 INFO - 'sessionrestore_no_auto_restore', 08:00:14 INFO - 'tabpaint']}, 08:00:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['a11yr', 08:00:14 INFO - 'ts_paint', 08:00:14 INFO - 'tpaint', 08:00:14 INFO - 'sessionrestore', 08:00:14 INFO - 'sessionrestore_no_auto_restore', 08:00:14 INFO - 'tabpaint']}, 08:00:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['tsvgx', 08:00:14 INFO - 'tsvgr_opacity', 08:00:14 INFO - 'tart', 08:00:14 INFO - 'tscrollx', 08:00:14 INFO - 'cart']}, 08:00:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:14 INFO - 'tsvgr_opacity', 08:00:14 INFO - 'tart', 08:00:14 INFO - 'tscrollx', 08:00:14 INFO - 'cart']}, 08:00:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'talos_options': ['--disable-e10s'], 08:00:14 INFO - 'tests': ['tp5o']}, 08:00:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'tests': ['tp5o']}, 08:00:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'talos_options': ['--disable-e10s', 08:00:14 INFO - '--xperf_path', 08:00:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:14 INFO - 'tests': ['tp5n']}, 08:00:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:14 INFO - 'talos_options': ['--xperf_path', 08:00:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:14 INFO - 'tests': ['tp5n']}}, 08:00:14 INFO - 'talos.zip': {'path': '', 08:00:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:14 INFO - Running post-action listener: _resource_record_post_action 08:00:14 INFO - [mozharness: 2016-12-07 16:00:14.526532Z] Finished populate-webroot step (success) 08:00:14 INFO - [mozharness: 2016-12-07 16:00:14.526620Z] Running create-virtualenv step. 08:00:14 INFO - Running pre-action listener: _resource_record_pre_action 08:00:14 INFO - Running main action method: create_virtualenv 08:00:14 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:14 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 08:00:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:14 INFO - Using real prefix '/usr' 08:00:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:17 INFO - Installing pip.................done. 08:00:17 INFO - Return code: 0 08:00:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:00:17 INFO - Reading from file tmpfile_stdout 08:00:17 INFO - Output received: 08:00:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:00:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:17 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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:17 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 08:00:17 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 08:00:17 INFO - Using env: {'DISPLAY': ':0', 08:00:17 INFO - 'HOME': '/home/cltbld', 08:00:17 INFO - 'LANG': 'en_US.UTF-8', 08:00:17 INFO - 'LANGUAGE': 'en_US:en', 08:00:17 INFO - 'LOGNAME': 'cltbld', 08:00:17 INFO - 'MAIL': '/var/mail/cltbld', 08:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:17 INFO - 'MOZ_NO_REMOTE': '1', 08:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:17 INFO - 'NO_EM_RESTART': '1', 08:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:17 INFO - 'PWD': '/builds/slave/test', 08:00:17 INFO - 'SHELL': '/bin/bash', 08:00:17 INFO - 'SHLVL': '1', 08:00:17 INFO - 'TERM': 'linux', 08:00:17 INFO - 'TMOUT': '86400', 08:00:17 INFO - 'USER': 'cltbld', 08:00:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:17 INFO - '_': '/tools/buildbot/bin/python'} 08:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:17 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 08:00:17 INFO - Cleaning up... 08:00:17 INFO - Return code: 0 08:00:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:17 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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:17 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 08:00:17 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 08:00:17 INFO - Using env: {'DISPLAY': ':0', 08:00:17 INFO - 'HOME': '/home/cltbld', 08:00:17 INFO - 'LANG': 'en_US.UTF-8', 08:00:17 INFO - 'LANGUAGE': 'en_US:en', 08:00:17 INFO - 'LOGNAME': 'cltbld', 08:00:17 INFO - 'MAIL': '/var/mail/cltbld', 08:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:17 INFO - 'MOZ_NO_REMOTE': '1', 08:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:17 INFO - 'NO_EM_RESTART': '1', 08:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:17 INFO - 'PWD': '/builds/slave/test', 08:00:17 INFO - 'SHELL': '/bin/bash', 08:00:17 INFO - 'SHLVL': '1', 08:00:17 INFO - 'TERM': 'linux', 08:00:17 INFO - 'TMOUT': '86400', 08:00:17 INFO - 'USER': 'cltbld', 08:00:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:17 INFO - '_': '/tools/buildbot/bin/python'} 08:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:17 INFO - Downloading/unpacking psutil>=3.1.1 08:00:17 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 08:00:17 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 08:00:17 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 08:00:17 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 08:00:17 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 08:00:17 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 08:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:19 INFO - Installing collected packages: psutil 08:00:19 INFO - Running setup.py install for psutil 08:00:19 INFO - building 'psutil._psutil_linux' extension 08:00:19 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 08:00:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:00:20 INFO - building 'psutil._psutil_posix' extension 08:00:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:00:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:00:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:20 INFO - Successfully installed psutil 08:00:20 INFO - Cleaning up... 08:00:20 INFO - Return code: 0 08:00:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:00: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')]} 08:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:20 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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:20 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 08:00:20 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 08:00:20 INFO - Using env: {'DISPLAY': ':0', 08:00:20 INFO - 'HOME': '/home/cltbld', 08:00:20 INFO - 'LANG': 'en_US.UTF-8', 08:00:20 INFO - 'LANGUAGE': 'en_US:en', 08:00:20 INFO - 'LOGNAME': 'cltbld', 08:00:20 INFO - 'MAIL': '/var/mail/cltbld', 08:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:20 INFO - 'MOZ_NO_REMOTE': '1', 08:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:20 INFO - 'NO_EM_RESTART': '1', 08:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:20 INFO - 'PWD': '/builds/slave/test', 08:00:20 INFO - 'SHELL': '/bin/bash', 08:00:20 INFO - 'SHLVL': '1', 08:00:20 INFO - 'TERM': 'linux', 08:00:20 INFO - 'TMOUT': '86400', 08:00:20 INFO - 'USER': 'cltbld', 08:00:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:20 INFO - '_': '/tools/buildbot/bin/python'} 08:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:00:20 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 08:00:20 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 08:00:20 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 08:00:20 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 08:00:20 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 08:00:20 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 08:00:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:00:22 INFO - Installing collected packages: mozsystemmonitor 08:00:22 INFO - Running setup.py install for mozsystemmonitor 08:00:22 INFO - Successfully installed mozsystemmonitor 08:00:22 INFO - Cleaning up... 08:00:22 INFO - Return code: 0 08:00:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:00:22 INFO - Using env: {'DISPLAY': ':0', 08:00:22 INFO - 'HOME': '/home/cltbld', 08:00:22 INFO - 'LANG': 'en_US.UTF-8', 08:00:22 INFO - 'LANGUAGE': 'en_US:en', 08:00:22 INFO - 'LOGNAME': 'cltbld', 08:00:22 INFO - 'MAIL': '/var/mail/cltbld', 08:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:22 INFO - 'MOZ_NO_REMOTE': '1', 08:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:22 INFO - 'NO_EM_RESTART': '1', 08:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:22 INFO - 'PWD': '/builds/slave/test', 08:00:22 INFO - 'SHELL': '/bin/bash', 08:00:22 INFO - 'SHLVL': '1', 08:00:22 INFO - 'TERM': 'linux', 08:00:22 INFO - 'TMOUT': '86400', 08:00:22 INFO - 'USER': 'cltbld', 08:00:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:22 INFO - '_': '/tools/buildbot/bin/python'} 08:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:25 INFO - warning: no files found matching '*.txt' 08:00:25 INFO - no previously-included directories found matching 'build' 08:00:25 INFO - no previously-included directories found matching 'dist' 08:00:25 INFO - no previously-included directories found matching '.git*' 08:00:25 INFO - Installing collected packages: jsonschema, functools32 08:00:25 INFO - Running setup.py install for functools32 08:00:25 INFO - warning: no files found matching '*.txt' 08:00:25 INFO - no previously-included directories found matching 'build' 08:00:25 INFO - no previously-included directories found matching 'dist' 08:00:25 INFO - no previously-included directories found matching '.git*' 08:00:25 INFO - Successfully installed jsonschema functools32 08:00:25 INFO - Cleaning up... 08:00:25 INFO - Return code: 0 08:00:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:00:25 INFO - Using env: {'DISPLAY': ':0', 08:00:25 INFO - 'HOME': '/home/cltbld', 08:00:25 INFO - 'LANG': 'en_US.UTF-8', 08:00:25 INFO - 'LANGUAGE': 'en_US:en', 08:00:25 INFO - 'LOGNAME': 'cltbld', 08:00:25 INFO - 'MAIL': '/var/mail/cltbld', 08:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:25 INFO - 'MOZ_NO_REMOTE': '1', 08:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:25 INFO - 'NO_EM_RESTART': '1', 08:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:25 INFO - 'PWD': '/builds/slave/test', 08:00:25 INFO - 'SHELL': '/bin/bash', 08:00:25 INFO - 'SHLVL': '1', 08:00:25 INFO - 'TERM': 'linux', 08:00:25 INFO - 'TMOUT': '86400', 08:00:25 INFO - 'USER': 'cltbld', 08:00:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:25 INFO - '_': '/tools/buildbot/bin/python'} 08:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:00:25 INFO - Cleaning up... 08:00:25 INFO - Return code: 0 08:00:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:00:25 INFO - Using env: {'DISPLAY': ':0', 08:00:25 INFO - 'HOME': '/home/cltbld', 08:00:25 INFO - 'LANG': 'en_US.UTF-8', 08:00:25 INFO - 'LANGUAGE': 'en_US:en', 08:00:25 INFO - 'LOGNAME': 'cltbld', 08:00:25 INFO - 'MAIL': '/var/mail/cltbld', 08:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:25 INFO - 'MOZ_NO_REMOTE': '1', 08:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:25 INFO - 'NO_EM_RESTART': '1', 08:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:25 INFO - 'PWD': '/builds/slave/test', 08:00:25 INFO - 'SHELL': '/bin/bash', 08:00:25 INFO - 'SHLVL': '1', 08:00:25 INFO - 'TERM': 'linux', 08:00:25 INFO - 'TMOUT': '86400', 08:00:25 INFO - 'USER': 'cltbld', 08:00:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:25 INFO - '_': '/tools/buildbot/bin/python'} 08:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:28 INFO - Downloading docopt-0.6.1.tar.gz 08:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:28 INFO - Running setup.py install for blobuploader 08:00:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:28 INFO - Running setup.py install for requests 08:00:29 INFO - Running setup.py install for docopt 08:00:29 INFO - Successfully installed blobuploader requests docopt 08:00:29 INFO - Cleaning up... 08:00:29 INFO - Return code: 0 08:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:29 INFO - Using env: {'DISPLAY': ':0', 08:00:29 INFO - 'HOME': '/home/cltbld', 08:00:29 INFO - 'LANG': 'en_US.UTF-8', 08:00:29 INFO - 'LANGUAGE': 'en_US:en', 08:00:29 INFO - 'LOGNAME': 'cltbld', 08:00:29 INFO - 'MAIL': '/var/mail/cltbld', 08:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:29 INFO - 'MOZ_NO_REMOTE': '1', 08:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:29 INFO - 'NO_EM_RESTART': '1', 08:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:29 INFO - 'PWD': '/builds/slave/test', 08:00:29 INFO - 'SHELL': '/bin/bash', 08:00:29 INFO - 'SHLVL': '1', 08:00:29 INFO - 'TERM': 'linux', 08:00:29 INFO - 'TMOUT': '86400', 08:00:29 INFO - 'USER': 'cltbld', 08:00:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:29 INFO - '_': '/tools/buildbot/bin/python'} 08:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:29 INFO - Running setup.py (path:/tmp/pip-XTGmZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:29 INFO - Running setup.py (path:/tmp/pip-9ErbC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:29 INFO - Running setup.py (path:/tmp/pip-LtkBS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:29 INFO - Running setup.py (path:/tmp/pip-OLbJou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:29 INFO - Running setup.py (path:/tmp/pip-3v8TWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:29 INFO - Running setup.py (path:/tmp/pip-Ox_qbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:29 INFO - Running setup.py (path:/tmp/pip-OTv2eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:30 INFO - Running setup.py (path:/tmp/pip-x5Uuu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:30 INFO - Running setup.py (path:/tmp/pip-naBQ_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:30 INFO - Running setup.py (path:/tmp/pip-y8tZMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:30 INFO - Running setup.py (path:/tmp/pip-nxSZdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:30 INFO - Running setup.py (path:/tmp/pip-UGU85_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:30 INFO - Running setup.py (path:/tmp/pip-hIWeIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:30 INFO - Running setup.py (path:/tmp/pip-mnp2DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:30 INFO - Running setup.py (path:/tmp/pip-xQQq_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:30 INFO - Running setup.py (path:/tmp/pip-wIHQi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:30 INFO - Running setup.py (path:/tmp/pip-c5uy8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:30 INFO - Running setup.py install for manifestparser 08:00:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for mozcrash 08:00:30 INFO - Running setup.py install for mozdebug 08:00:31 INFO - Running setup.py install for mozdevice 08:00:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozfile 08:00:31 INFO - Running setup.py install for mozhttpd 08:00:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozinfo 08:00:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozInstall 08:00:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozleak 08:00:31 INFO - Running setup.py install for mozlog 08:00:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for moznetwork 08:00:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozprocess 08:00:32 INFO - Running setup.py install for mozprofile 08:00:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozrunner 08:00:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Running setup.py install for mozscreenshot 08:00:32 INFO - Running setup.py install for moztest 08:00:32 INFO - Running setup.py install for mozversion 08:00:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:32 INFO - Cleaning up... 08:00:32 INFO - Return code: 0 08:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:32 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')]} 08:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:32 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')]} 08:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:32 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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:32 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 08:00:32 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 08:00:32 INFO - Using env: {'DISPLAY': ':0', 08:00:32 INFO - 'HOME': '/home/cltbld', 08:00:32 INFO - 'LANG': 'en_US.UTF-8', 08:00:32 INFO - 'LANGUAGE': 'en_US:en', 08:00:32 INFO - 'LOGNAME': 'cltbld', 08:00:32 INFO - 'MAIL': '/var/mail/cltbld', 08:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:32 INFO - 'MOZ_NO_REMOTE': '1', 08:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:32 INFO - 'NO_EM_RESTART': '1', 08:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:32 INFO - 'PWD': '/builds/slave/test', 08:00:32 INFO - 'SHELL': '/bin/bash', 08:00:32 INFO - 'SHLVL': '1', 08:00:32 INFO - 'TERM': 'linux', 08:00:32 INFO - 'TMOUT': '86400', 08:00:32 INFO - 'USER': 'cltbld', 08:00:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:32 INFO - '_': '/tools/buildbot/bin/python'} 08:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:32 INFO - Running setup.py (path:/tmp/pip-6SJP6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:32 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)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:32 INFO - Running setup.py (path:/tmp/pip-4XNImO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:32 INFO - Running setup.py (path:/tmp/pip-xjy6U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:33 INFO - Running setup.py (path:/tmp/pip-32aahz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:33 INFO - Running setup.py (path:/tmp/pip-IJU78x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:33 INFO - Running setup.py (path:/tmp/pip-6_yA2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:33 INFO - Running setup.py (path:/tmp/pip-p7MUPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:33 INFO - Running setup.py (path:/tmp/pip-8s5TcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:33 INFO - Running setup.py (path:/tmp/pip-3gZn6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:33 INFO - Running setup.py (path:/tmp/pip-qwQ3_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:33 INFO - Running setup.py (path:/tmp/pip-AdTn0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:33 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:33 INFO - Running setup.py (path:/tmp/pip-xJbnuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:33 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:33 INFO - Running setup.py (path:/tmp/pip-jbHH8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:33 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:33 INFO - Running setup.py (path:/tmp/pip-npVbVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:33 INFO - Running setup.py (path:/tmp/pip-E3MT2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:33 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:33 INFO - Running setup.py (path:/tmp/pip-DUayXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:33 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)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:33 INFO - Running setup.py (path:/tmp/pip-60nLlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:36 INFO - Downloading blessings-1.6.tar.gz 08:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:36 INFO - Installing collected packages: blessings 08:00:36 INFO - Running setup.py install for blessings 08:00:36 INFO - Successfully installed blessings 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:36 INFO - Reading from file tmpfile_stdout 08:00:36 INFO - Current package versions: 08:00:36 INFO - argparse == 1.2.1 08:00:36 INFO - blessings == 1.6 08:00:36 INFO - blobuploader == 1.2.4 08:00:36 INFO - docopt == 0.6.1 08:00:36 INFO - functools32 == 3.2.3-2 08:00:36 INFO - jsonschema == 2.5.1 08:00:36 INFO - manifestparser == 1.1 08:00:36 INFO - mozInstall == 1.12 08:00:36 INFO - mozcrash == 1.0 08:00:36 INFO - mozdebug == 0.1 08:00:36 INFO - mozdevice == 0.48 08:00:36 INFO - mozfile == 1.2 08:00:36 INFO - mozhttpd == 0.7 08:00:36 INFO - mozinfo == 0.9 08:00:36 INFO - mozleak == 0.1 08:00:36 INFO - mozlog == 3.4 08:00:36 INFO - moznetwork == 0.27 08:00:36 INFO - mozprocess == 0.23 08:00:36 INFO - mozprofile == 0.28 08:00:36 INFO - mozrunner == 6.13 08:00:36 INFO - mozscreenshot == 0.1 08:00:36 INFO - mozsystemmonitor == 0.3 08:00:36 INFO - moztest == 0.7 08:00:36 INFO - mozversion == 1.4 08:00:36 INFO - psutil == 3.1.1 08:00:36 INFO - requests == 1.2.3 08:00:36 INFO - wsgiref == 0.1.2 08:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:36 INFO - Using env: {'DISPLAY': ':0', 08:00:36 INFO - 'HOME': '/home/cltbld', 08:00:36 INFO - 'LANG': 'en_US.UTF-8', 08:00:36 INFO - 'LANGUAGE': 'en_US:en', 08:00:36 INFO - 'LOGNAME': 'cltbld', 08:00:36 INFO - 'MAIL': '/var/mail/cltbld', 08:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:36 INFO - 'MOZ_NO_REMOTE': '1', 08:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:36 INFO - 'NO_EM_RESTART': '1', 08:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:36 INFO - 'PWD': '/builds/slave/test', 08:00:36 INFO - 'SHELL': '/bin/bash', 08:00:36 INFO - 'SHLVL': '1', 08:00:36 INFO - 'TERM': 'linux', 08:00:36 INFO - 'TMOUT': '86400', 08:00:36 INFO - 'USER': 'cltbld', 08:00:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:36 INFO - '_': '/tools/buildbot/bin/python'} 08:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 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)) 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 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 0x7f98664a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1112ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', '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 08:00:36 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 08:00:36 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 08:00:36 INFO - Using env: {'DISPLAY': ':0', 08:00:36 INFO - 'HOME': '/home/cltbld', 08:00:36 INFO - 'LANG': 'en_US.UTF-8', 08:00:36 INFO - 'LANGUAGE': 'en_US:en', 08:00:36 INFO - 'LOGNAME': 'cltbld', 08:00:36 INFO - 'MAIL': '/var/mail/cltbld', 08:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:36 INFO - 'MOZ_NO_REMOTE': '1', 08:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:36 INFO - 'NO_EM_RESTART': '1', 08:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:36 INFO - 'PWD': '/builds/slave/test', 08:00:36 INFO - 'SHELL': '/bin/bash', 08:00:36 INFO - 'SHLVL': '1', 08:00:36 INFO - 'TERM': 'linux', 08:00:36 INFO - 'TMOUT': '86400', 08:00:36 INFO - 'USER': 'cltbld', 08:00:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:36 INFO - '_': '/tools/buildbot/bin/python'} 08:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Running post-action listener: _resource_record_post_action 08:00:36 INFO - Running post-action listener: _start_resource_monitoring 08:00:36 INFO - Starting resource monitoring. 08:00:36 INFO - [mozharness: 2016-12-07 16:00:36.996875Z] Finished create-virtualenv step (success) 08:00:36 INFO - [mozharness: 2016-12-07 16:00:36.997378Z] Running install step. 08:00:36 INFO - Running pre-action listener: _resource_record_pre_action 08:00:36 INFO - Running main action method: install 08:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:37 INFO - Reading from file tmpfile_stdout 08:00:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:37 INFO - Reading from file tmpfile_stdout 08:00:37 INFO - Output received: 08:00:37 INFO - Usage: mozinstall [options] installer 08:00:37 INFO - Options: 08:00:37 INFO - -h, --help show this help message and exit 08:00:37 INFO - -d DEST, --destination=DEST 08:00:37 INFO - Directory to install application into. [default: 08:00:37 INFO - "/builds/slave/test"] 08:00:37 INFO - --app=APP Application being installed. [default: firefox] 08:00:37 INFO - mkdir: /builds/slave/test/build/application 08:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:00:53 INFO - Reading from file tmpfile_stdout 08:00:53 INFO - Output received: 08:00:53 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:53 INFO - Running post-action listener: _resource_record_post_action 08:00:53 INFO - [mozharness: 2016-12-07 16:00:53.241313Z] Finished install step (success) 08:00:53 INFO - [mozharness: 2016-12-07 16:00:53.241556Z] Running run-tests step. 08:00:53 INFO - Running pre-action listener: _resource_record_pre_action 08:00:53 INFO - Running main action method: run_tests 08:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:53 INFO - Python 2.7.3 08:00:53 INFO - Return code: 0 08:00:53 INFO - grabbing minidump binary from tooltool 08:00:53 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')]} 08:00:53 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 0x110ff60>, '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 0x1110d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11111d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:53 INFO - Return code: 0 08:00:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:53 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:00:53 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:00:53 INFO - Using env: {'DISPLAY': ':0', 08:00:53 INFO - 'HOME': '/home/cltbld', 08:00:53 INFO - 'LANG': 'en_US.UTF-8', 08:00:53 INFO - 'LANGUAGE': 'en_US:en', 08:00:53 INFO - 'LOGNAME': 'cltbld', 08:00:53 INFO - 'MAIL': '/var/mail/cltbld', 08:00:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:53 INFO - 'MOZ_NO_REMOTE': '1', 08:00:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:53 INFO - 'NO_EM_RESTART': '1', 08:00:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:53 INFO - 'PWD': '/builds/slave/test', 08:00:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:53 INFO - 'SHELL': '/bin/bash', 08:00:53 INFO - 'SHLVL': '1', 08:00:53 INFO - 'TERM': 'linux', 08:00:53 INFO - 'TMOUT': '86400', 08:00:53 INFO - 'USER': 'cltbld', 08:00:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458', 08:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:53 INFO - '_': '/tools/buildbot/bin/python'} 08:00:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:00:53 INFO - mozversion application_buildid: 20161207062538 08:00:53 INFO - mozversion application_changeset: 93266100e27057f116effff38f70d8563533097b 08:00:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:00:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:53 INFO - mozversion application_name: Firefox 08:00:53 INFO - mozversion application_remotingname: firefox-dev 08:00:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:53 INFO - mozversion application_vendor: Mozilla 08:00:53 INFO - mozversion application_version: 52.0a2 08:00:53 INFO - mozversion platform_buildid: 20161207062538 08:00:53 INFO - mozversion platform_changeset: 93266100e27057f116effff38f70d8563533097b 08:00:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:53 INFO - mozversion platform_version: 52.0a2 08:00:53 INFO - using testdate: 1481126453 08:00:53 INFO - actual date: 1481126453 08:00:53 INFO - starting webserver on 'localhost:45655' 08:00:53 INFO - SUITE-START | Running 2 tests 08:00:53 INFO - TEST-START | dromaeo_css 08:00:53 INFO - operating with platform_type : linux_ 08:00:53 INFO - Initialising browser for dromaeo_css test... 08:00:53 INFO - TEST-INFO | started process 18225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMIsqy/profile http://localhost:45655/getInfo.html) 08:00:57 INFO - PROCESS | 18225 | __metrics Screen width/height:1600/1200 08:00:57 INFO - PROCESS | 18225 | colorDepth:24 08:00:57 INFO - PROCESS | 18225 | Browser inner width/height: 1024/697 08:00:57 INFO - PROCESS | 18225 | __metrics 08:00:58 ERROR - PROCESS | 18225 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:00:58 INFO - TEST-INFO | 18225: exit 0 08:00:58 INFO - Browser initialized. 08:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:58 INFO - TEST-INFO | started process 18357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMIsqy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:10 INFO - PROCESS | 18357 | RSS: Main: 151666688 08:01:10 INFO - PROCESS | 18357 | 08:02:00 INFO - PROCESS | 18357 | 1481126520414 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] 08:04:10 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:45655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45655/tests/dromaeo/cssquery-ext.html) 08:04:12 INFO - PROCESS | 18357 | RSS: Main: 156069888 08:04:12 INFO - PROCESS | 18357 | 08:07:14 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:45655/tests/dromaeo/cssquery-ext.html (next: http://localhost:45655/tests/dromaeo/cssquery-jquery.html) 08:07:15 INFO - PROCESS | 18357 | RSS: Main: 153030656 08:07:15 INFO - PROCESS | 18357 | 08:10:16 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:45655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45655/tests/dromaeo/cssquery-mootools.html) 08:10:17 INFO - PROCESS | 18357 | RSS: Main: 153092096 08:10:17 INFO - PROCESS | 18357 | 08:13:19 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:45655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45655/tests/dromaeo/cssquery-prototype.html) 08:13:19 INFO - PROCESS | 18357 | RSS: Main: 151326720 08:13:19 INFO - PROCESS | 18357 | 08:16:22 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:45655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45655/tests/dromaeo/cssquery-yui.html) 08:16:23 INFO - PROCESS | 18357 | RSS: Main: 154124288 08:16:23 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | Cycle 1(1): loaded http://localhost:45655/tests/dromaeo/cssquery-yui.html (next: http://localhost:45655/tests/dromaeo/cssquery-dojo.html) 08:19:25 INFO - PROCESS | 18357 | RSS: Main: 155185152 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | __start_tp_report 08:19:25 INFO - PROCESS | 18357 | _x_x_mozilla_page_load 08:19:25 INFO - PROCESS | 18357 | _x_x_mozilla_page_load_details 08:19:25 INFO - PROCESS | 18357 | |i|pagename|runs| 08:19:25 INFO - PROCESS | 18357 | |0;dojo.html;3289.375018746438;3314.403407386671;3323.135984643993;3334.4498157803964;3334.9666503334965;5701.315842098948;5721.799737009201;5736.282964629421;5755.366909639936;5764.596478246519;5737.426257374261;5748.281464816898;5764.048931926227;5789.565782566303;5809.157672137548;5181.844544663657;5233.947660523384;5248.973755131238;5277.3139491866195;5278.920816187741;5289.497497737709;5291.28567643367;5296.285001524802;5311.203319502067;5338.546223571001;5139.383274007125;5165.948340516585;5258.079836028699;5267.736613169345;5279.3928698199625;5176.223566465042;5196.610254230948;5208.817691380802;5214.713190774506;5246.291750613656;5121.820736274212;5210.687358758449;5248.763805628718;5251;5279.973600132013;5592.3009623797025;5706.629069110536;5735.541156707453;5743.597948143632;5808.622439541458;6040.728167232485;6104.450599446027;6128.754849806002;6157.630542167484;6187.226596675416;6087.178230938811;6185.56701030928;6197.959305924386;6200.348963358872;6229.3459186785185;5581.134924086732;5595.272614560081;5628.859278517988;5777.942220577783;5833.037548804485;6060.484858787053;6139.57023008394;6140.0134868502855;6151.569390142737;6159.23009623797;5900.64596124234;5909.084091965752;5914.378990206053;5919.260092488439;5924.851878703067;5980.700964951735;5984.281886173687;5990.460858522754;6003.369646187175;6006.639601623917;6038.245219347582;6064.727087281083;6079.240094988127;6126.540509461808;6142.099766648122;6068;6105.694715264219;6124.173236613;6140.232470941132;6140.815775526741;4545.181867263925;4707.6233901287815;4724.480307166209;4733.5266473352385;4738.715677059387;4097.836086556505;4175.498940127204;4179.519355274121;4218.514870789837;4234.767087810138;5974.163617093611;5978.8206353809455;5979.611325263844;5981.910271345933;5984.072468767348;6039.728212230372;6097.4817140543555;6249.0938813871735;6260.530460215502;6271.905921411182;5850.47345738877;5857.88284234313;5899.321578018583;5940.584159108821;5944.613600115978;5139.8458046258675;5175.378954525481;5179.404368497671;5183.300254465599;5210.739463026834;6416.454601358843;6421.711023003976;6422.229332480132;6426.582272152295;6436.388543088399;6012.278526576839;6062.7271772769445;6123.5876691309595;6141.3551577085545;6152.969235153795;6339.90490142639;6390.968045159744;6402.519811014286;6408.935910640834;6415.166028416276;6068.332483426908;6072.787452439144;6075;6088.178095957166;6104.694765261808;5992.8501787453915;6037.939620603738;6079.635221886701;6145.293291271382;6213.502919766498;5894.086416605433;6000.699965001645;6004.849878753066;6034.2155519782145;6038.849028774316;5976.641401515923;5979.953508135972;5981.551383646157;6004.949133901462;6012.368701286302;5742.109972954198;5810.186573879576;5944.64332140073;5948.583599148018;5964.5526585505395;5982.4017598239825;5982.850428739316;6036;6046.365131661112;6094.603850749687;5851.1515830205235;5900.852478687895;5901.498372638202;5911.793087241926;5917.142014407973 08:19:25 INFO - PROCESS | 18357 | |1;ext.html;579.4871538688262;600.5435868739758;631.7978246960973;648.3160265919456;651.6318280171705;42010.78994605027;43454.696359109235;43529.78235108824;46924.296135558;47086.529134708646;44700.776496117556;45116;45368.31947520781;45380.3192952106;45427;8660.69687560934;8816.8677469838;8821;8838.911610883873;8855.512946787923;8648.870266946002;8691.130886911289;8709.25971292441;8761.95619021904;8801.207891289783;8829.337799665018;8840.646374145026;8892.599833007498;8894.644214231455;8901.955490222539;8783.604737786814;8798.428102173339;8840.204381605654;8843.95578022109;8875.334349923782;8642.783930401727;8676.60955257015;8733.737987860375;8750.081241469681;8751.781205469913;42316;42675.35986960198;42720.35919461211;42730;42746;3508.982455087734;3697.2235830475634;4284.057507348379;4297.419848320468;4395.1868904252815;32582.83708581442;32650.83674581612;32691.6730832691;32694.182645433815;33038.33923321544;4402.075564131536;4466.218411777926;4488.483824360208;4523.819047238107;4581.908361832745;328519.9999999976;329189;329857;331231;334588;58618.41381586215;58773;58937;59006;59118.70440647855;60387.09419358713;60560.394396056356;60636;61210;61410.38589614136;18501.259949602136;18603.25586976533;18655.347062852736;18755.812441875405;18782.342618008304;13453.192808431526;13463.528776492776;13472.730545389037;13491.730165396637;13510.594682159552;15551.766723499157;16149.273282702306;16198.190090495427;16214.675706485805;16260.430884919208;6215.160953271341;6329.303776584572;6364.109024736541;6430.067640192239;6459.870802583922;963.8843338799248;987.4124895687055;1056.793925184597;1071.8487646319795;1075.2688172043086;30559.694403055684;30588;30866.228344291125;30898;31328;1084.1868598551087;1106.5629076514892;1162.5001249462812;1175.494537348931;1231.384307846077;15504.147271900154;15994.200289985687;16113.838861611468;17295.221715022853;17566.297348105934;520491;527658;529643;529954;532916;61219;61280;61383.69308153431;61963.6901815488;62336.688316558124;1458.8905832062637;1483.1768368555556;1484.7921291019265;1498.8276348219877;1519.4833756522835;31646;32292.838535807172;32394.35211295808;32410.189745256557;32810.17974550655;55504.167437489275;55748.442515575945;55923.161152583554;56240.156397654886;56478.43521564732;384951;386563;386578;387133;388613;44984.32523512215;45861.31208031815;45941.54058459373;46652.300215496114;46710.299345510524;49409.50590494193;49469.50530494649;49875.75062124812;50064;51302;41611.58388416077;43227.35158972555;43251.567484324754;43672.56327436685;44174.779126104164;40921.59078409178;43414.580610403085;43511;43743.78128109339;43756.78121609499;40833.79583102065;40996.385054224804;41382.586174137876;41479.170416590896;41517.584824151374;35105.82447087748;37576.99282149659;37885.62114378821;38138;38392.2321553573;28174.2956426091;28513.144605661862;28556.42887142287;28557;28660 08:19:25 INFO - PROCESS | 18357 | |2;jquery.html;417.6199658310938;425.34921569997897;430.81972978517626;441.6665417609704;443.2464809823303;17754.289828406865;18403.907980460113;19506.512337191576;19685.21259149634;19760.604787904234;19476.636635435527;19589.902050489763;20171.193152273892;20299.797002030013;20332.796672033277;5666.263385759856;5932.495737862287;5933.851653708649;5948.078047902582;5954.255718035246;5698.629589076697;5781.971090144543;5858.912116318259;5901.616394934337;5922.851928701773;5771.307443106812;5773.48038676519;5776.220210271623;5781.479666829984;5785.681787501686;5604.075327570946;5775.653460792366;5776.335721392031;5820.185174075633;5895.675737834417;5283.682979021271;5293.7617807198385;5309.36287645485;5310.7610157543;5318.627696061278;23294;23602.173923912753;23776.88111559431;23808.761912381;23824.523509529714;2414.915477958263;2441.084593277521;2528.8103392245657;2566.8973241070335;3044.6194225721783;14395.856041439662;15124.470643527533;15252.084874907541;15301.846981530265;15707;2030.8273796727149;2036.7861374555607;2047.819072687583;2054.4247610668885;2120.236714782677;82836.58581707113;83193.58403208006;83971.58014209951;84621;85025;10842.29525080883;10949.671509854717;11325.32048077118;11440.485178167002;11467.197296189186;14012.509562165274;14770.409183632535;15936.203189840462;15952.20238988046;16009.519714408587;8313.293370063613;8371.832563348698;8532.616032278562;8540.572971351408;8556.272716819016;8543;8581.056083830774;8622.82754344922;8670.913290867136;8708.651653933899;4359.542248063971;4506.909861802746;4511.826924999524;4547.522510136454;4613.746243956548;2025.8379329653592;2066.359428577146;2077.0341791067226;2198.6482162853868;2223.5102481337544;904.8733177355175;984.601236499219;994.0854413939194;1021.2289721260549;1030.0111892583054;19086.141123649468;19412.22351105968;19449.4165175045;19492.610147797248;19960.50098747543;975.351391324761;1032.6747074671455;1048.554364395129;1048.7483004078965;1063.2291588598205;10501.369917804956;10892.836607450894;10965.671029869116;10970.780584388267;10997.780044399067;500669;502421;508069;516007;518565;87154.56422717846;89819.55090224638;97474;98251;98771;1084.208527774729;1111.7053980695123;1113.0261021606095;1115.1580556679655;1117.0672488472055;17390.73913891318;17793.466196014142;17847;17892.731609025614;18167.81832181714;31391.372172555963;38113.428298576095;41419.96450088772;44480;45461;62357.68821156047;64253.357466424735;64318.35681643124;65110.67444662746;65413;8687.956560217159;8692.087330830173;8965;9116.772080698036;9389.530523473935;12420.813687794871;12792.808107878576;12824.743505129658;13110.147840390344;13754.518591849237;10952.726181845517;11230.270032447865;11374.54501819918;11415.200935934405;11780.469878855643;11068.778624427305;11190.272632278877;11733.647990560297;11810.881891180978;12129.393530323625;11080.61217857371;11465.885341146482;11470.254433461798;11683.299002059903;11870.465829037541;7698.34564062061;8240.546769927712;8291.875621865798;8615.353848461265;8952.865707014269;9550.713478595653;12332.691682708004;12485.438155282853;12587.678293779021;12597.622071337875 08:19:25 INFO - PROCESS | 18357 | |3;mootools.html;1528.778327142564;1529.717002354564;1725.3271224222547;1808.9547761305957;1828.8262615051574;8029.879551806713;8309.086000539952;8622.396432249745;9130.726078217656;9138.862917056249;8316.334693224542;8599.226069653745;8612.698555550556;8745.387822852403;8789.077146899579;2528.4943011397704;2561.526117668228;2561.6541766861424;2561.7950563954837;2564.038485567912;2477.52926943881;2574.6266791315247;2612.686477622688;2619.266605350505;2623.527765002299;2499.7250302466805;2504.4365017871014;2508.686414198225;2508.9623655645178;2514.308565144591;2439.6462512935614;2450.8652024138664;2458.950820983588;2470.493548822487;2476.2818782553036;2461.4953934443574;2464.3099932018886;2466.198485492222;2485.0556788420286;2505.523950449409;8870.068642792543;8998.325125615605;8998.415103018348;9014.639414423415;9026.097390260988;5621.8594535136945;5751.1085781703905;5760.971195143998;5762.078067509178;5772.682502462363;3451.3442445935193;3644.6355364463607;3705.370087085202;3718.925621487555;3736.813159342022;1151.8617765868066;1218.469965564973;1228.6744012836605;1235.3946566182597;1276.8595454499998;11995.28028318295;12097.697557561043;12103.576374826927;12114;12136.696582585419;4726.983698504838;4787.928181077286;4916.926246106311;4945.406551213878;4952.257161425815;9739.951300243454;9838.852417213748;9850.359726617748;9870.802583948282;9882.555285012191;5601.831945041574;5622.887542249132;5638.718064096779;5655.688937108499;5657.010023245915;4711.552402521755;4837.9032419351415;5102.438731739506;5183.870403239949;5242.947570524322;3943.2507823513442;4016.3975403689096;4044.1911617676583;4101.466809314829;4138.048248902769;1237.3936770982154;1239.8698136695516;1258.10674421162;1263.8041103628952;1278.2202856257675;865.8744482050067;875.6103533927342;964.0985678390728;973.9384071362249;975.0882924465648;5622.91565626516;5748.712564371848;5820.476157145792;5968.403159683997;6029.246344206974;460.56016504238374;460.9101225261109;461.6399208617284;466.71763583031776;476.95707386334703;3939.7439166454087;4160.687948403882;4163.188178305262;4202.936955945664;4209.957900420956;10674.519646615921;11181;11211.159163062803;11232.494537745657;11232.943835280772;11013.229073964905;11092.389918554558;11100.167487438313;11105.555777768799;11107.944460277648;8377.287930525974;8404.495730256082;8470.32237421017;8523.232909038215;8592.226699597066;5934.9109763354445;5946.226990491208;6017.157597936205;6020.1270815730595;6066.908996364969;10073.546690398804;10163.339382940085;10213.489325533545;10303.278770485995;10317.9484102579;9904.356216845881;10283.33158344735;10360.274780765274;10463.476826158814;10530.578776849146;6634.668266586747;6912.930870691229;7065.399441047569;7499.587522686086;7652.234776522303;8419.70531031411;8806.691765788166;8843.292536597186;8909.73270801877;8920.86618700707;7635.465517413728;7664.6550905210515;7780.649870755943;7790.493617914817;7949.642266097924;7709.807254818675;7735.110462296908;7793.9220607793195;7877.645505952131;8041.276285134366;7036.401905837856;7054.894176587458;7131.964340178266;7150.570965742072;7152.141742990874;5217.269582258411;5230.7384630769075;5292.9206061908335;5352.090144675492;5353.464653534771;5236.476352364733;5247.291615631993;5290.920636190537;5336.332958380202;5367.785288588413 08:19:25 INFO - PROCESS | 18357 | |4;prototype.html;344.66567429593283;347.5464518802962;358.02081307623644;361.7287034723957;368.22672387985233;5431.375391829931;5545.445455454463;5692.060809966356;5707.400722924091;5731.993802169244;5386.91919621206;5481.287432633762;5513.724313784305;5523.7238138093135;5526.203983705292;4376.978115109428;4378.40891479651;4383.780810959455;4397.604215620593;4415.359772832937;4176.749395036292;4336.544662810406;4394.956050439487;4430.939613079917;4446.2219111655495;4364.432623758907;4366.2359087159775;4376.912461750763;4382.758948257844;4385.495667998173;4373.475182978047;4378.6715996300245;4397.614751353313;4400.647948164139;4413.205622987861;3794.924101517954;3816.732828701992;3933.567307596162;3936.094698219397;3938.991114531581;5338.652987555835;5428.565714742851;5432.348118225838;5444.373897001856;5506.531944784658;4940.6788558743565;4942.481039490874;4947.282644016597;4961.469650478246;5003.449620541774;5672.9432705672825;5797.565182611321;5816.447437493432;5866.589338746289;5886.146508756249;4213.346931225634;4229.97885010576;4240.681948853849;4257.787110644486;4268.253055715238;6076.301225359096;6097.908531372033;6098.23772028492;6100.877982440326;6130.846728831815;4257.91484170321;4259.190753756776;4331.610155086058;4345.239583072949;4366.519682834885;4367.100311364567;4367.978160109179;4392.472903251631;4402.163588918095;4412.33814927757;4999.875028118717;5016.1723315653235;5026.195808670668;5029.270755740397;5040.218766091261;5726.398728133569;5746.9712651436475;5869.853253668693;5879.382664820132;5932.3474417814;1463.1075044223016;1466.7506523890963;1472.7201831652167;1482.8294746104336;1486.6060493969107;1004.9346792458467;1019.1337363241186;1023.7305740881253;1032.2361452525226;1036.2953191829629;5523.536262890338;5545.694986775766;5549.500544950974;5587.664740115606;5591.692456914828;5836.832633473237;5865.885481758452;5875.532276443904;5887.882242355215;5916.408359164049;5384.703841288689;5499.257600223998;5529.364123125812;5537.446255374431;5564.360098588633;3085.6451508076857;3089.335792804558;3093.427715872571;3095.4892442747146;3102.9844850776053;5921.259842519685;6024.608400453956;6027.336992930774;6032.1856549365275;6061.060535616986;6134.355892631299;6188.566800323934;6192.721327540272;6194.38056194377;6229.937700623026;6293.37066293367;6308.432241098323;6313.02148167044;6331.271903731038;6336.746530138835;5971.373005834324;6017.909731353946;6045.637261764308;6050.45545900871;6065.8180254592435;5933.643981361132;5960.821175364746;5974.970125149346;6009.969950150221;6041.909371359346;6085.618354784548;6230.875382492415;6254.998400511792;6264.992803454458;6272.937270627235;4333.956660433355;4354.738715677069;4358.128374325084;4367.781610919378;4421.955780442283;5879.647681033301;6020;6098.939010609837;6134.631922084689;6159.692015399122;5766.808612727137;5780.306363236438;5857.648541087548;5862.706864656665;5874.383189765013;5891.852703682443;5891.9116213255975;5893.675847828411;5901.645901245767;5916.55625828056;5639.893733895239;5768.02006615434;5797.304323481209;5802.883942321046;5804.2744656917885;5849.356570777296;5900.1149827526215;5910.911336329872;5914;5932.228810254639;5678.047415343915;5709.743061562157;5788.189653448437;5790.913136302875;5792.942070579409 08:19:25 INFO - PROCESS | 18357 | |5;yui.html;773.0144066315447;794.3208556684035;805.858974679431;853.6969375871562;858.4977787994026;14863.851361486382;15191.164485953268;15541.378344866192;15550.989185702922;15602.297896594651;13513;13675.589732308023;14950.551483455514;15673.686526269468;15834;847.1401527449628;864.2135656552539;865.4461144867258;868.1665601023026;869.0961400143843;856.6530555125153;859.3468963587655;861.7371701631;861.7931696392852;862.9439086459391;894.0389081737159;898.8292224477361;901.4320977783987;901.589776651622;902.7246689759621;886.898006729228;895.7088946092481;896.0457113174448;896.9282457403425;898.0884402331606;655.5476721062452;658.1575583253443;659.4757168051362;660.1615947746383;664.1565212180503;15106.320215590215;15199.848001519953;15259.084454932628;15271.923640381838;15330.923345383313;13681.931590341985;14387.28063596816;14432.567022989328;14697.26513674312;15034.248287585577;11583.47874345648;11659.475323610457;11671.591494297743;11682.065434765198;11938.224015439055;3761.3430805339835;3772.2078363543687;3788.2423515296773;3805.6384643458828;3954.762714237155;54557.45442545563;56040.43959560393;65942;66165;66362;10431.68704938853;11374.715632109264;11460.426978651034;11523.193376463567;11681.065514758799;20397.38807835767;20412.591748164952;20460.283890064075;20541.281055163;20577.176912923616;8668.393212475066;8742.80920421861;8818;8900.554972251492;9195.862062069074;4632.60622847055;4694.718316900997;4732.95267047332;4822.252550854623;4858.684185527929;3415.829208539613;3447.465642825366;3479.0954351868695;3711.8515259389324;3876.7673939563715;670.792054463118;671.516508114157;673.5419914458117;673.8618583190532;712.9928700712926;663.9476429858631;698.7833771530842;740.7481456304882;758.1584441270186;771.8224808294124;8745.256653184424;9321.72034838956;9655.613775449045;10192.694219173436;10261.640842570474;616.6608365399013;657.6251536624078;679.7281087564915;744.95530268183;756.9659365328573;4486.327050942385;4496.437945256843;4599.931001034987;4700.435947686231;4782.426108866958;52194.739026304625;52324;52456;76325;85515.57242213748;47819.28271075937;49539.75230123899;58554;79513.60243198747;80436;66995;67720.3227967714;70948;72911.63544182245;75263;8734.213920747163;8762.649494020168;8798.47209167452;8820.955895220482;9046.592903319499;47942.52057479381;48705.26942095801;50028.99942001212;50303.245451318995;50453.74773126111;65241.34758652543;65281.67359163364;65390;67194.3280567188;69756.30243697498;11034.724131896446;11329.433528323387;11496.597619083292;11571.13216508782;11909.583164589545;13282.601521954357;13567.118137321437;13614.18314901109;13798.241096739775;14497.20265385414;11844.585439509576;12028.939855300667;12241.326727030098;12382.442790074288;12502.687432814253;11389.544418223179;11490.597829075943;11621.24461909973;12017.158798883995;12036.879631203576;12173.330466824409;12266.938665306616;12292.815607765711;12510.18683785551;13065.216087034809;9945.204383649436;10200.795984080425;10201.234907381828;10444.42555659446;10495.947520262655;9572.282078843975;10232.693019209435;10267.691969240936;10304.433256170983;10345.586176552853 08:19:25 INFO - PROCESS | 18357 | __end_tp_report 08:19:25 INFO - PROCESS | 18357 | __start_cc_report 08:19:25 INFO - PROCESS | 18357 | _x_x_mozilla_cycle_collect,308 08:19:25 INFO - PROCESS | 18357 | __end_cc_report 08:19:25 INFO - PROCESS | 18357 | __startTimestamp1481127565553__endTimestamp 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | ------- Summary: start ------- 08:19:25 INFO - PROCESS | 18357 | Number of tests: 6 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | [#0] dojo.html Cycles:165 Average:5696.02 Median:5944.61 stddev:644.61 (10.8%) stddev-sans-first:618.32 08:19:25 INFO - PROCESS | 18357 | Values: 3289.4 3314.4 3323.1 3334.4 3335.0 5701.3 5721.8 5736.3 5755.4 5764.6 5737.4 5748.3 5764.0 5789.6 5809.2 5181.8 5233.9 5249.0 5277.3 5278.9 5289.5 5291.3 5296.3 5311.2 5338.5 5139.4 5165.9 5258.1 5267.7 5279.4 5176.2 5196.6 5208.8 5214.7 5246.3 5121.8 5210.7 5248.8 5251.0 5280.0 5592.3 5706.6 5735.5 5743.6 5808.6 6040.7 6104.5 6128.8 6157.6 6187.2 6087.2 6185.6 6198.0 6200.3 6229.3 5581.1 5595.3 5628.9 5777.9 5833.0 6060.5 6139.6 6140.0 6151.6 6159.2 5900.6 5909.1 5914.4 5919.3 5924.9 5980.7 5984.3 5990.5 6003.4 6006.6 6038.2 6064.7 6079.2 6126.5 6142.1 6068.0 6105.7 6124.2 6140.2 6140.8 4545.2 4707.6 4724.5 4733.5 4738.7 4097.8 4175.5 4179.5 4218.5 4234.8 5974.2 5978.8 5979.6 5981.9 5984.1 6039.7 6097.5 6249.1 6260.5 6271.9 5850.5 5857.9 5899.3 5940.6 5944.6 5139.8 5175.4 5179.4 5183.3 5210.7 6416.5 6421.7 6422.2 6426.6 6436.4 6012.3 6062.7 6123.6 6141.4 6153.0 6339.9 6391.0 6402.5 6408.9 6415.2 6068.3 6072.8 6075.0 6088.2 6104.7 5992.9 6037.9 6079.6 6145.3 6213.5 5894.1 6000.7 6004.8 6034.2 6038.8 5976.6 5980.0 5981.6 6004.9 6012.4 5742.1 5810.2 5944.6 5948.6 5964.6 5982.4 5982.9 6036.0 6046.4 6094.6 5851.2 5900.9 5901.5 5911.8 5917.1 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | [#1] ext.html Cycles:180 Average:59126.10 Median:43601.17 stddev:111971.12 (256.8%) stddev-sans-first:112198.95 08:19:25 INFO - PROCESS | 18357 | Values: 579.5 600.5 631.8 648.3 651.6 42010.8 43454.7 43529.8 46924.3 47086.5 44700.8 45116.0 45368.3 45380.3 45427.0 8660.7 8816.9 8821.0 8838.9 8855.5 8648.9 8691.1 8709.3 8762.0 8801.2 8829.3 8840.6 8892.6 8894.6 8902.0 8783.6 8798.4 8840.2 8844.0 8875.3 8642.8 8676.6 8733.7 8750.1 8751.8 42316.0 42675.4 42720.4 42730.0 42746.0 3509.0 3697.2 4284.1 4297.4 4395.2 32582.8 32650.8 32691.7 32694.2 33038.3 4402.1 4466.2 4488.5 4523.8 4581.9 328520.0 329189.0 329857.0 331231.0 334588.0 58618.4 58773.0 58937.0 59006.0 59118.7 60387.1 60560.4 60636.0 61210.0 61410.4 18501.3 18603.3 18655.3 18755.8 18782.3 13453.2 13463.5 13472.7 13491.7 13510.6 15551.8 16149.3 16198.2 16214.7 16260.4 6215.2 6329.3 6364.1 6430.1 6459.9 963.9 987.4 1056.8 1071.8 1075.3 30559.7 30588.0 30866.2 30898.0 31328.0 1084.2 1106.6 1162.5 1175.5 1231.4 15504.1 15994.2 16113.8 17295.2 17566.3 520491.0 527658.0 529643.0 529954.0 532916.0 61219.0 61280.0 61383.7 61963.7 62336.7 1458.9 1483.2 1484.8 1498.8 1519.5 31646.0 32292.8 32394.4 32410.2 32810.2 55504.2 55748.4 55923.2 56240.2 56478.4 384951.0 386563.0 386578.0 387133.0 388613.0 44984.3 45861.3 45941.5 46652.3 46710.3 49409.5 49469.5 49875.8 50064.0 51302.0 41611.6 43227.4 43251.6 43672.6 44174.8 40921.6 43414.6 43511.0 43743.8 43756.8 40833.8 40996.4 41382.6 41479.2 41517.6 35105.8 37577.0 37885.6 38138.0 38392.2 28174.3 28513.1 28556.4 28557.0 28660.0 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | [#2] jquery.html Cycles:180 Average:30042.58 Median:2428.00 stddev:83975.57 (3458.6%) stddev-sans-first:84181.68 08:19:25 INFO - PROCESS | 18357 | Values: 417.6 425.3 430.8 441.7 443.2 17754.3 18403.9 19506.5 19685.2 19760.6 19476.6 19589.9 20171.2 20299.8 20332.8 5666.3 5932.5 5933.9 5948.1 5954.3 5698.6 5782.0 5858.9 5901.6 5922.9 5771.3 5773.5 5776.2 5781.5 5785.7 5604.1 5775.7 5776.3 5820.2 5895.7 5283.7 5293.8 5309.4 5310.8 5318.6 23294.0 23602.2 23776.9 23808.8 23824.5 2414.9 2441.1 2528.8 2566.9 3044.6 14395.9 15124.5 15252.1 15301.8 15707.0 2030.8 2036.8 2047.8 2054.4 2120.2 82836.6 83193.6 83971.6 84621.0 85025.0 10842.3 10949.7 11325.3 11440.5 11467.2 14012.5 14770.4 15936.2 15952.2 16009.5 8313.3 8371.8 8532.6 8540.6 8556.3 8543.0 8581.1 8622.8 8670.9 8708.7 4359.5 4506.9 4511.8 4547.5 4613.7 2025.8 2066.4 2077.0 2198.6 2223.5 904.9 984.6 994.1 1021.2 1030.0 19086.1 19412.2 19449.4 19492.6 19960.5 975.4 1032.7 1048.6 1048.7 1063.2 10501.4 10892.8 10965.7 10970.8 10997.8 500669.0 502421.0 508069.0 516007.0 518565.0 87154.6 89819.6 97474.0 98251.0 98771.0 1084.2 1111.7 1113.0 1115.2 1117.1 17390.7 17793.5 17847.0 17892.7 18167.8 31391.4 38113.4 41420.0 44480.0 45461.0 62357.7 64253.4 64318.4 65110.7 65413.0 8688.0 8692.1 8965.0 9116.8 9389.5 12420.8 12792.8 12824.7 13110.1 13754.5 10952.7 11230.3 11374.5 11415.2 11780.5 11068.8 11190.3 11733.6 11810.9 12129.4 11080.6 11465.9 11470.3 11683.3 11870.5 7698.3 8240.5 8291.9 8615.4 8952.9 9550.7 12332.7 12485.4 12587.7 12597.6 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | [#3] mootools.html Cycles:180 Average:5878.64 Median:5027.35 stddev:3271.06 (65.1%) stddev-sans-first:3263.90 08:19:25 INFO - PROCESS | 18357 | Values: 1528.8 1529.7 1725.3 1809.0 1828.8 8029.9 8309.1 8622.4 9130.7 9138.9 8316.3 8599.2 8612.7 8745.4 8789.1 2528.5 2561.5 2561.7 2561.8 2564.0 2477.5 2574.6 2612.7 2619.3 2623.5 2499.7 2504.4 2508.7 2509.0 2514.3 2439.6 2450.9 2459.0 2470.5 2476.3 2461.5 2464.3 2466.2 2485.1 2505.5 8870.1 8998.3 8998.4 9014.6 9026.1 5621.9 5751.1 5761.0 5762.1 5772.7 3451.3 3644.6 3705.4 3718.9 3736.8 1151.9 1218.5 1228.7 1235.4 1276.9 11995.3 12097.7 12103.6 12114.0 12136.7 4727.0 4787.9 4916.9 4945.4 4952.3 9740.0 9838.9 9850.4 9870.8 9882.6 5601.8 5622.9 5638.7 5655.7 5657.0 4711.6 4837.9 5102.4 5183.9 5242.9 3943.3 4016.4 4044.2 4101.5 4138.0 1237.4 1239.9 1258.1 1263.8 1278.2 865.9 875.6 964.1 973.9 975.1 5622.9 5748.7 5820.5 5968.4 6029.2 460.6 460.9 461.6 466.7 477.0 3939.7 4160.7 4163.2 4202.9 4210.0 10674.5 11181.0 11211.2 11232.5 11232.9 11013.2 11092.4 11100.2 11105.6 11107.9 8377.3 8404.5 8470.3 8523.2 8592.2 5934.9 5946.2 6017.2 6020.1 6066.9 10073.5 10163.3 10213.5 10303.3 10317.9 9904.4 10283.3 10360.3 10463.5 10530.6 6634.7 6912.9 7065.4 7499.6 7652.2 8419.7 8806.7 8843.3 8909.7 8920.9 7635.5 7664.7 7780.6 7790.5 7949.6 7709.8 7735.1 7793.9 7877.6 8041.3 7036.4 7054.9 7132.0 7150.6 7152.1 5217.3 5230.7 5292.9 5352.1 5353.5 5236.5 5247.3 5290.9 5336.3 5367.8 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | [#4] prototype.html Cycles:180 Average:4939.19 Median:5541.45 stddev:1447.20 (26.1%) stddev-sans-first:1409.57 08:19:25 INFO - PROCESS | 18357 | Values: 344.7 347.5 358.0 361.7 368.2 5431.4 5545.4 5692.1 5707.4 5732.0 5386.9 5481.3 5513.7 5523.7 5526.2 4377.0 4378.4 4383.8 4397.6 4415.4 4176.7 4336.5 4395.0 4430.9 4446.2 4364.4 4366.2 4376.9 4382.8 4385.5 4373.5 4378.7 4397.6 4400.6 4413.2 3794.9 3816.7 3933.6 3936.1 3939.0 5338.7 5428.6 5432.3 5444.4 5506.5 4940.7 4942.5 4947.3 4961.5 5003.4 5672.9 5797.6 5816.4 5866.6 5886.1 4213.3 4230.0 4240.7 4257.8 4268.3 6076.3 6097.9 6098.2 6100.9 6130.8 4257.9 4259.2 4331.6 4345.2 4366.5 4367.1 4368.0 4392.5 4402.2 4412.3 4999.9 5016.2 5026.2 5029.3 5040.2 5726.4 5747.0 5869.9 5879.4 5932.3 1463.1 1466.8 1472.7 1482.8 1486.6 1004.9 1019.1 1023.7 1032.2 1036.3 5523.5 5545.7 5549.5 5587.7 5591.7 5836.8 5865.9 5875.5 5887.9 5916.4 5384.7 5499.3 5529.4 5537.4 5564.4 3085.6 3089.3 3093.4 3095.5 3103.0 5921.3 6024.6 6027.3 6032.2 6061.1 6134.4 6188.6 6192.7 6194.4 6229.9 6293.4 6308.4 6313.0 6331.3 6336.7 5971.4 6017.9 6045.6 6050.5 6065.8 5933.6 5960.8 5975.0 6010.0 6041.9 6085.6 6230.9 6255.0 6265.0 6272.9 4334.0 4354.7 4358.1 4367.8 4422.0 5879.6 6020.0 6098.9 6134.6 6159.7 5766.8 5780.3 5857.6 5862.7 5874.4 5891.9 5891.9 5893.7 5901.6 5916.6 5639.9 5768.0 5797.3 5802.9 5804.3 5849.4 5900.1 5910.9 5914.0 5932.2 5678.0 5709.7 5788.2 5790.9 5792.9 08:19:25 INFO - PROCESS | 18357 | 08:19:25 INFO - PROCESS | 18357 | [#5] yui.html Cycles:180 Average:16999.98 Median:4840.47 stddev:21589.79 (446.0%) stddev-sans-first:21615.97 08:19:25 INFO - PROCESS | 18357 | Values: 773.0 794.3 805.9 853.7 858.5 14863.9 15191.2 15541.4 15551.0 15602.3 13513.0 13675.6 14950.6 15673.7 15834.0 847.1 864.2 865.4 868.2 869.1 856.7 859.3 861.7 861.8 862.9 894.0 898.8 901.4 901.6 902.7 886.9 895.7 896.0 896.9 898.1 655.5 658.2 659.5 660.2 664.2 15106.3 15199.8 15259.1 15271.9 15330.9 13681.9 14387.3 14432.6 14697.3 15034.2 11583.5 11659.5 11671.6 11682.1 11938.2 3761.3 3772.2 3788.2 3805.6 3954.8 54557.5 56040.4 65942.0 66165.0 66362.0 10431.7 11374.7 11460.4 11523.2 11681.1 20397.4 20412.6 20460.3 20541.3 20577.2 8668.4 8742.8 8818.0 8900.6 9195.9 4632.6 4694.7 4733.0 4822.3 4858.7 3415.8 3447.5 3479.1 3711.9 3876.8 670.8 671.5 673.5 673.9 713.0 663.9 698.8 740.7 758.2 771.8 8745.3 9321.7 9655.6 10192.7 10261.6 616.7 657.6 679.7 745.0 757.0 4486.3 4496.4 4599.9 4700.4 4782.4 52194.7 52324.0 52456.0 76325.0 85515.6 47819.3 49539.8 58554.0 79513.6 80436.0 66995.0 67720.3 70948.0 72911.6 75263.0 8734.2 8762.6 8798.5 8821.0 9046.6 47942.5 48705.3 50029.0 50303.2 50453.7 65241.3 65281.7 65390.0 67194.3 69756.3 11034.7 11329.4 11496.6 11571.1 11909.6 13282.6 13567.1 13614.2 13798.2 14497.2 11844.6 12028.9 12241.3 12382.4 12502.7 11389.5 11490.6 11621.2 12017.2 12036.9 12173.3 12266.9 12292.8 12510.2 13065.2 9945.2 10200.8 10201.2 10444.4 10495.9 9572.3 10232.7 10267.7 10304.4 10345.6 08:19:25 INFO - PROCESS | 18357 | -------- Summary: end -------- 08:19:25 INFO - PROCESS | 18357 | 08:19:26 INFO - TEST-INFO | 18357: exit 0 08:19:26 INFO - TEST-OK | dromaeo_css | took 1112838ms 08:19:26 INFO - TEST-START | kraken 08:19:26 INFO - operating with platform_type : linux_ 08:19:26 INFO - Initialising browser for kraken test... 08:19:26 INFO - TEST-INFO | started process 18736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGnqiL/profile http://localhost:45655/getInfo.html) 08:19:30 INFO - PROCESS | 18736 | __metrics Screen width/height:1600/1200 08:19:30 INFO - PROCESS | 18736 | colorDepth:24 08:19:30 INFO - PROCESS | 18736 | Browser inner width/height: 1024/697 08:19:30 INFO - PROCESS | 18736 | __metrics 08:19:30 ERROR - PROCESS | 18736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:19:31 INFO - TEST-INFO | 18736: exit 0 08:19:31 INFO - Browser initialized. 08:19:31 INFO - Running cycle 1/1 for kraken test... 08:19:31 INFO - TEST-INFO | started process 18867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHGnqiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:43 INFO - PROCESS | 18867 | RSS: Main: 152059904 08:19:43 INFO - PROCESS | 18867 | 08:19:46 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45655/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:47 INFO - PROCESS | 18867 | RSS: Main: 157065216 08:19:47 INFO - PROCESS | 18867 | 08:19:49 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45655/tests/kraken/driver.html?testName=audio-dft) 08:19:50 INFO - PROCESS | 18867 | RSS: Main: 155099136 08:19:50 INFO - PROCESS | 18867 | 08:19:53 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45655/tests/kraken/driver.html?testName=audio-fft) 08:19:53 INFO - PROCESS | 18867 | RSS: Main: 155389952 08:19:53 INFO - PROCESS | 18867 | 08:19:55 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45655/tests/kraken/driver.html?testName=audio-oscillator) 08:19:56 INFO - PROCESS | 18867 | RSS: Main: 155254784 08:19:56 INFO - PROCESS | 18867 | 08:19:58 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:59 INFO - PROCESS | 18867 | RSS: Main: 155136000 08:19:59 INFO - PROCESS | 18867 | 08:20:02 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45655/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:02 INFO - PROCESS | 18867 | RSS: Main: 158105600 08:20:02 INFO - PROCESS | 18867 | 08:20:06 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45655/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:06 INFO - PROCESS | 18867 | RSS: Main: 158490624 08:20:06 INFO - PROCESS | 18867 | 08:20:09 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45655/tests/kraken/driver.html?testName=json-parse-financial) 08:20:10 INFO - PROCESS | 18867 | RSS: Main: 158158848 08:20:10 INFO - PROCESS | 18867 | 08:20:11 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:12 INFO - PROCESS | 18867 | RSS: Main: 156852224 08:20:12 INFO - PROCESS | 18867 | 08:20:14 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:14 INFO - PROCESS | 18867 | RSS: Main: 157392896 08:20:14 INFO - PROCESS | 18867 | 08:20:16 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:17 INFO - PROCESS | 18867 | RSS: Main: 157548544 08:20:17 INFO - PROCESS | 18867 | 08:20:20 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:20 INFO - PROCESS | 18867 | RSS: Main: 157347840 08:20:20 INFO - PROCESS | 18867 | 08:20:23 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:24 INFO - PROCESS | 18867 | RSS: Main: 157839360 08:20:24 INFO - PROCESS | 18867 | 08:20:25 INFO - PROCESS | 18867 | Cycle 1(1): loaded http://localhost:45655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45655/tests/kraken/driver.html?testName=ai-astar) 08:20:26 INFO - PROCESS | 18867 | RSS: Main: 159211520 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | __start_tp_report 08:20:26 INFO - PROCESS | 18867 | _x_x_mozilla_page_load 08:20:26 INFO - PROCESS | 18867 | _x_x_mozilla_page_load_details 08:20:26 INFO - PROCESS | 18867 | |i|pagename|runs| 08:20:26 INFO - PROCESS | 18867 | |0;ai-astar;102;114;113;114;113;114;114;115;113;113 08:20:26 INFO - PROCESS | 18867 | |1;audio-beat-detection;156;124;122;162;124;124;128;126;163;126 08:20:26 INFO - PROCESS | 18867 | |2;audio-dft;163;164;163;163;162;163;165;164;162;162 08:20:26 INFO - PROCESS | 18867 | |3;audio-fft;75;76;77;107;77;79;78;78;97;77 08:20:26 INFO - PROCESS | 18867 | |4;audio-oscillator;81;81;114;82;81;81;111;84;85;103 08:20:26 INFO - PROCESS | 18867 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;118;118;118 08:20:26 INFO - PROCESS | 18867 | |6;imaging-darkroom;148;148;147;147;147;147;148;148;148;148 08:20:26 INFO - PROCESS | 18867 | |7;imaging-desaturate;85;86;86;86;84;85;86;86;85;88 08:20:26 INFO - PROCESS | 18867 | |8;json-parse-financial;55;53;55;53;59;54;53;58;52;63 08:20:26 INFO - PROCESS | 18867 | |9;json-stringify-tinderbox;59;58;59;58;59;60;59;59;59;61 08:20:26 INFO - PROCESS | 18867 | |10;stanford-crypto-aes;75;74;76;76;76;76;81;75;81;75 08:20:26 INFO - PROCESS | 18867 | |11;stanford-crypto-ccm;139;126;138;128;139;128;127;130;184;140 08:20:26 INFO - PROCESS | 18867 | |12;stanford-crypto-pbkdf2;163;161;163;161;160;157;159;163;159;161 08:20:26 INFO - PROCESS | 18867 | |13;stanford-crypto-sha256-iterative;63;67;64;64;64;64;63;64;63;63 08:20:26 INFO - PROCESS | 18867 | __end_tp_report 08:20:26 INFO - PROCESS | 18867 | __start_cc_report 08:20:26 INFO - PROCESS | 18867 | _x_x_mozilla_cycle_collect,822 08:20:26 INFO - PROCESS | 18867 | __end_cc_report 08:20:26 INFO - PROCESS | 18867 | __startTimestamp1481127626039__endTimestamp 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | ------- Summary: start ------- 08:20:26 INFO - PROCESS | 18867 | Number of tests: 14 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.75 (3.3%) stddev-sans-first:0.71 08:20:26 INFO - PROCESS | 18867 | Values: 102.0 114.0 113.0 114.0 113.0 114.0 114.0 115.0 113.0 113.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:127.00 stddev:17.30 (13.6%) stddev-sans-first:16.69 08:20:26 INFO - PROCESS | 18867 | Values: 156.0 124.0 122.0 162.0 124.0 124.0 128.0 126.0 163.0 126.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 08:20:26 INFO - PROCESS | 18867 | Values: 163.0 164.0 163.0 163.0 162.0 163.0 165.0 164.0 162.0 162.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.50 stddev:10.81 (13.9%) stddev-sans-first:11.15 08:20:26 INFO - PROCESS | 18867 | Values: 75.0 76.0 77.0 107.0 77.0 79.0 78.0 78.0 97.0 77.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.00 stddev:13.47 (16.6%) stddev-sans-first:13.87 08:20:26 INFO - PROCESS | 18867 | Values: 81.0 81.0 114.0 82.0 81.0 81.0 111.0 84.0 85.0 103.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:20:26 INFO - PROCESS | 18867 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 08:20:26 INFO - PROCESS | 18867 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.06 (1.2%) stddev-sans-first:1.09 08:20:26 INFO - PROCESS | 18867 | Values: 85.0 86.0 86.0 86.0 84.0 85.0 86.0 86.0 85.0 88.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.47 (6.3%) stddev-sans-first:3.68 08:20:26 INFO - PROCESS | 18867 | Values: 55.0 53.0 55.0 53.0 59.0 54.0 53.0 58.0 52.0 63.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 08:20:26 INFO - PROCESS | 18867 | Values: 59.0 58.0 59.0 58.0 59.0 60.0 59.0 59.0 59.0 61.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:2.46 (3.2%) stddev-sans-first:2.55 08:20:26 INFO - PROCESS | 18867 | Values: 75.0 74.0 76.0 76.0 76.0 76.0 81.0 75.0 81.0 75.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.50 stddev:17.16 (12.4%) stddev-sans-first:18.20 08:20:26 INFO - PROCESS | 18867 | Values: 139.0 126.0 138.0 128.0 139.0 128.0 127.0 130.0 184.0 140.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.00 (1.2%) stddev-sans-first:1.94 08:20:26 INFO - PROCESS | 18867 | Values: 163.0 161.0 163.0 161.0 160.0 157.0 159.0 163.0 159.0 161.0 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - PROCESS | 18867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.22 08:20:26 INFO - PROCESS | 18867 | Values: 63.0 67.0 64.0 64.0 64.0 64.0 63.0 64.0 63.0 63.0 08:20:26 INFO - PROCESS | 18867 | -------- Summary: end -------- 08:20:26 INFO - PROCESS | 18867 | 08:20:26 INFO - TEST-INFO | 18867: exit 0 08:20:27 INFO - TEST-OK | kraken | took 60656ms 08:20:27 INFO - SUITE-END | took 1173s 08:20:27 INFO - Completed test suite (00:19:33) 08:20:27 INFO - javascript benchmark 08:20:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7414.3052138100575, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.375018746438, 3314.403407386671, 3323.135984643993, 3334.4498157803964, 3334.9666503334965, 5701.315842098948, 5721.799737009201, 5736.282964629421, 5755.366909639936, 5764.596478246519, 5737.426257374261, 5748.281464816898, 5764.048931926227, 5789.565782566303, 5809.157672137548, 5181.844544663657, 5233.947660523384, 5248.973755131238, 5277.3139491866195, 5278.920816187741, 5289.497497737709, 5291.28567643367, 5296.285001524802, 5311.203319502067, 5338.546223571001, 5139.383274007125, 5165.948340516585, 5258.079836028699, 5267.736613169345, 5279.3928698199625, 5176.223566465042, 5196.610254230948, 5208.817691380802, 5214.713190774506, 5246.291750613656, 5121.820736274212, 5210.687358758449, 5248.763805628718, 5251.0, 5279.973600132013, 5592.3009623797025, 5706.629069110536, 5735.541156707453, 5743.597948143632, 5808.622439541458, 6040.728167232485, 6104.450599446027, 6128.754849806002, 6157.630542167484, 6187.226596675416, 6087.178230938811, 6185.56701030928, 6197.959305924386, 6200.348963358872, 6229.3459186785185, 5581.134924086732, 5595.272614560081, 5628.859278517988, 5777.942220577783, 5833.037548804485, 6060.484858787053, 6139.57023008394, 6140.0134868502855, 6151.569390142737, 6159.23009623797, 5900.64596124234, 5909.084091965752, 5914.378990206053, 5919.260092488439, 5924.851878703067, 5980.700964951735, 5984.281886173687, 5990.460858522754, 6003.369646187175, 6006.639601623917, 6038.245219347582, 6064.727087281083, 6079.240094988127, 6126.540509461808, 6142.099766648122, 6068.0, 6105.694715264219, 6124.173236613, 6140.232470941132, 6140.815775526741, 4545.181867263925, 4707.6233901287815, 4724.480307166209, 4733.5266473352385, 4738.715677059387, 4097.836086556505, 4175.498940127204, 4179.519355274121, 4218.514870789837, 4234.767087810138, 5974.163617093611, 5978.8206353809455, 5979.611325263844, 5981.910271345933, 5984.072468767348, 6039.728212230372, 6097.4817140543555, 6249.0938813871735, 6260.530460215502, 6271.905921411182, 5850.47345738877, 5857.88284234313, 5899.321578018583, 5940.584159108821, 5944.613600115978, 5139.8458046258675, 5175.378954525481, 5179.404368497671, 5183.300254465599, 5210.739463026834, 6416.454601358843, 6421.711023003976, 6422.229332480132, 6426.582272152295, 6436.388543088399, 6012.278526576839, 6062.7271772769445, 6123.5876691309595, 6141.3551577085545, 6152.969235153795, 6339.90490142639, 6390.968045159744, 6402.519811014286, 6408.935910640834, 6415.166028416276, 6068.332483426908, 6072.787452439144, 6075.0, 6088.178095957166, 6104.694765261808, 5992.8501787453915, 6037.939620603738, 6079.635221886701, 6145.293291271382, 6213.502919766498, 5894.086416605433, 6000.699965001645, 6004.849878753066, 6034.2155519782145, 6038.849028774316, 5976.641401515923, 5979.953508135972, 5981.551383646157, 6004.949133901462, 6012.368701286302, 5742.109972954198, 5810.186573879576, 5944.64332140073, 5948.583599148018, 5964.5526585505395, 5982.4017598239825, 5982.850428739316, 6036.0, 6046.365131661112, 6094.603850749687, 5851.1515830205235, 5900.852478687895, 5901.498372638202, 5911.793087241926, 5917.142014407973], "value": 5652.520683718283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4871538688262, 600.5435868739758, 631.7978246960973, 648.3160265919456, 651.6318280171705, 42010.78994605027, 43454.696359109235, 43529.78235108824, 46924.296135558, 47086.529134708646, 44700.776496117556, 45116.0, 45368.31947520781, 45380.3192952106, 45427.0, 8660.69687560934, 8816.8677469838, 8821.0, 8838.911610883873, 8855.512946787923, 8648.870266946002, 8691.130886911289, 8709.25971292441, 8761.95619021904, 8801.207891289783, 8829.337799665018, 8840.646374145026, 8892.599833007498, 8894.644214231455, 8901.955490222539, 8783.604737786814, 8798.428102173339, 8840.204381605654, 8843.95578022109, 8875.334349923782, 8642.783930401727, 8676.60955257015, 8733.737987860375, 8750.081241469681, 8751.781205469913, 42316.0, 42675.35986960198, 42720.35919461211, 42730.0, 42746.0, 3508.982455087734, 3697.2235830475634, 4284.057507348379, 4297.419848320468, 4395.1868904252815, 32582.83708581442, 32650.83674581612, 32691.6730832691, 32694.182645433815, 33038.33923321544, 4402.075564131536, 4466.218411777926, 4488.483824360208, 4523.819047238107, 4581.908361832745, 328519.9999999976, 329189.0, 329857.0, 331231.0, 334588.0, 58618.41381586215, 58773.0, 58937.0, 59006.0, 59118.70440647855, 60387.09419358713, 60560.394396056356, 60636.0, 61210.0, 61410.38589614136, 18501.259949602136, 18603.25586976533, 18655.347062852736, 18755.812441875405, 18782.342618008304, 13453.192808431526, 13463.528776492776, 13472.730545389037, 13491.730165396637, 13510.594682159552, 15551.766723499157, 16149.273282702306, 16198.190090495427, 16214.675706485805, 16260.430884919208, 6215.160953271341, 6329.303776584572, 6364.109024736541, 6430.067640192239, 6459.870802583922, 963.8843338799248, 987.4124895687055, 1056.793925184597, 1071.8487646319795, 1075.2688172043086, 30559.694403055684, 30588.0, 30866.228344291125, 30898.0, 31328.0, 1084.1868598551087, 1106.5629076514892, 1162.5001249462812, 1175.494537348931, 1231.384307846077, 15504.147271900154, 15994.200289985687, 16113.838861611468, 17295.221715022853, 17566.297348105934, 520491.0, 527658.0, 529643.0, 529954.0, 532916.0, 61219.0, 61280.0, 61383.69308153431, 61963.6901815488, 62336.688316558124, 1458.8905832062637, 1483.1768368555556, 1484.7921291019265, 1498.8276348219877, 1519.4833756522835, 31646.0, 32292.838535807172, 32394.35211295808, 32410.189745256557, 32810.17974550655, 55504.167437489275, 55748.442515575945, 55923.161152583554, 56240.156397654886, 56478.43521564732, 384951.0, 386563.0, 386578.0, 387133.0, 388613.0, 44984.32523512215, 45861.31208031815, 45941.54058459373, 46652.300215496114, 46710.299345510524, 49409.50590494193, 49469.50530494649, 49875.75062124812, 50064.0, 51302.0, 41611.58388416077, 43227.35158972555, 43251.567484324754, 43672.56327436685, 44174.779126104164, 40921.59078409178, 43414.580610403085, 43511.0, 43743.78128109339, 43756.78121609499, 40833.79583102065, 40996.385054224804, 41382.586174137876, 41479.170416590896, 41517.584824151374, 35105.82447087748, 37576.99282149659, 37885.62114378821, 38138.0, 38392.2321553573, 28174.2956426091, 28513.144605661862, 28556.42887142287, 28557.0, 28660.0], "value": 20591.696410019562, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.6199658310938, 425.34921569997897, 430.81972978517626, 441.6665417609704, 443.2464809823303, 17754.289828406865, 18403.907980460113, 19506.512337191576, 19685.21259149634, 19760.604787904234, 19476.636635435527, 19589.902050489763, 20171.193152273892, 20299.797002030013, 20332.796672033277, 5666.263385759856, 5932.495737862287, 5933.851653708649, 5948.078047902582, 5954.255718035246, 5698.629589076697, 5781.971090144543, 5858.912116318259, 5901.616394934337, 5922.851928701773, 5771.307443106812, 5773.48038676519, 5776.220210271623, 5781.479666829984, 5785.681787501686, 5604.075327570946, 5775.653460792366, 5776.335721392031, 5820.185174075633, 5895.675737834417, 5283.682979021271, 5293.7617807198385, 5309.36287645485, 5310.7610157543, 5318.627696061278, 23294.0, 23602.173923912753, 23776.88111559431, 23808.761912381, 23824.523509529714, 2414.915477958263, 2441.084593277521, 2528.8103392245657, 2566.8973241070335, 3044.6194225721783, 14395.856041439662, 15124.470643527533, 15252.084874907541, 15301.846981530265, 15707.0, 2030.8273796727149, 2036.7861374555607, 2047.819072687583, 2054.4247610668885, 2120.236714782677, 82836.58581707113, 83193.58403208006, 83971.58014209951, 84621.0, 85025.0, 10842.29525080883, 10949.671509854717, 11325.32048077118, 11440.485178167002, 11467.197296189186, 14012.509562165274, 14770.409183632535, 15936.203189840462, 15952.20238988046, 16009.519714408587, 8313.293370063613, 8371.832563348698, 8532.616032278562, 8540.572971351408, 8556.272716819016, 8543.0, 8581.056083830774, 8622.82754344922, 8670.913290867136, 8708.651653933899, 4359.542248063971, 4506.909861802746, 4511.826924999524, 4547.522510136454, 4613.746243956548, 2025.8379329653592, 2066.359428577146, 2077.0341791067226, 2198.6482162853868, 2223.5102481337544, 904.8733177355175, 984.601236499219, 994.0854413939194, 1021.2289721260549, 1030.0111892583054, 19086.141123649468, 19412.22351105968, 19449.4165175045, 19492.610147797248, 19960.50098747543, 975.351391324761, 1032.6747074671455, 1048.554364395129, 1048.7483004078965, 1063.2291588598205, 10501.369917804956, 10892.836607450894, 10965.671029869116, 10970.780584388267, 10997.780044399067, 500669.0, 502421.0, 508069.0, 516007.0, 518565.0, 87154.56422717846, 89819.55090224638, 97474.0, 98251.0, 98771.0, 1084.208527774729, 1111.7053980695123, 1113.0261021606095, 1115.1580556679655, 1117.0672488472055, 17390.73913891318, 17793.466196014142, 17847.0, 17892.731609025614, 18167.81832181714, 31391.372172555963, 38113.428298576095, 41419.96450088772, 44480.0, 45461.0, 62357.68821156047, 64253.357466424735, 64318.35681643124, 65110.67444662746, 65413.0, 8687.956560217159, 8692.087330830173, 8965.0, 9116.772080698036, 9389.530523473935, 12420.813687794871, 12792.808107878576, 12824.743505129658, 13110.147840390344, 13754.518591849237, 10952.726181845517, 11230.270032447865, 11374.54501819918, 11415.200935934405, 11780.469878855643, 11068.778624427305, 11190.272632278877, 11733.647990560297, 11810.881891180978, 12129.393530323625, 11080.61217857371, 11465.885341146482, 11470.254433461798, 11683.299002059903, 11870.465829037541, 7698.34564062061, 8240.546769927712, 8291.875621865798, 8615.353848461265, 8952.865707014269, 9550.713478595653, 12332.691682708004, 12485.438155282853, 12587.678293779021, 12597.622071337875], "value": 9533.922010945611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.778327142564, 1529.717002354564, 1725.3271224222547, 1808.9547761305957, 1828.8262615051574, 8029.879551806713, 8309.086000539952, 8622.396432249745, 9130.726078217656, 9138.862917056249, 8316.334693224542, 8599.226069653745, 8612.698555550556, 8745.387822852403, 8789.077146899579, 2528.4943011397704, 2561.526117668228, 2561.6541766861424, 2561.7950563954837, 2564.038485567912, 2477.52926943881, 2574.6266791315247, 2612.686477622688, 2619.266605350505, 2623.527765002299, 2499.7250302466805, 2504.4365017871014, 2508.686414198225, 2508.9623655645178, 2514.308565144591, 2439.6462512935614, 2450.8652024138664, 2458.950820983588, 2470.493548822487, 2476.2818782553036, 2461.4953934443574, 2464.3099932018886, 2466.198485492222, 2485.0556788420286, 2505.523950449409, 8870.068642792543, 8998.325125615605, 8998.415103018348, 9014.639414423415, 9026.097390260988, 5621.8594535136945, 5751.1085781703905, 5760.971195143998, 5762.078067509178, 5772.682502462363, 3451.3442445935193, 3644.6355364463607, 3705.370087085202, 3718.925621487555, 3736.813159342022, 1151.8617765868066, 1218.469965564973, 1228.6744012836605, 1235.3946566182597, 1276.8595454499998, 11995.28028318295, 12097.697557561043, 12103.576374826927, 12114.0, 12136.696582585419, 4726.983698504838, 4787.928181077286, 4916.926246106311, 4945.406551213878, 4952.257161425815, 9739.951300243454, 9838.852417213748, 9850.359726617748, 9870.802583948282, 9882.555285012191, 5601.831945041574, 5622.887542249132, 5638.718064096779, 5655.688937108499, 5657.010023245915, 4711.552402521755, 4837.9032419351415, 5102.438731739506, 5183.870403239949, 5242.947570524322, 3943.2507823513442, 4016.3975403689096, 4044.1911617676583, 4101.466809314829, 4138.048248902769, 1237.3936770982154, 1239.8698136695516, 1258.10674421162, 1263.8041103628952, 1278.2202856257675, 865.8744482050067, 875.6103533927342, 964.0985678390728, 973.9384071362249, 975.0882924465648, 5622.91565626516, 5748.712564371848, 5820.476157145792, 5968.403159683997, 6029.246344206974, 460.56016504238374, 460.9101225261109, 461.6399208617284, 466.71763583031776, 476.95707386334703, 3939.7439166454087, 4160.687948403882, 4163.188178305262, 4202.936955945664, 4209.957900420956, 10674.519646615921, 11181.0, 11211.159163062803, 11232.494537745657, 11232.943835280772, 11013.229073964905, 11092.389918554558, 11100.167487438313, 11105.555777768799, 11107.944460277648, 8377.287930525974, 8404.495730256082, 8470.32237421017, 8523.232909038215, 8592.226699597066, 5934.9109763354445, 5946.226990491208, 6017.157597936205, 6020.1270815730595, 6066.908996364969, 10073.546690398804, 10163.339382940085, 10213.489325533545, 10303.278770485995, 10317.9484102579, 9904.356216845881, 10283.33158344735, 10360.274780765274, 10463.476826158814, 10530.578776849146, 6634.668266586747, 6912.930870691229, 7065.399441047569, 7499.587522686086, 7652.234776522303, 8419.70531031411, 8806.691765788166, 8843.292536597186, 8909.73270801877, 8920.86618700707, 7635.465517413728, 7664.6550905210515, 7780.649870755943, 7790.493617914817, 7949.642266097924, 7709.807254818675, 7735.110462296908, 7793.9220607793195, 7877.645505952131, 8041.276285134366, 7036.401905837856, 7054.894176587458, 7131.964340178266, 7150.570965742072, 7152.141742990874, 5217.269582258411, 5230.7384630769075, 5292.9206061908335, 5352.090144675492, 5353.464653534771, 5236.476352364733, 5247.291615631993, 5290.920636190537, 5336.332958380202, 5367.785288588413], "value": 4672.356646443658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.66567429593283, 347.5464518802962, 358.02081307623644, 361.7287034723957, 368.22672387985233, 5431.375391829931, 5545.445455454463, 5692.060809966356, 5707.400722924091, 5731.993802169244, 5386.91919621206, 5481.287432633762, 5513.724313784305, 5523.7238138093135, 5526.203983705292, 4376.978115109428, 4378.40891479651, 4383.780810959455, 4397.604215620593, 4415.359772832937, 4176.749395036292, 4336.544662810406, 4394.956050439487, 4430.939613079917, 4446.2219111655495, 4364.432623758907, 4366.2359087159775, 4376.912461750763, 4382.758948257844, 4385.495667998173, 4373.475182978047, 4378.6715996300245, 4397.614751353313, 4400.647948164139, 4413.205622987861, 3794.924101517954, 3816.732828701992, 3933.567307596162, 3936.094698219397, 3938.991114531581, 5338.652987555835, 5428.565714742851, 5432.348118225838, 5444.373897001856, 5506.531944784658, 4940.6788558743565, 4942.481039490874, 4947.282644016597, 4961.469650478246, 5003.449620541774, 5672.9432705672825, 5797.565182611321, 5816.447437493432, 5866.589338746289, 5886.146508756249, 4213.346931225634, 4229.97885010576, 4240.681948853849, 4257.787110644486, 4268.253055715238, 6076.301225359096, 6097.908531372033, 6098.23772028492, 6100.877982440326, 6130.846728831815, 4257.91484170321, 4259.190753756776, 4331.610155086058, 4345.239583072949, 4366.519682834885, 4367.100311364567, 4367.978160109179, 4392.472903251631, 4402.163588918095, 4412.33814927757, 4999.875028118717, 5016.1723315653235, 5026.195808670668, 5029.270755740397, 5040.218766091261, 5726.398728133569, 5746.9712651436475, 5869.853253668693, 5879.382664820132, 5932.3474417814, 1463.1075044223016, 1466.7506523890963, 1472.7201831652167, 1482.8294746104336, 1486.6060493969107, 1004.9346792458467, 1019.1337363241186, 1023.7305740881253, 1032.2361452525226, 1036.2953191829629, 5523.536262890338, 5545.694986775766, 5549.500544950974, 5587.664740115606, 5591.692456914828, 5836.832633473237, 5865.885481758452, 5875.532276443904, 5887.882242355215, 5916.408359164049, 5384.703841288689, 5499.257600223998, 5529.364123125812, 5537.446255374431, 5564.360098588633, 3085.6451508076857, 3089.335792804558, 3093.427715872571, 3095.4892442747146, 3102.9844850776053, 5921.259842519685, 6024.608400453956, 6027.336992930774, 6032.1856549365275, 6061.060535616986, 6134.355892631299, 6188.566800323934, 6192.721327540272, 6194.38056194377, 6229.937700623026, 6293.37066293367, 6308.432241098323, 6313.02148167044, 6331.271903731038, 6336.746530138835, 5971.373005834324, 6017.909731353946, 6045.637261764308, 6050.45545900871, 6065.8180254592435, 5933.643981361132, 5960.821175364746, 5974.970125149346, 6009.969950150221, 6041.909371359346, 6085.618354784548, 6230.875382492415, 6254.998400511792, 6264.992803454458, 6272.937270627235, 4333.956660433355, 4354.738715677069, 4358.128374325084, 4367.781610919378, 4421.955780442283, 5879.647681033301, 6020.0, 6098.939010609837, 6134.631922084689, 6159.692015399122, 5766.808612727137, 5780.306363236438, 5857.648541087548, 5862.706864656665, 5874.383189765013, 5891.852703682443, 5891.9116213255975, 5893.675847828411, 5901.645901245767, 5916.55625828056, 5639.893733895239, 5768.02006615434, 5797.304323481209, 5802.883942321046, 5804.2744656917885, 5849.356570777296, 5900.1149827526215, 5910.911336329872, 5914.0, 5932.228810254639, 5678.047415343915, 5709.743061562157, 5788.189653448437, 5790.913136302875, 5792.942070579409], "value": 4479.40592975583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.0144066315447, 794.3208556684035, 805.858974679431, 853.6969375871562, 858.4977787994026, 14863.851361486382, 15191.164485953268, 15541.378344866192, 15550.989185702922, 15602.297896594651, 13513.0, 13675.589732308023, 14950.551483455514, 15673.686526269468, 15834.0, 847.1401527449628, 864.2135656552539, 865.4461144867258, 868.1665601023026, 869.0961400143843, 856.6530555125153, 859.3468963587655, 861.7371701631, 861.7931696392852, 862.9439086459391, 894.0389081737159, 898.8292224477361, 901.4320977783987, 901.589776651622, 902.7246689759621, 886.898006729228, 895.7088946092481, 896.0457113174448, 896.9282457403425, 898.0884402331606, 655.5476721062452, 658.1575583253443, 659.4757168051362, 660.1615947746383, 664.1565212180503, 15106.320215590215, 15199.848001519953, 15259.084454932628, 15271.923640381838, 15330.923345383313, 13681.931590341985, 14387.28063596816, 14432.567022989328, 14697.26513674312, 15034.248287585577, 11583.47874345648, 11659.475323610457, 11671.591494297743, 11682.065434765198, 11938.224015439055, 3761.3430805339835, 3772.2078363543687, 3788.2423515296773, 3805.6384643458828, 3954.762714237155, 54557.45442545563, 56040.43959560393, 65942.0, 66165.0, 66362.0, 10431.68704938853, 11374.715632109264, 11460.426978651034, 11523.193376463567, 11681.065514758799, 20397.38807835767, 20412.591748164952, 20460.283890064075, 20541.281055163, 20577.176912923616, 8668.393212475066, 8742.80920421861, 8818.0, 8900.554972251492, 9195.862062069074, 4632.60622847055, 4694.718316900997, 4732.95267047332, 4822.252550854623, 4858.684185527929, 3415.829208539613, 3447.465642825366, 3479.0954351868695, 3711.8515259389324, 3876.7673939563715, 670.792054463118, 671.516508114157, 673.5419914458117, 673.8618583190532, 712.9928700712926, 663.9476429858631, 698.7833771530842, 740.7481456304882, 758.1584441270186, 771.8224808294124, 8745.256653184424, 9321.72034838956, 9655.613775449045, 10192.694219173436, 10261.640842570474, 616.6608365399013, 657.6251536624078, 679.7281087564915, 744.95530268183, 756.9659365328573, 4486.327050942385, 4496.437945256843, 4599.931001034987, 4700.435947686231, 4782.426108866958, 52194.739026304625, 52324.0, 52456.0, 76325.0, 85515.57242213748, 47819.28271075937, 49539.75230123899, 58554.0, 79513.60243198747, 80436.0, 66995.0, 67720.3227967714, 70948.0, 72911.63544182245, 75263.0, 8734.213920747163, 8762.649494020168, 8798.47209167452, 8820.955895220482, 9046.592903319499, 47942.52057479381, 48705.26942095801, 50028.99942001212, 50303.245451318995, 50453.74773126111, 65241.34758652543, 65281.67359163364, 65390.0, 67194.3280567188, 69756.30243697498, 11034.724131896446, 11329.433528323387, 11496.597619083292, 11571.13216508782, 11909.583164589545, 13282.601521954357, 13567.118137321437, 13614.18314901109, 13798.241096739775, 14497.20265385414, 11844.585439509576, 12028.939855300667, 12241.326727030098, 12382.442790074288, 12502.687432814253, 11389.544418223179, 11490.597829075943, 11621.24461909973, 12017.158798883995, 12036.879631203576, 12173.330466824409, 12266.938665306616, 12292.815607765711, 12510.18683785551, 13065.216087034809, 9945.204383649436, 10200.795984080425, 10201.234907381828, 10444.42555659446, 10495.947520262655, 9572.282078843975, 10232.693019209435, 10267.691969240936, 10304.433256170983, 10345.586176552853], "value": 7151.840674439211, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 115.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 122.0, 162.0, 124.0, 124.0, 128.0, 126.0, 163.0, 126.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 162.0, 163.0, 165.0, 164.0, 162.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 107.0, 77.0, 79.0, 78.0, 78.0, 97.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 82.0, 81.0, 81.0, 111.0, 84.0, 85.0, 103.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 84.0, 85.0, 86.0, 86.0, 85.0, 88.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 53.0, 59.0, 54.0, 53.0, 58.0, 52.0, 63.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 61.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 76.0, 76.0, 76.0, 81.0, 75.0, 81.0, 75.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 126.0, 138.0, 128.0, 139.0, 128.0, 127.0, 130.0, 184.0, 140.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 160.0, 157.0, 159.0, 163.0, 159.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 63.9, "unit": "score"}]}]} 08:20:27 INFO - Return code: 0 08:20:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:27 ERROR - # TBPL SUCCESS # 08:20:27 INFO - Running post-action listener: _resource_record_post_action 08:20:27 INFO - [mozharness: 2016-12-07 16:20:27.348640Z] Finished run-tests step (success) 08:20:27 INFO - Running post-run listener: _resource_record_post_run 08:20:27 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368361472; Read time: 16; Write time: 240092 08:20:27 INFO - TinderboxPrint: CPU usage
13.3% 08:20:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:20:27 INFO - TinderboxPrint: I/O write bytes / time
368,361,472 / 240,092 08:20:27 INFO - TinderboxPrint: CPU idle
8,230.5 (86.7%) 08:20:27 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 08:20:27 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119148544; Read time: 0; Write time: 95632 08:20:27 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 249212928; Read time: 0; Write time: 144460 08:20:27 INFO - Running post-run listener: _upload_blobber_files 08:20:27 INFO - Blob upload gear active. 08:20:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:27 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 08:20:27 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'] 08:20:27 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 08:20:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:20:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:29 INFO - (blobuploader) - INFO - Done attempting. 08:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:32 INFO - (blobuploader) - INFO - Done attempting. 08:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:33 INFO - (blobuploader) - INFO - Done attempting. 08:20:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:33 INFO - Return code: 0 08:20:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/935bbd6ea91adf4d234fa64cbb05cde9423efd086419402bb57301eba37080209206555c4d5eec639b304d91b51a0faec70a500b655ae989c19cb1f35b421318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71714fb8c07a6f4eaf98120316541cb42729430d1addc566af4d37dbd349ff58c14a1958f50512009e71bd7a4f658538ed19fa558771991cf6f095c3bc43731d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d34eddc03f0c8a27ee2445ec160c29055b101c2b202990d3940b4fc6b18a1cb662666031262ea874e4c5fa9faf32bf1dbbb2fd4f6f0825b4eb4e5228bc3ac4a"} 08:20:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:33 INFO - Contents: 08:20:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/935bbd6ea91adf4d234fa64cbb05cde9423efd086419402bb57301eba37080209206555c4d5eec639b304d91b51a0faec70a500b655ae989c19cb1f35b421318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71714fb8c07a6f4eaf98120316541cb42729430d1addc566af4d37dbd349ff58c14a1958f50512009e71bd7a4f658538ed19fa558771991cf6f095c3bc43731d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d34eddc03f0c8a27ee2445ec160c29055b101c2b202990d3940b4fc6b18a1cb662666031262ea874e4c5fa9faf32bf1dbbb2fd4f6f0825b4eb4e5228bc3ac4a"} 08:20:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:33 INFO - Copying logs to upload dir... 08:20:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.147186 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-07 08:20:32.142881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:32.145890) ========= 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=3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/935bbd6ea91adf4d234fa64cbb05cde9423efd086419402bb57301eba37080209206555c4d5eec639b304d91b51a0faec70a500b655ae989c19cb1f35b421318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71714fb8c07a6f4eaf98120316541cb42729430d1addc566af4d37dbd349ff58c14a1958f50512009e71bd7a4f658538ed19fa558771991cf6f095c3bc43731d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d34eddc03f0c8a27ee2445ec160c29055b101c2b202990d3940b4fc6b18a1cb662666031262ea874e4c5fa9faf32bf1dbbb2fd4f6f0825b4eb4e5228bc3ac4a"} build_url:https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/935bbd6ea91adf4d234fa64cbb05cde9423efd086419402bb57301eba37080209206555c4d5eec639b304d91b51a0faec70a500b655ae989c19cb1f35b421318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71714fb8c07a6f4eaf98120316541cb42729430d1addc566af4d37dbd349ff58c14a1958f50512009e71bd7a4f658538ed19fa558771991cf6f095c3bc43731d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d34eddc03f0c8a27ee2445ec160c29055b101c2b202990d3940b4fc6b18a1cb662666031262ea874e4c5fa9faf32bf1dbbb2fd4f6f0825b4eb4e5228bc3ac4a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:32.170425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:32.170736) ========= 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=3a3620fb28aea1604ab609ef000001d2-1481125325.432027-1328972458 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-12-07 08:20:32.256353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 08:20:32.256679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 08:20:32.256964) ========= ========= Total master_lag: 0.18 =========