builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1480761528.91 results: success (0) buildid: 20161203004004 builduid: 8e9aad80eba6401797a0a73de328a4f8 revision: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:48.912127) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:48.912637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:48.912921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:48.947435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:48.947777) ========= 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=836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-03 02:38:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-12-03 02:38:49 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.213494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.181651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.181967) ========= 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=836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019521 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.242927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.243283) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 --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 bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 --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=836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-03 02:38:49,796 truncating revision to first 12 chars 2016-12-03 02:38:49,796 Setting DEBUG logging. 2016-12-03 02:38:49,796 attempt 1/10 2016-12-03 02:38:49,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb91b72c0d3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 02:38:50,106 unpacking tar archive at: mozilla-aurora-bb91b72c0d3b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625523 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.882016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.885335) ========= script_repo_revision: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.885823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.886100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 02:38:49.900123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-03 02:38:49.900416) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:50 INFO - MultiFileLogger online at 20161203 02:38:50 in /builds/slave/test 02:38:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:38:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:50 INFO - {'append_to_log': False, 02:38:50 INFO - 'base_work_dir': '/builds/slave/test', 02:38:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:38:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:50 INFO - 'branch': 'Mozilla-Aurora', 02:38:50 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:50 INFO - 'config_files': ('talos/linux_config.py',), 02:38:50 INFO - 'default_actions': ('clobber', 02:38:50 INFO - 'read-buildbot-config', 02:38:50 INFO - 'download-and-extract', 02:38:50 INFO - 'populate-webroot', 02:38:50 INFO - 'create-virtualenv', 02:38:50 INFO - 'install', 02:38:50 INFO - 'run-tests'), 02:38:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:50 INFO - 'download_minidump_stackwalk': True, 02:38:50 INFO - 'download_symbols': 'ondemand', 02:38:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:50 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:50 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:50 INFO - 'installer_path': 'installer.exe', 02:38:50 INFO - 'log_level': 'info', 02:38:50 INFO - 'log_name': 'talos', 02:38:50 INFO - 'log_to_console': True, 02:38:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:50 INFO - 'opt_config_files': (), 02:38:50 INFO - 'pip_index': False, 02:38:50 INFO - 'sps_profile': False, 02:38:50 INFO - 'sps_profile_interval': 0, 02:38:50 INFO - 'suite': 'dromaeojs', 02:38:50 INFO - 'system_bits': '32', 02:38:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:50 INFO - 'title': 'talos-linux64-ix-028', 02:38:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:50 INFO - 'use_talos_json': True, 02:38:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:50 INFO - 'work_dir': 'build'} 02:38:50 INFO - [mozharness: 2016-12-03 10:38:50.556561Z] Running clobber step. 02:38:50 INFO - Running pre-action listener: _resource_record_pre_action 02:38:50 INFO - Running main action method: clobber 02:38:50 INFO - rmtree: /builds/slave/test/build 02:38:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:51 INFO - Running post-action listener: _resource_record_post_action 02:38:51 INFO - [mozharness: 2016-12-03 10:38:51.009892Z] Finished clobber step (success) 02:38:51 INFO - [mozharness: 2016-12-03 10:38:51.009991Z] Running read-buildbot-config step. 02:38:51 INFO - Running pre-action listener: _resource_record_pre_action 02:38:51 INFO - Running main action method: read_buildbot_config 02:38:51 INFO - Using buildbot properties: 02:38:51 INFO - { 02:38:51 INFO - "project": "", 02:38:51 INFO - "product": "firefox", 02:38:51 INFO - "script_repo_revision": "production", 02:38:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:38:51 INFO - "repository": "", 02:38:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:38:51 INFO - "buildid": "20161203004004", 02:38:51 INFO - "stage_platform": "linux64-pgo", 02:38:51 INFO - "basedir": "/builds/slave/test", 02:38:51 INFO - "nightly_build": "True", 02:38:51 INFO - "buildnumber": 657, 02:38:51 INFO - "slavename": "talos-linux64-ix-028", 02:38:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:38:51 INFO - "platform": "ubuntu64_hw", 02:38:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:38:51 INFO - "branch": "mozilla-aurora", 02:38:51 INFO - "repo_path": "releases/mozilla-aurora", 02:38:51 INFO - "revision": "bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1", 02:38:51 INFO - "pgo_build": "True", 02:38:51 INFO - "builduid": "8e9aad80eba6401797a0a73de328a4f8", 02:38:51 INFO - "slavebuilddir": "test" 02:38:51 INFO - } 02:38:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:38:51 INFO - Running post-action listener: _resource_record_post_action 02:38:51 INFO - [mozharness: 2016-12-03 10:38:51.012509Z] Finished read-buildbot-config step (success) 02:38:51 INFO - [mozharness: 2016-12-03 10:38:51.012597Z] Running download-and-extract step. 02:38:51 INFO - Running pre-action listener: _resource_record_pre_action 02:38:51 INFO - Running main action method: download_and_extract 02:38:51 INFO - mkdir: /builds/slave/test/build/tests 02:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:51 INFO - trying https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:38:51 INFO - Downloading https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/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 02:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/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 02:38:51 INFO - Downloaded 1361 bytes. 02:38:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:38:51 INFO - Using the following test package requirements: 02:38:51 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:38:51 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:38:51 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:38:51 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'jsshell-linux-x86_64.zip'], 02:38:51 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:38:51 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:38:51 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:38:51 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:38:51 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:38:51 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:38:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:38:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:38:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:38:52 INFO - Http code: 200 02:38:52 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 02:38:52 INFO - x-amz-cf-id: 7OrssPaCzu4ya63-bbphXNpqqwA3uFMJDwRelG0uamc_vJnuDv4A6w== 02:38:52 INFO - x-amz-version-id: VsCZOpUbQezI.WrIUU1sHY_UcNSkX5XF 02:38:52 INFO - Expected file size: 21955311 02:38:52 INFO - Obtained file size: 21955311 02:38:57 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 02:38:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:38:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:38:57 INFO - Fetch https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:38:57 INFO - Http code: 200 02:38:57 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 02:38:57 INFO - x-amz-cf-id: 2ecqVOfLdDr24mJ3mYhFFwpQBGIUI-d0ZRUxkeR1T5c6Ey1M5QtvbA== 02:38:57 INFO - x-amz-version-id: VsCZOpUbQezI.WrIUU1sHY_UcNSkX5XF 02:38:57 INFO - Expected file size: 21955311 02:38:57 INFO - Obtained file size: 21955311 02:39:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:39:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:39:02 INFO - Fetch https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:39:02 INFO - Http code: 200 02:39:02 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 02:39:02 INFO - x-amz-cf-id: zp05R7-rOCtZKKsHGyG360wHdLei_OLPornEPLjeVzl2WbvgU4n4eg== 02:39:02 INFO - x-amz-version-id: ONF5YpECxkkEIngCQMJ2skQopk.hjP_Q 02:39:03 INFO - Expected file size: 14409038 02:39:03 INFO - Obtained file size: 14409038 02:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:04 INFO - trying https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:39:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/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 02:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/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 02:39:07 INFO - Downloaded 63983833 bytes. 02:39:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:39:07 INFO - mkdir: /builds/slave/test/properties 02:39:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:07 INFO - Contents: 02:39:07 INFO - build_url:https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:39:07 INFO - Running post-action listener: _resource_record_post_action 02:39:07 INFO - Running post-action listener: set_extra_try_arguments 02:39:07 INFO - [mozharness: 2016-12-03 10:39:07.718654Z] Finished download-and-extract step (success) 02:39:07 INFO - [mozharness: 2016-12-03 10:39:07.718917Z] Running populate-webroot step. 02:39:07 INFO - Running pre-action listener: _resource_record_pre_action 02:39:07 INFO - Running main action method: populate_webroot 02:39:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:07 INFO - '--tppagecycles', 02:39:07 INFO - '7'], 02:39:07 INFO - 'tests': ['tsvgm']}}, 02:39:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:39:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:39:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:39:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['damp', 'tps']}, 02:39:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'tests': ['damp', 'tps']}, 02:39:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['dromaeo_dom']}, 02:39:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['basic_compositor_video']}, 02:39:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:39:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['a11yr', 02:39:07 INFO - 'ts_paint', 02:39:07 INFO - 'tpaint', 02:39:07 INFO - 'sessionrestore', 02:39:07 INFO - 'sessionrestore_no_auto_restore', 02:39:07 INFO - 'tabpaint']}, 02:39:07 INFO - 'other-e10s': {'tests': ['a11yr', 02:39:07 INFO - 'ts_paint', 02:39:07 INFO - 'tpaint', 02:39:07 INFO - 'sessionrestore', 02:39:07 INFO - 'sessionrestore_no_auto_restore', 02:39:07 INFO - 'tabpaint']}, 02:39:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:39:07 INFO - 'ts_paint', 02:39:07 INFO - 'tpaint', 02:39:07 INFO - 'sessionrestore', 02:39:07 INFO - 'sessionrestore_no_auto_restore', 02:39:07 INFO - 'tabpaint']}, 02:39:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:39:07 INFO - 'ts_paint', 02:39:07 INFO - 'tpaint', 02:39:07 INFO - 'sessionrestore', 02:39:07 INFO - 'sessionrestore_no_auto_restore', 02:39:07 INFO - 'tabpaint']}, 02:39:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['a11yr', 02:39:07 INFO - 'ts_paint', 02:39:07 INFO - 'tpaint', 02:39:07 INFO - 'sessionrestore', 02:39:07 INFO - 'sessionrestore_no_auto_restore', 02:39:07 INFO - 'tabpaint']}, 02:39:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['a11yr', 02:39:07 INFO - 'ts_paint', 02:39:07 INFO - 'tpaint', 02:39:07 INFO - 'sessionrestore', 02:39:07 INFO - 'sessionrestore_no_auto_restore', 02:39:07 INFO - 'tabpaint']}, 02:39:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['tsvgx', 02:39:07 INFO - 'tsvgr_opacity', 02:39:07 INFO - 'tart', 02:39:07 INFO - 'tscrollx', 02:39:07 INFO - 'cart']}, 02:39:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:39:07 INFO - 'tsvgr_opacity', 02:39:07 INFO - 'tart', 02:39:07 INFO - 'tscrollx', 02:39:07 INFO - 'cart']}, 02:39:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'talos_options': ['--disable-e10s'], 02:39:07 INFO - 'tests': ['tp5o']}, 02:39:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'tests': ['tp5o']}, 02:39:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'talos_options': ['--disable-e10s', 02:39:07 INFO - '--xperf_path', 02:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:07 INFO - 'tests': ['tp5n']}, 02:39:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:07 INFO - 'talos_options': ['--xperf_path', 02:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:07 INFO - 'tests': ['tp5n']}}, 02:39:07 INFO - 'talos.zip': {'path': '', 02:39:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:07 INFO - Running post-action listener: _resource_record_post_action 02:39:07 INFO - [mozharness: 2016-12-03 10:39:07.734828Z] Finished populate-webroot step (success) 02:39:07 INFO - [mozharness: 2016-12-03 10:39:07.734935Z] Running create-virtualenv step. 02:39:07 INFO - Running pre-action listener: _resource_record_pre_action 02:39:07 INFO - Running main action method: create_virtualenv 02:39:07 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:07 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 02:39:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:07 INFO - Using real prefix '/usr' 02:39:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:08 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:10 INFO - Installing pip.................done. 02:39:10 INFO - Return code: 0 02:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:39:10 INFO - Reading from file tmpfile_stdout 02:39:10 INFO - Output received: 02:39:10 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) 02:39:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:10 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')]} 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 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')]} 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:10 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 02:39:10 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 02:39:10 INFO - Using env: {'DISPLAY': ':0', 02:39:10 INFO - 'HOME': '/home/cltbld', 02:39:10 INFO - 'LANG': 'en_US.UTF-8', 02:39:10 INFO - 'LANGUAGE': 'en_US:en', 02:39:10 INFO - 'LOGNAME': 'cltbld', 02:39:10 INFO - 'MAIL': '/var/mail/cltbld', 02:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:10 INFO - 'MOZ_NO_REMOTE': '1', 02:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:10 INFO - 'NO_EM_RESTART': '1', 02:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:10 INFO - 'PWD': '/builds/slave/test', 02:39:10 INFO - 'SHELL': '/bin/bash', 02:39:10 INFO - 'SHLVL': '1', 02:39:10 INFO - 'TERM': 'linux', 02:39:10 INFO - 'TMOUT': '86400', 02:39:10 INFO - 'USER': 'cltbld', 02:39:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:10 INFO - '_': '/tools/buildbot/bin/python'} 02:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:10 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 02:39:10 INFO - Cleaning up... 02:39:10 INFO - Return code: 0 02:39:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39:10 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')]} 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 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')]} 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:10 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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:10 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 02:39:10 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 02:39:10 INFO - Using env: {'DISPLAY': ':0', 02:39:10 INFO - 'HOME': '/home/cltbld', 02:39:10 INFO - 'LANG': 'en_US.UTF-8', 02:39:10 INFO - 'LANGUAGE': 'en_US:en', 02:39:10 INFO - 'LOGNAME': 'cltbld', 02:39:10 INFO - 'MAIL': '/var/mail/cltbld', 02:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:10 INFO - 'MOZ_NO_REMOTE': '1', 02:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:10 INFO - 'NO_EM_RESTART': '1', 02:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:10 INFO - 'PWD': '/builds/slave/test', 02:39:10 INFO - 'SHELL': '/bin/bash', 02:39:10 INFO - 'SHLVL': '1', 02:39:10 INFO - 'TERM': 'linux', 02:39:10 INFO - 'TMOUT': '86400', 02:39:10 INFO - 'USER': 'cltbld', 02:39:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:10 INFO - '_': '/tools/buildbot/bin/python'} 02:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:10 INFO - Downloading/unpacking psutil>=3.1.1 02:39:10 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 02:39:10 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 02:39:10 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 02:39:10 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 02:39:10 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 02:39:10 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 02:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:13 INFO - Installing collected packages: psutil 02:39:13 INFO - Running setup.py install for psutil 02:39:13 INFO - building 'psutil._psutil_linux' extension 02:39:13 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 02:39:13 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 02:39:13 INFO - building 'psutil._psutil_posix' extension 02:39:13 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 02:39:13 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 02:39:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:13 INFO - Successfully installed psutil 02:39:13 INFO - Cleaning up... 02:39:13 INFO - Return code: 0 02:39:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:39:13 INFO - Using env: {'DISPLAY': ':0', 02:39:13 INFO - 'HOME': '/home/cltbld', 02:39:13 INFO - 'LANG': 'en_US.UTF-8', 02:39:13 INFO - 'LANGUAGE': 'en_US:en', 02:39:13 INFO - 'LOGNAME': 'cltbld', 02:39:13 INFO - 'MAIL': '/var/mail/cltbld', 02:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:13 INFO - 'MOZ_NO_REMOTE': '1', 02:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:13 INFO - 'NO_EM_RESTART': '1', 02:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:13 INFO - 'PWD': '/builds/slave/test', 02:39:13 INFO - 'SHELL': '/bin/bash', 02:39:13 INFO - 'SHLVL': '1', 02:39:13 INFO - 'TERM': 'linux', 02:39:13 INFO - 'TMOUT': '86400', 02:39:13 INFO - 'USER': 'cltbld', 02:39:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:13 INFO - '_': '/tools/buildbot/bin/python'} 02:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:15 INFO - Installing collected packages: mozsystemmonitor 02:39:15 INFO - Running setup.py install for mozsystemmonitor 02:39:15 INFO - Successfully installed mozsystemmonitor 02:39:15 INFO - Cleaning up... 02:39:16 INFO - Return code: 0 02:39:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39:16 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')]} 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:16 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')]} 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:16 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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:16 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 02:39:16 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 02:39:16 INFO - Using env: {'DISPLAY': ':0', 02:39:16 INFO - 'HOME': '/home/cltbld', 02:39:16 INFO - 'LANG': 'en_US.UTF-8', 02:39:16 INFO - 'LANGUAGE': 'en_US:en', 02:39:16 INFO - 'LOGNAME': 'cltbld', 02:39:16 INFO - 'MAIL': '/var/mail/cltbld', 02:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:16 INFO - 'MOZ_NO_REMOTE': '1', 02:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:16 INFO - 'NO_EM_RESTART': '1', 02:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:16 INFO - 'PWD': '/builds/slave/test', 02:39:16 INFO - 'SHELL': '/bin/bash', 02:39:16 INFO - 'SHLVL': '1', 02:39:16 INFO - 'TERM': 'linux', 02:39:16 INFO - 'TMOUT': '86400', 02:39:16 INFO - 'USER': 'cltbld', 02:39:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:16 INFO - '_': '/tools/buildbot/bin/python'} 02:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:16 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:18 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:18 INFO - warning: no files found matching '*.txt' 02:39:18 INFO - no previously-included directories found matching 'build' 02:39:18 INFO - no previously-included directories found matching 'dist' 02:39:18 INFO - no previously-included directories found matching '.git*' 02:39:18 INFO - Installing collected packages: jsonschema, functools32 02:39:18 INFO - Running setup.py install for functools32 02:39:18 INFO - warning: no files found matching '*.txt' 02:39:18 INFO - no previously-included directories found matching 'build' 02:39:18 INFO - no previously-included directories found matching 'dist' 02:39:18 INFO - no previously-included directories found matching '.git*' 02:39:18 INFO - Successfully installed jsonschema functools32 02:39:18 INFO - Cleaning up... 02:39:18 INFO - Return code: 0 02:39:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:39:18 INFO - Using env: {'DISPLAY': ':0', 02:39:18 INFO - 'HOME': '/home/cltbld', 02:39:18 INFO - 'LANG': 'en_US.UTF-8', 02:39:18 INFO - 'LANGUAGE': 'en_US:en', 02:39:18 INFO - 'LOGNAME': 'cltbld', 02:39:18 INFO - 'MAIL': '/var/mail/cltbld', 02:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:18 INFO - 'MOZ_NO_REMOTE': '1', 02:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:18 INFO - 'NO_EM_RESTART': '1', 02:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:18 INFO - 'PWD': '/builds/slave/test', 02:39:18 INFO - 'SHELL': '/bin/bash', 02:39:18 INFO - 'SHLVL': '1', 02:39:18 INFO - 'TERM': 'linux', 02:39:18 INFO - 'TMOUT': '86400', 02:39:18 INFO - 'USER': 'cltbld', 02:39:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:18 INFO - '_': '/tools/buildbot/bin/python'} 02:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:39:18 INFO - Cleaning up... 02:39:18 INFO - Return code: 0 02:39:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:18 INFO - Using env: {'DISPLAY': ':0', 02:39:18 INFO - 'HOME': '/home/cltbld', 02:39:18 INFO - 'LANG': 'en_US.UTF-8', 02:39:18 INFO - 'LANGUAGE': 'en_US:en', 02:39:18 INFO - 'LOGNAME': 'cltbld', 02:39:18 INFO - 'MAIL': '/var/mail/cltbld', 02:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:18 INFO - 'MOZ_NO_REMOTE': '1', 02:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:18 INFO - 'NO_EM_RESTART': '1', 02:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:18 INFO - 'PWD': '/builds/slave/test', 02:39:18 INFO - 'SHELL': '/bin/bash', 02:39:18 INFO - 'SHLVL': '1', 02:39:18 INFO - 'TERM': 'linux', 02:39:18 INFO - 'TMOUT': '86400', 02:39:18 INFO - 'USER': 'cltbld', 02:39:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:18 INFO - '_': '/tools/buildbot/bin/python'} 02:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:19 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:19 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 02:39:19 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 02:39:19 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 02:39:19 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 02:39:19 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 02:39:19 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 02:39:21 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:21 INFO - Downloading docopt-0.6.1.tar.gz 02:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:21 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:21 INFO - Running setup.py install for blobuploader 02:39:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:21 INFO - Running setup.py install for requests 02:39:22 INFO - Running setup.py install for docopt 02:39:22 INFO - Successfully installed blobuploader requests docopt 02:39:22 INFO - Cleaning up... 02:39:22 INFO - Return code: 0 02:39:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:22 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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:22 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 02:39:22 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 02:39:22 INFO - Using env: {'DISPLAY': ':0', 02:39:22 INFO - 'HOME': '/home/cltbld', 02:39:22 INFO - 'LANG': 'en_US.UTF-8', 02:39:22 INFO - 'LANGUAGE': 'en_US:en', 02:39:22 INFO - 'LOGNAME': 'cltbld', 02:39:22 INFO - 'MAIL': '/var/mail/cltbld', 02:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:22 INFO - 'MOZ_NO_REMOTE': '1', 02:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:22 INFO - 'NO_EM_RESTART': '1', 02:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:22 INFO - 'PWD': '/builds/slave/test', 02:39:22 INFO - 'SHELL': '/bin/bash', 02:39:22 INFO - 'SHLVL': '1', 02:39:22 INFO - 'TERM': 'linux', 02:39:22 INFO - 'TMOUT': '86400', 02:39:22 INFO - 'USER': 'cltbld', 02:39:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:22 INFO - '_': '/tools/buildbot/bin/python'} 02:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:22 INFO - Running setup.py (path:/tmp/pip-jVZltX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:22 INFO - Running setup.py (path:/tmp/pip-FgHPlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:22 INFO - Running setup.py (path:/tmp/pip-iycr2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:22 INFO - Running setup.py (path:/tmp/pip-ESFsHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:22 INFO - Running setup.py (path:/tmp/pip-S9V32Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:23 INFO - Running setup.py (path:/tmp/pip-ctQN6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:23 INFO - Running setup.py (path:/tmp/pip-zIf6vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:23 INFO - Running setup.py (path:/tmp/pip-sxC4kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:23 INFO - Running setup.py (path:/tmp/pip-JG665x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:23 INFO - Running setup.py (path:/tmp/pip-9iyP86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:23 INFO - Running setup.py (path:/tmp/pip-RfS7EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:23 INFO - Running setup.py (path:/tmp/pip-k88ibe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:23 INFO - Running setup.py (path:/tmp/pip-3AkfUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:23 INFO - Running setup.py (path:/tmp/pip-XKWx__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:23 INFO - Running setup.py (path:/tmp/pip-1q2lbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:23 INFO - Running setup.py (path:/tmp/pip-y98VMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:23 INFO - Running setup.py (path:/tmp/pip-u0VYq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:23 INFO - Running setup.py install for manifestparser 02:39:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozcrash 02:39:24 INFO - Running setup.py install for mozdebug 02:39:24 INFO - Running setup.py install for mozdevice 02:39:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozfile 02:39:24 INFO - Running setup.py install for mozhttpd 02:39:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozinfo 02:39:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozInstall 02:39:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for mozleak 02:39:24 INFO - Running setup.py install for mozlog 02:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:24 INFO - Running setup.py install for moznetwork 02:39:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Running setup.py install for mozprocess 02:39:25 INFO - Running setup.py install for mozprofile 02:39:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Running setup.py install for mozrunner 02:39:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Running setup.py install for mozscreenshot 02:39:25 INFO - Running setup.py install for moztest 02:39:25 INFO - Running setup.py install for mozversion 02:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:25 INFO - Cleaning up... 02:39:25 INFO - Return code: 0 02:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:25 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 02:39:25 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 02:39:25 INFO - Using env: {'DISPLAY': ':0', 02:39:25 INFO - 'HOME': '/home/cltbld', 02:39:25 INFO - 'LANG': 'en_US.UTF-8', 02:39:25 INFO - 'LANGUAGE': 'en_US:en', 02:39:25 INFO - 'LOGNAME': 'cltbld', 02:39:25 INFO - 'MAIL': '/var/mail/cltbld', 02:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:25 INFO - 'MOZ_NO_REMOTE': '1', 02:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:25 INFO - 'NO_EM_RESTART': '1', 02:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:25 INFO - 'PWD': '/builds/slave/test', 02:39:25 INFO - 'SHELL': '/bin/bash', 02:39:25 INFO - 'SHLVL': '1', 02:39:25 INFO - 'TERM': 'linux', 02:39:25 INFO - 'TMOUT': '86400', 02:39:25 INFO - 'USER': 'cltbld', 02:39:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:25 INFO - '_': '/tools/buildbot/bin/python'} 02:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:25 INFO - Running setup.py (path:/tmp/pip-IPkBKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:26 INFO - Running setup.py (path:/tmp/pip-WqJapt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:26 INFO - Running setup.py (path:/tmp/pip-nQJmZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:26 INFO - Running setup.py (path:/tmp/pip-fo9Nkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:26 INFO - Running setup.py (path:/tmp/pip-Cth8os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:26 INFO - Running setup.py (path:/tmp/pip-rfBHL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:26 INFO - Running setup.py (path:/tmp/pip-Nd8Ja0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:26 INFO - Running setup.py (path:/tmp/pip-dK7A1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:26 INFO - Running setup.py (path:/tmp/pip-B_jCNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:26 INFO - Running setup.py (path:/tmp/pip-Nlz95a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:26 INFO - Running setup.py (path:/tmp/pip-V0ldqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:26 INFO - Running setup.py (path:/tmp/pip-bfw2TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:26 INFO - Running setup.py (path:/tmp/pip-z7LGFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:26 INFO - Running setup.py (path:/tmp/pip-3Pmo1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:26 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)) 02:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:26 INFO - Running setup.py (path:/tmp/pip-VN_2Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:27 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)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:27 INFO - Running setup.py (path:/tmp/pip-8zPUwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:27 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)) 02:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:27 INFO - Running setup.py (path:/tmp/pip-IrtWme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:27 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)) 02:39:27 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)) 02:39:27 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)) 02:39:27 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)) 02:39:27 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)) 02:39:27 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)) 02:39:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39:29 INFO - Downloading blessings-1.6.tar.gz 02:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:29 INFO - Installing collected packages: blessings 02:39:29 INFO - Running setup.py install for blessings 02:39:29 INFO - Successfully installed blessings 02:39:29 INFO - Cleaning up... 02:39:29 INFO - Return code: 0 02:39:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:29 INFO - Reading from file tmpfile_stdout 02:39:29 INFO - Current package versions: 02:39:29 INFO - argparse == 1.2.1 02:39:29 INFO - blessings == 1.6 02:39:29 INFO - blobuploader == 1.2.4 02:39:29 INFO - docopt == 0.6.1 02:39:29 INFO - functools32 == 3.2.3-2 02:39:29 INFO - jsonschema == 2.5.1 02:39:29 INFO - manifestparser == 1.1 02:39:29 INFO - mozInstall == 1.12 02:39:29 INFO - mozcrash == 1.0 02:39:29 INFO - mozdebug == 0.1 02:39:29 INFO - mozdevice == 0.48 02:39:29 INFO - mozfile == 1.2 02:39:29 INFO - mozhttpd == 0.7 02:39:29 INFO - mozinfo == 0.9 02:39:29 INFO - mozleak == 0.1 02:39:29 INFO - mozlog == 3.4 02:39:29 INFO - moznetwork == 0.27 02:39:29 INFO - mozprocess == 0.23 02:39:29 INFO - mozprofile == 0.28 02:39:29 INFO - mozrunner == 6.13 02:39:29 INFO - mozscreenshot == 0.1 02:39:29 INFO - mozsystemmonitor == 0.3 02:39:29 INFO - moztest == 0.7 02:39:29 INFO - mozversion == 1.4 02:39:29 INFO - psutil == 3.1.1 02:39:29 INFO - requests == 1.2.3 02:39:29 INFO - wsgiref == 0.1.2 02:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:29 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 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:29 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 02:39:29 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 02:39:29 INFO - Using env: {'DISPLAY': ':0', 02:39:29 INFO - 'HOME': '/home/cltbld', 02:39:29 INFO - 'LANG': 'en_US.UTF-8', 02:39:29 INFO - 'LANGUAGE': 'en_US:en', 02:39:29 INFO - 'LOGNAME': 'cltbld', 02:39:29 INFO - 'MAIL': '/var/mail/cltbld', 02:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:29 INFO - 'MOZ_NO_REMOTE': '1', 02:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:29 INFO - 'NO_EM_RESTART': '1', 02:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:29 INFO - 'PWD': '/builds/slave/test', 02:39:29 INFO - 'SHELL': '/bin/bash', 02:39:29 INFO - 'SHLVL': '1', 02:39:29 INFO - 'TERM': 'linux', 02:39:29 INFO - 'TMOUT': '86400', 02:39:29 INFO - 'USER': 'cltbld', 02:39:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:29 INFO - '_': '/tools/buildbot/bin/python'} 02:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 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)) 02:39:30 INFO - Cleaning up... 02:39:30 INFO - Return code: 0 02:39:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe3de1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, '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': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', '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 02:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:39:30 INFO - Using env: {'DISPLAY': ':0', 02:39:30 INFO - 'HOME': '/home/cltbld', 02:39:30 INFO - 'LANG': 'en_US.UTF-8', 02:39:30 INFO - 'LANGUAGE': 'en_US:en', 02:39:30 INFO - 'LOGNAME': 'cltbld', 02:39:30 INFO - 'MAIL': '/var/mail/cltbld', 02:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:30 INFO - 'MOZ_NO_REMOTE': '1', 02:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:30 INFO - 'NO_EM_RESTART': '1', 02:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:30 INFO - 'PWD': '/builds/slave/test', 02:39:30 INFO - 'SHELL': '/bin/bash', 02:39:30 INFO - 'SHLVL': '1', 02:39:30 INFO - 'TERM': 'linux', 02:39:30 INFO - 'TMOUT': '86400', 02:39:30 INFO - 'USER': 'cltbld', 02:39:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:30 INFO - '_': '/tools/buildbot/bin/python'} 02:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:30 INFO - Cleaning up... 02:39:30 INFO - Return code: 0 02:39:30 INFO - Running post-action listener: _resource_record_post_action 02:39:30 INFO - Running post-action listener: _start_resource_monitoring 02:39:30 INFO - Starting resource monitoring. 02:39:30 INFO - [mozharness: 2016-12-03 10:39:30.293665Z] Finished create-virtualenv step (success) 02:39:30 INFO - [mozharness: 2016-12-03 10:39:30.294112Z] Running install step. 02:39:30 INFO - Running pre-action listener: _resource_record_pre_action 02:39:30 INFO - Running main action method: install 02:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:30 INFO - Reading from file tmpfile_stdout 02:39:30 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:30 INFO - Reading from file tmpfile_stdout 02:39:30 INFO - Output received: 02:39:30 INFO - Usage: mozinstall [options] installer 02:39:30 INFO - Options: 02:39:30 INFO - -h, --help show this help message and exit 02:39:30 INFO - -d DEST, --destination=DEST 02:39:30 INFO - Directory to install application into. [default: 02:39:30 INFO - "/builds/slave/test"] 02:39:30 INFO - --app=APP Application being installed. [default: firefox] 02:39:30 INFO - mkdir: /builds/slave/test/build/application 02:39:30 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'] 02:39:30 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 02:39:46 INFO - Reading from file tmpfile_stdout 02:39:46 INFO - Output received: 02:39:46 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:46 INFO - Running post-action listener: _resource_record_post_action 02:39:46 INFO - [mozharness: 2016-12-03 10:39:46.511960Z] Finished install step (success) 02:39:46 INFO - [mozharness: 2016-12-03 10:39:46.512203Z] Running run-tests step. 02:39:46 INFO - Running pre-action listener: _resource_record_pre_action 02:39:46 INFO - Running main action method: run_tests 02:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:46 INFO - Python 2.7.3 02:39:46 INFO - Return code: 0 02:39:46 INFO - grabbing minidump binary from tooltool 02:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:46 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 0x233af60>, '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 0x233bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:46 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 02:39:46 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 02:39:46 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 02:39:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:46 INFO - Return code: 0 02:39:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:39:46 INFO - Using env: {'DISPLAY': ':0', 02:39:46 INFO - 'HOME': '/home/cltbld', 02:39:46 INFO - 'LANG': 'en_US.UTF-8', 02:39:46 INFO - 'LANGUAGE': 'en_US:en', 02:39:46 INFO - 'LOGNAME': 'cltbld', 02:39:46 INFO - 'MAIL': '/var/mail/cltbld', 02:39:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:46 INFO - 'MOZ_NO_REMOTE': '1', 02:39:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:46 INFO - 'NO_EM_RESTART': '1', 02:39:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:46 INFO - 'PWD': '/builds/slave/test', 02:39:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:46 INFO - 'SHELL': '/bin/bash', 02:39:46 INFO - 'SHLVL': '1', 02:39:46 INFO - 'TERM': 'linux', 02:39:46 INFO - 'TMOUT': '86400', 02:39:46 INFO - 'USER': 'cltbld', 02:39:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401', 02:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:46 INFO - '_': '/tools/buildbot/bin/python'} 02:39:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:39:46 INFO - mozversion application_buildid: 20161203004004 02:39:46 INFO - mozversion application_changeset: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 02:39:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:39:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:46 INFO - mozversion application_name: Firefox 02:39:46 INFO - mozversion application_remotingname: firefox-dev 02:39:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:46 INFO - mozversion application_vendor: Mozilla 02:39:46 INFO - mozversion application_version: 52.0a2 02:39:46 INFO - mozversion platform_buildid: 20161203004004 02:39:46 INFO - mozversion platform_changeset: bb91b72c0d3b53a952a0b6edc1cbb22632aa4ca1 02:39:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:39:46 INFO - mozversion platform_version: 52.0a2 02:39:46 INFO - using testdate: 1480761586 02:39:46 INFO - actual date: 1480761586 02:39:46 INFO - starting webserver on 'localhost:58918' 02:39:46 INFO - SUITE-START | Running 2 tests 02:39:46 INFO - TEST-START | dromaeo_css 02:39:46 INFO - operating with platform_type : linux_ 02:39:46 INFO - Initialising browser for dromaeo_css test... 02:39:46 INFO - TEST-INFO | started process 12632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9_AnfB/profile http://localhost:58918/getInfo.html) 02:39:50 INFO - PROCESS | 12632 | __metrics Screen width/height:1600/1200 02:39:50 INFO - PROCESS | 12632 | colorDepth:24 02:39:50 INFO - PROCESS | 12632 | Browser inner width/height: 1024/697 02:39:50 INFO - PROCESS | 12632 | __metrics 02:39:51 INFO - PROCESS | 12632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:39:51 INFO - PROCESS | 12632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:51 INFO - PROCESS | 12632 | console.error: PushService: 02:39:51 INFO - PROCESS | 12632 | stateChangeProcessEnqueue: Error transitioning state 02:39:51 INFO - PROCESS | 12632 | UnknownError 02:39:52 INFO - TEST-INFO | 12632: exit 0 02:39:52 INFO - Browser initialized. 02:39:52 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:52 INFO - TEST-INFO | started process 12724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9_AnfB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:04 INFO - PROCESS | 12724 | RSS: Main: 145059840 02:40:04 INFO - PROCESS | 12724 | 02:40:55 INFO - PROCESS | 12724 | 1480761655863 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] 02:43:06 INFO - PROCESS | 12724 | Cycle 1(1): loaded http://localhost:58918/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58918/tests/dromaeo/cssquery-ext.html) 02:43:07 INFO - PROCESS | 12724 | RSS: Main: 246956032 02:43:07 INFO - PROCESS | 12724 | 02:46:09 INFO - PROCESS | 12724 | Cycle 1(1): loaded http://localhost:58918/tests/dromaeo/cssquery-ext.html (next: http://localhost:58918/tests/dromaeo/cssquery-jquery.html) 02:46:10 INFO - PROCESS | 12724 | RSS: Main: 224432128 02:46:10 INFO - PROCESS | 12724 | 02:49:12 INFO - PROCESS | 12724 | Cycle 1(1): loaded http://localhost:58918/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58918/tests/dromaeo/cssquery-mootools.html) 02:49:12 INFO - PROCESS | 12724 | RSS: Main: 230617088 02:49:12 INFO - PROCESS | 12724 | 02:52:14 INFO - PROCESS | 12724 | Cycle 1(1): loaded http://localhost:58918/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58918/tests/dromaeo/cssquery-prototype.html) 02:52:15 INFO - PROCESS | 12724 | RSS: Main: 216854528 02:52:15 INFO - PROCESS | 12724 | 02:55:18 INFO - PROCESS | 12724 | Cycle 1(1): loaded http://localhost:58918/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58918/tests/dromaeo/cssquery-yui.html) 02:55:18 INFO - PROCESS | 12724 | RSS: Main: 176836608 02:55:18 INFO - PROCESS | 12724 | 02:58:20 INFO - PROCESS | 12724 | Cycle 1(1): loaded http://localhost:58918/tests/dromaeo/cssquery-yui.html (next: http://localhost:58918/tests/dromaeo/cssquery-dojo.html) 02:58:21 INFO - PROCESS | 12724 | RSS: Main: 271597568 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | __start_tp_report 02:58:21 INFO - PROCESS | 12724 | _x_x_mozilla_page_load 02:58:21 INFO - PROCESS | 12724 | _x_x_mozilla_page_load_details 02:58:21 INFO - PROCESS | 12724 | |i|pagename|runs| 02:58:21 INFO - PROCESS | 12724 | |0;dojo.html;3257.9185520361993;3277.1807048237943;3306.735461163106;3317.6848199421047;3336.9332613347733;5565.220869078333;5601.943980560199;5667.659940403579;5689.715514224288;5699.031164702;5553.805616803413;5633.57748168888;5634.3520495143075;5645.435456454353;5659.490645841874;5067.822626208083;5073.467285934979;5087.643864929457;5140.8971820563565;5168.250603662485;4981.302617633534;4993.375828021497;5197.298364720771;5198.324217851674;5204.739763011853;5052.26742122392;5062.367204099488;5087.160618497944;5096.51583099605;5110.463401342861;5103.795848166087;5176.637635365526;5184.844454666366;5187.385968235601;5216.947830521684;4921;5066.544011039025;5086.21163719624;5118.872028199287;5148.304978827848;5429.647072940246;5477.972610136924;5499.752511137009;5499.945000549983;5516.475934786189;5865.472107510344;5887.116932460165;5955.583109182359;5958.851028724273;5986.221791167164;5869.354371019184;6039.275286965549;6039.5772295939305;6061.393860613947;6063.757449702007;5522.392536820947;5587.608867379326;5664.037113690682;5673.886522269614;5682.090865461506;6189.473894718909;6209.65846878417;6210.813675589739;6210.9068363974575;6213.409726076015;5669.914951275734;5965.582409231399;5970.611910225822;5976.910346344808;5986.640801551921;5768.4808367246305;5935.169076329317;5955.464008239279;5981.222441082631;6074.757009719562;6007.789727359609;6022.066579680157;6025.78909738157;6030.7889223876955;6057.909131363033;5982.102684597258;6032.095185722177;6038.064100064497;6049.364816694272;6050.0017497112485;4452.821887124479;4479;4545.749983750926;4574.245249533789;4589.196890544142;4133.503979522417;4140.4617399738445;4143.56492568282;4169.645580125723;4181.707280490336;5624.493795558419;5629.296337957755;5634.887302254014;5636.2954630671165;5673.574481913873;5778.393268706809;5811.2445382100905;5988.550858685616;6007.3992600739575;6023.728932197974;5743.368229494752;5769.105788602773;5770.798022069207;5773.162891380726;5777.653340799566;5274.498922602346;5276.551493123051;5281.419043905167;5282.286891269629;5289.576833853283;5908.940910590839;5967.940320596738;6035.818925432244;6252.374762523711;6260.311365749764;5829.76680932758;5882.676452795137;5921.61509501881;5935;5951.7619295227705;6065.272167339947;6068.150458935841;6077.392260773887;6078.240219972504;6086.087086936818;5791.971040144772;5794.159846822272;5798.188253644409;5800.332961709458;5810.244668193108;5945.34601193877;5975.760969561343;5982.282126144891;6027.517798576191;6046.03263477859;5851.093080572518;5872.677002764889;5881.911771323519;5892.558058145742;5898.026825573732;5702.942970570241;5875.383084776037;5881.382454842351;5896.351401345934;5898.734556945034;5103.132467480463;5596.300462442195;5717.1995920570325;5717.485426311652;5828.154917536848;5860;5877.853053673693;5879.265091863517;5879.882402352015;5887.087501437284;5653.604247702621;5714.171445140514;5715.057015592547;5715.657060576379;5746.5402767779315 02:58:21 INFO - PROCESS | 12724 | |1;ext.html;580.918671386006;601.7442586900567;633.2527617411453;643.0964494884689;651.5862427358629;34749.65250347496;45662.08675826486;46416.303755443696;46601.30098048532;46827;47109.52890471094;47122;47205.52794472054;47646;47698;8195.34437245022;8787.95606021969;8924.107589241057;8936.64253429862;8937.240334571537;8202.712905048325;10597.576096956112;10820;10852.891471085306;11178.552857885716;10902.454877256145;10903.29128606642;10915.890841091566;10920.781584368307;10930.453477326142;10814.29707069038;10833.512491937881;10860.945695271474;10873.728156796104;10884.782304353948;10617.84073238902;10674.626388076458;10682.893171068268;10687.732806679818;10699.251052426256;43666.56333436688;43957.340639890426;43989.560104398864;44124.55875441269;44172;3734.3464893643504;3789.905252368713;3807.600201978808;3842.4620553122586;4005.619466150711;33459.330813383596;33475.83262083698;33850.153746156546;34262;34742.826285868665;4092.815823287959;4093.9590604093873;4135.462389889325;4157.521884983235;4178.289690752579;395970;396911;397082;397109;398013;62950.370496294454;63479.365206348266;63556.68221658862;63577.68211158914;63638.68180659067;39701.80149099294;40647.1870562593;40925.59074409278;42896;42938;17185.39851105205;17414.825851741574;17416.21627026787;17421.47735567935;17424.47726568205;11960.222585532087;12098.57654982089;12807.423665935055;12888.80666789999;12950.935245323713;19922.701159482618;20879.8956005219;20909.89545052265;20936.37190884276;21116.78883211179;7438.925610743823;7534;7692.7692169235015;7701.362365340379;7827.6477558510005;996.7209181429212;1043.0820877627639;1053.599632139782;1059.4384975962753;1102.7022703869911;34330.31339373199;34428.31143377118;34780.82609586987;34788.26058697055;34864.825675871456;1076.0907033556632;1123.7920984617872;1133.5295852221236;1145.7479354541988;1173.9354335511457;16406.75389869129;18094.63810723778;18102.185401656956;18594.907025465058;18952.90523547401;546726;549971;551034;553513;556173;62040;62584;62674.37325626685;62781;63143;1281.7564662714055;1355.403622406138;1361.237706884148;1417.7944198091425;1428.0860249440366;31117.533237001917;34495.65504345025;34872.82563587166;34983.825080874434;35022.12444688903;53921;54681;54681.45318546764;54706.72646636901;54721.72639136779;340190;341218;341257;342297;342551;30785.8460707695;30819.383612328078;31022.53466198054;31685.683143169197;32983.50524742083;50348;50376;50406.747966259936;50602;50996.23505647492;42512;42589;43088;43882.780586096866;44771.32843007422;42225.155496890504;42557.57442425536;42695.786521067195;42947;44244.55755442533;43726.78136609297;44049;44513.10973780571;44671.32993005042;44905;35020.47469288014;37612;38371.6162838368;38394.61605384022;38696.80651596724;29312.56031159577;29953.55069673913;29989.70010299869;30003.54994675038;30145.397092058476 02:58:21 INFO - PROCESS | 12724 | |2;jquery.html;396.6707632664885;417.4552209366777;424.93877590529377;429.2316753012108;439.20065480824894;15612.453564125259;20308.390748277558;21432.464188395297;21620.8918955405;21829.67255491167;19260.61478770427;19573.90213048933;19660.213591456326;20410.387688369334;20526.69209961848;5467.726613669311;5692.117721753135;5692.6299790513485;5704.087346024637;5704.2299289595785;5387.730613469311;5674.063779476382;5677.48902598766;5681.431856814306;5685.118806584986;5534.916976245359;5650.406707295737;5651.943480565204;5655.886882262353;5657.23627310312;5486.945130548704;5607.719614019303;5626.887462250773;5640.238567793336;5641.68970706613;5111.463296353866;5115.693058416469;5122.180451127839;5124.9743751281;5203.089459344637;14037.859621403757;14451.855481445262;14469.638259043502;14470.638234044232;19901.303454379027;2289.267434420986;2316.6409206573007;2336.906523739048;2722.3058120179226;2780.638516992778;10954.616588419367;11062.612808551743;11153.498092585853;11321.660350189508;11420.31478111316;1940.7380003699461;1991.6614175590184;2019.6061767955255;2079.781622929586;2087.081684059009;78998.6050069746;80197;80942.19057809464;90101;95290.52354738182;10566.154707623371;11700.473478693479;11960.222585531912;12251.632451026484;12312.445939932724;14868.776968345483;15361.6159596011;15929.840701593068;15954.1225232611;15980.520584382488;7525.962370188114;8207.220314070153;8330.291925186306;8466.703665371682;8547.316214702932;7362.77911662651;7387.85224295511;7402.222766609536;7774.455788094779;7936.801579960547;4927.507249275115;5115.641905066684;5141.53726164647;5174.223866420067;5262.7631756571045;1863.1057092595358;1963.4475182263002;2029.797020297988;2144.656854903208;2145.227718021511;949.3164921256684;968.4867020479157;979.5934687104772;1024.8770147582338;1089.9727506812394;19597.314094006928;19820.70268945967;19931.302404415776;20129.798702013086;20326.08532616036;1019.9031092046243;1039.158281791751;1039.6621098143135;1068.8183008888507;1069.8234791259356;10428.612599004202;11338.376389298668;11351.148663850245;11486.253393529394;11517.251378660529;387965;397540;401118;477659;489269;93942;105881.47059264808;107154.46422767993;107963;108025;1022.8925962773801;1052.8473371360956;1093.7375029992745;1127.7180704823795;1134.65393055119;17933.73099403484;18079.728804067687;18282.634347312713;18530.536736581693;18905.432837014912;44243.33634995542;44828.77585612051;46232.30651540297;46555;47566.52433475621;64291.67854160699;65029.349706502326;65445.67277163584;65845.68308633704;67770;8063.637136328996;8904.626631438856;8965;9058.501782401767;9306.348555601044;13154.934225328812;13957.720845583235;14123.64690882736;14140.858591413955;14199.148051116967;11792.351420671945;12005;12013.75972480563;12277.815832762337;12378.381080946097;10801.945990269998;11293.37886416255;11319.547218111184;11618.128640351839;12370.938145309216;11916.046716262852;12148.453319600463;12242.143049986771;12519.061070419573;12544.623661290176;8367.748967530984;8410.663573457237;8466.322694184328;8528.658853645784;8549.401541892257;10407;12191.817122743343;12294.877051229374;12419.068569857478;12998.285094319903 02:58:21 INFO - PROCESS | 12724 | |3;mootools.html;1467.8752306053982;1512.6369671278892;1666.2085509383044;1769.5310742653207;1798.6402719456105;8050.838983220332;8571.528565928871;8575.699850505234;8580.91419085809;8586.613602387892;7520.6991720331125;7718.652660630271;8026.759197224078;8286.709965151222;8404.62179201936;2420.624803155509;2449.326435230308;2450.8529488230674;2456.3736247256925;2457.1645640482234;2432.3631487616394;2492.239866840613;2497.1759319424546;2499.7250302466805;2500.499900019994;2398.5083057973075;2400.6519054737055;2458.1765108688523;2463.6797216361847;2465.2973902437807;2365.9999999999914;2387.8328517003815;2404.326788499223;2405.302462285944;2416;2429.392651837041;2436.9390765230833;2456.6929133858266;2457.1522824625476;2460.126655037454;8335.291500222489;8511.914880851175;8527.914720852774;8529.23236908675;8537.402381833273;5188.974055129738;5351.464853514617;5371.704556249405;5373.382061062989;5376.731163441812;3335.232896433834;3358.462645976632;3428.160100775301;3494.475828625701;3549.6095429502734;1155.381870699172;1166.241942737219;1166.5158959031992;1177.7585594953014;1206.5173930427811;11725.824112638316;11769.470373833112;11778.764424711459;11796.882031179664;11804.999999999915;4496.303073023687;4765.475797662254;4825.613950883921;4841.031793641286;4855.562999330077;9854.408735475894;9856.408615482951;9856.45789481571;9856.704298871045;9859.161971232383;5322.14845624706;5339.733013349317;5389.191621256765;5394.271773310631;5403.189521571796;4469.821207151743;4497.572730590588;4702.200625893606;4914.164592019294;4969.428515720666;3945.3292940200236;4035.7376770509823;4047.3119569673227;4069.5116586009867;4155.688323375698;1338.5716570697284;1343.7648411527944;1347.1041757231528;1351.7566837969064;1361.8229630148016;938.5682586010512;983.1250187333136;997.8602995580625;1006.5571148694551;1011.5296387179997;5939.762409503658;5967.910481342783;5978.85052873673;6044.455998960115;6062.514998800086;493.77286448234213;495.34119620904113;503.29036059157147;505.37838458695273;506.7972810875679;4053.3717273822604;4151.418801367811;4189.308764053958;4197.97901010493;4271.807768650418;9876.654317098866;10323.948380258202;10364.689059328231;10367.066963973128;10386.688399348031;10155;10207.030332118436;10241.180705543538;10243.282970192015;10245.641402550875;7835.2948234658015;7942.404319675932;8009.919900801034;8038.959805200937;8043.798905027421;5748.080307150836;5801.709914504174;5873.353931067664;5898.764049437975;5965.164876917148;9427.717168484956;9469.810603787748;9499.952500237454;9552.904470955202;9611.231101511723;9722.27082968766;9722.75693107678;9805.803883922425;9825.213982881496;9825.4104753715;6847.21257055425;6956;6970.895436568354;7547.849043018999;7613.352865006536;7261.5280006799385;7882.842343153219;7995.360371170176;8215.794605134919;8219.260266576037;7210.567365958059;7347.853042939005;7413.518121322097;7438.404927605887;7603.657835397531;7042.084529011196;7078.752243671447;7127.037849890406;7195.604241766544;7488.812779680552;6683.331666833278;6780.864382712417;6805.693743781443;6814.625195614289;6815.795526134224;4924.458309586014;4955.628327875352;5042;5094.083065048327;5281.880133495879;5098.592112630907;5262.237325404193;5263.473652634706;5281.128613778684;5389.51494365509 02:58:21 INFO - PROCESS | 12724 | |4;prototype.html;349.55082718706467;360.27764332513306;367.07130958674554;370.9425039118936;371.1352548561851;5380.838574842751;5421;5432.483914028171;5441.014029879096;5448.37343705474;5075.923861142086;5208.531232189102;5228.215767634857;5234.267202591631;5345.7594408251625;4141.316682747351;4181;4212.220739163265;4262.573742625744;4282;4242.705974677722;4252.936205956913;4258.978705106486;4276.87169384919;4284.100338928829;4147.4815648044;4189.832406703728;4210.347396153601;4223.936640950373;4225.873223803275;4211.263028969948;4215.072684009513;4221.620054195107;4222.19778242133;4230.894227644303;3781.4516895050338;3788.4317352397084;3789.147441825567;3790.4648617310036;3795.2599243147597;5050.949490505084;5183.663061900965;5230.764615592308;5245.344331958505;5250.5274525292525;4819.44576373718;4836.395450568679;4841.128596852565;4847.927281090787;4870.732109733964;5617.0731829248125;5619.550435965113;5624.55003599711;5632.3804381518;5639.774409023634;4073.348264277701;4165.10450253197;4173.4157217989505;4181.393697913785;4190.245755763961;5776.335721392052;5777.768889244425;5778.653280803165;5781.277340332458;5783.421657834225;4238.21593005295;4257.063446041866;4265.210935976854;4266.935995960063;4300.397944287803;3975.582563830756;4151.91696166075;4317.330813723878;4325.97837010813;4334.089841133397;4771.23660214364;4771.809127634925;4785.688930219594;4793.904121917542;4810.855674329776;5603.355614104348;5667.336351914676;5670.716464176775;5672.801451949244;5719.971400142973;1397.82527184102;1415.7168566286784;1423.501774378959;1429.3062720676032;1429.685469196775;1021.39737554843;1028.28534168752;1045.1273186889032;1050.3907733514695;1051.6319288249051;5252.501012403815;5286.15421532553;5289;5292.391374991848;5311.433127227478;5512.200730894078;5520;5534.667919924817;5552.5280351169795;5565.132233097958;5181.740912954338;5261.815836445706;5268.6575372600655;5287.365516138088;5522.6134170608475;3000.9549856752164;3015.306479509681;3017.230606195406;3020.154356780105;3033.453978283886;5724.284464441945;5881.588288819741;5890;5912.881742365214;5929.318128415288;5435.864103397367;5655.768414216833;5718.999175144333;5724.940885936116;5752.194692743019;5782.653040817564;5803.187553742479;5808.564357673192;5820.650760954356;5823.155642431823;5368.758405871823;5584.301962254718;5604.271444712162;5607.635503692247;5675.943240567542;5520.309961254843;5526.309211348582;5539.282822325092;5576.442355764553;5579.944200558105;5773.336066352424;5798;5801.767929282782;5825.155352473783;5847.502962248086;3945.881623551183;4083.2037752637953;4095.3037983543463;4098.815553300049;4108.404281379243;5512.972435137799;5622.409646987007;5662.716864156693;5771.163181338767;5781.682007489629;5588.385277619377;5631.774729010794;5660.811229641821;5661.122526008476;5665.405132461197;5396.595255355943;5620.819627878192;5640.774369025193;5644.6613203207935;5667.943320566742;5580.1629755537;5588.944110559005;5601.579881508822;5604.943950560442;5606.215129881902;5628.620987858001;5654.247183373003;5665.688387138582;5666.716664166857;5679.574031947538;5305.867353316198;5495.945040549544;5518.751656175402;5521.5306698929435;5526.861828454321 02:58:21 INFO - PROCESS | 12724 | |5;yui.html;770.2605498721227;787.3150359187508;798.6525861250357;806.1092492795459;849.4011721736176;14601.926990365033;14668.633284167874;14746.852531474682;14816.925915370408;15645.765313520293;13571.864281357184;14690.192039437827;14832.925835370836;14842.183679897602;14848.851511484881;843.3590471241854;864.0970186155482;864.6195673903494;866.1122349591687;866.4151697604124;854.8974123105236;856.7729551668813;858.9785255368603;859.2696208223023;859.3812455032366;885.9943963601327;886.8492356299412;886.8536691445904;887.5784002598779;887.6538150121457;878.9516576588285;879.4898958604026;879.7800549862534;879.8812160358366;880.2429910277157;643.0514990389186;645.9903101453482;646.6701981989172;647.1845474701862;647.870425914819;13654.795178072336;13719.725605487834;13738.793918091236;14339.354729037219;14723.484678036217;13597.844183244437;13922.234277114754;14181.175122668083;14253.144811311355;14322.427102915872;11984.760304793856;12367.257964522158;12503.937480312632;12518.937405313007;12645.936770316182;4432.091421258634;4480.73115613061;4492.775361231926;4519.615832654228;4546.181687296285;67344;68278;68280.31719682839;68444;68533.65733171352;11045.325835131933;11168.664940051649;11173;11175.329480231212;11406.315621062762;20686.58626827455;20811.583768324548;20825.68761468579;20868.47828804292;20872;8112.675492980333;8138.959305203554;8247.21651443112;8592.44149130317;8667.609957551798;4382.846600368972;4567.588916997486;4592.954070459253;4641.2109941310055;4729.55069268419;3222.548843161959;3318.1870441741926;3324.1523411529906;3324.384988777084;3330.966690333114;593.5815250248564;594.1236675903095;595.9761609535657;610.6305685060563;611.0223642172489;584.2667452347362;615.7110421479513;677.6848765324148;688.3357559954668;689.9448044156455;9077.77305567366;9101.499417531966;9385.343025988252;9536.713898583053;9612.567434465465;582.6358525921299;614.5452365249683;639.9168108145911;641.916550848396;679.3104998426601;4335.891602709894;4431.224535706238;4488.58686182263;4496.280595104768;4535.614472769786;70242.64878675676;90058.54970725236;92092;93203.53398232965;93646;47634;48338.75830620895;48952.26571601429;59695.701521492985;78720;70142;70282;70776.64611676909;70863.74817510863;71349;8500.829983400421;8614.741557753277;8709.695160669346;8797.516136612549;8919.73240802777;49038.50961490339;49641.255381170035;50049;50096;50612.74693626508;64092;66207;66483.66758166178;66926.330736692;67760.98358524725;11421.771564568828;11602.245854019462;11825.231359961575;11953.22304050234;11992.340421276913;12700;12864.807027894401;12896.871031289567;12921.96624270075;12948.417321220379;11009.06422954058;11045.282056666612;11088.445577721242;11134;11143.442827858737;11034.558617655204;11101.777964440827;11193.216474846682;11238.494267757807;11374.658760237206;11824.586139485076;11846.881531184577;11859.525618975144;12073.456694448947;12493.812592810933;9347.205487533636;9383.483908384831;9566.234701223746;9566.234701224024;9652.75868103275;9074.863877041718;9092.90907090947;9216.308776841897;9218.861717074384;9268.860967085364 02:58:21 INFO - PROCESS | 12724 | __end_tp_report 02:58:21 INFO - PROCESS | 12724 | __start_cc_report 02:58:21 INFO - PROCESS | 12724 | _x_x_mozilla_cycle_collect,1010 02:58:21 INFO - PROCESS | 12724 | __end_cc_report 02:58:21 INFO - PROCESS | 12724 | __startTimestamp1480762701107__endTimestamp 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | ------- Summary: start ------- 02:58:21 INFO - PROCESS | 12724 | Number of tests: 6 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | [#0] dojo.html Cycles:165 Average:5556.16 Median:5768.48 stddev:612.89 (10.6%) stddev-sans-first:587.65 02:58:21 INFO - PROCESS | 12724 | Values: 3257.9 3277.2 3306.7 3317.7 3336.9 5565.2 5601.9 5667.7 5689.7 5699.0 5553.8 5633.6 5634.4 5645.4 5659.5 5067.8 5073.5 5087.6 5140.9 5168.3 4981.3 4993.4 5197.3 5198.3 5204.7 5052.3 5062.4 5087.2 5096.5 5110.5 5103.8 5176.6 5184.8 5187.4 5216.9 4921.0 5066.5 5086.2 5118.9 5148.3 5429.6 5478.0 5499.8 5499.9 5516.5 5865.5 5887.1 5955.6 5958.9 5986.2 5869.4 6039.3 6039.6 6061.4 6063.8 5522.4 5587.6 5664.0 5673.9 5682.1 6189.5 6209.7 6210.8 6210.9 6213.4 5669.9 5965.6 5970.6 5976.9 5986.6 5768.5 5935.2 5955.5 5981.2 6074.8 6007.8 6022.1 6025.8 6030.8 6057.9 5982.1 6032.1 6038.1 6049.4 6050.0 4452.8 4479.0 4545.7 4574.2 4589.2 4133.5 4140.5 4143.6 4169.6 4181.7 5624.5 5629.3 5634.9 5636.3 5673.6 5778.4 5811.2 5988.6 6007.4 6023.7 5743.4 5769.1 5770.8 5773.2 5777.7 5274.5 5276.6 5281.4 5282.3 5289.6 5908.9 5967.9 6035.8 6252.4 6260.3 5829.8 5882.7 5921.6 5935.0 5951.8 6065.3 6068.2 6077.4 6078.2 6086.1 5792.0 5794.2 5798.2 5800.3 5810.2 5945.3 5975.8 5982.3 6027.5 6046.0 5851.1 5872.7 5881.9 5892.6 5898.0 5702.9 5875.4 5881.4 5896.4 5898.7 5103.1 5596.3 5717.2 5717.5 5828.2 5860.0 5877.9 5879.3 5879.9 5887.1 5653.6 5714.2 5715.1 5715.7 5746.5 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | [#1] ext.html Cycles:180 Average:60286.69 Median:21118.54 stddev:116182.98 (550.1%) stddev-sans-first:116422.42 02:58:21 INFO - PROCESS | 12724 | Values: 580.9 601.7 633.3 643.1 651.6 34749.7 45662.1 46416.3 46601.3 46827.0 47109.5 47122.0 47205.5 47646.0 47698.0 8195.3 8788.0 8924.1 8936.6 8937.2 8202.7 10597.6 10820.0 10852.9 11178.6 10902.5 10903.3 10915.9 10920.8 10930.5 10814.3 10833.5 10860.9 10873.7 10884.8 10617.8 10674.6 10682.9 10687.7 10699.3 43666.6 43957.3 43989.6 44124.6 44172.0 3734.3 3789.9 3807.6 3842.5 4005.6 33459.3 33475.8 33850.2 34262.0 34742.8 4092.8 4094.0 4135.5 4157.5 4178.3 395970.0 396911.0 397082.0 397109.0 398013.0 62950.4 63479.4 63556.7 63577.7 63638.7 39701.8 40647.2 40925.6 42896.0 42938.0 17185.4 17414.8 17416.2 17421.5 17424.5 11960.2 12098.6 12807.4 12888.8 12950.9 19922.7 20879.9 20909.9 20936.4 21116.8 7438.9 7534.0 7692.8 7701.4 7827.6 996.7 1043.1 1053.6 1059.4 1102.7 34330.3 34428.3 34780.8 34788.3 34864.8 1076.1 1123.8 1133.5 1145.7 1173.9 16406.8 18094.6 18102.2 18594.9 18952.9 546726.0 549971.0 551034.0 553513.0 556173.0 62040.0 62584.0 62674.4 62781.0 63143.0 1281.8 1355.4 1361.2 1417.8 1428.1 31117.5 34495.7 34872.8 34983.8 35022.1 53921.0 54681.0 54681.5 54706.7 54721.7 340190.0 341218.0 341257.0 342297.0 342551.0 30785.8 30819.4 31022.5 31685.7 32983.5 50348.0 50376.0 50406.7 50602.0 50996.2 42512.0 42589.0 43088.0 43882.8 44771.3 42225.2 42557.6 42695.8 42947.0 44244.6 43726.8 44049.0 44513.1 44671.3 44905.0 35020.5 37612.0 38371.6 38394.6 38696.8 29312.6 29953.6 29989.7 30003.5 30145.4 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | [#2] jquery.html Cycles:180 Average:28149.39 Median:11759.77 stddev:72314.13 (614.9%) stddev-sans-first:72486.97 02:58:21 INFO - PROCESS | 12724 | Values: 396.7 417.5 424.9 429.2 439.2 15612.5 20308.4 21432.5 21620.9 21829.7 19260.6 19573.9 19660.2 20410.4 20526.7 5467.7 5692.1 5692.6 5704.1 5704.2 5387.7 5674.1 5677.5 5681.4 5685.1 5534.9 5650.4 5651.9 5655.9 5657.2 5486.9 5607.7 5626.9 5640.2 5641.7 5111.5 5115.7 5122.2 5125.0 5203.1 14037.9 14451.9 14469.6 14470.6 19901.3 2289.3 2316.6 2336.9 2722.3 2780.6 10954.6 11062.6 11153.5 11321.7 11420.3 1940.7 1991.7 2019.6 2079.8 2087.1 78998.6 80197.0 80942.2 90101.0 95290.5 10566.2 11700.5 11960.2 12251.6 12312.4 14868.8 15361.6 15929.8 15954.1 15980.5 7526.0 8207.2 8330.3 8466.7 8547.3 7362.8 7387.9 7402.2 7774.5 7936.8 4927.5 5115.6 5141.5 5174.2 5262.8 1863.1 1963.4 2029.8 2144.7 2145.2 949.3 968.5 979.6 1024.9 1090.0 19597.3 19820.7 19931.3 20129.8 20326.1 1019.9 1039.2 1039.7 1068.8 1069.8 10428.6 11338.4 11351.1 11486.3 11517.3 387965.0 397540.0 401118.0 477659.0 489269.0 93942.0 105881.5 107154.5 107963.0 108025.0 1022.9 1052.8 1093.7 1127.7 1134.7 17933.7 18079.7 18282.6 18530.5 18905.4 44243.3 44828.8 46232.3 46555.0 47566.5 64291.7 65029.3 65445.7 65845.7 67770.0 8063.6 8904.6 8965.0 9058.5 9306.3 13154.9 13957.7 14123.6 14140.9 14199.1 11792.4 12005.0 12013.8 12277.8 12378.4 10801.9 11293.4 11319.5 11618.1 12370.9 11916.0 12148.5 12242.1 12519.1 12544.6 8367.7 8410.7 8466.3 8528.7 8549.4 10407.0 12191.8 12294.9 12419.1 12998.3 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | [#3] mootools.html Cycles:180 Average:5629.81 Median:5143.78 stddev:3070.56 (59.7%) stddev-sans-first:3063.24 02:58:21 INFO - PROCESS | 12724 | Values: 1467.9 1512.6 1666.2 1769.5 1798.6 8050.8 8571.5 8575.7 8580.9 8586.6 7520.7 7718.7 8026.8 8286.7 8404.6 2420.6 2449.3 2450.9 2456.4 2457.2 2432.4 2492.2 2497.2 2499.7 2500.5 2398.5 2400.7 2458.2 2463.7 2465.3 2366.0 2387.8 2404.3 2405.3 2416.0 2429.4 2436.9 2456.7 2457.2 2460.1 8335.3 8511.9 8527.9 8529.2 8537.4 5189.0 5351.5 5371.7 5373.4 5376.7 3335.2 3358.5 3428.2 3494.5 3549.6 1155.4 1166.2 1166.5 1177.8 1206.5 11725.8 11769.5 11778.8 11796.9 11805.0 4496.3 4765.5 4825.6 4841.0 4855.6 9854.4 9856.4 9856.5 9856.7 9859.2 5322.1 5339.7 5389.2 5394.3 5403.2 4469.8 4497.6 4702.2 4914.2 4969.4 3945.3 4035.7 4047.3 4069.5 4155.7 1338.6 1343.8 1347.1 1351.8 1361.8 938.6 983.1 997.9 1006.6 1011.5 5939.8 5967.9 5978.9 6044.5 6062.5 493.8 495.3 503.3 505.4 506.8 4053.4 4151.4 4189.3 4198.0 4271.8 9876.7 10323.9 10364.7 10367.1 10386.7 10155.0 10207.0 10241.2 10243.3 10245.6 7835.3 7942.4 8009.9 8039.0 8043.8 5748.1 5801.7 5873.4 5898.8 5965.2 9427.7 9469.8 9500.0 9552.9 9611.2 9722.3 9722.8 9805.8 9825.2 9825.4 6847.2 6956.0 6970.9 7547.8 7613.4 7261.5 7882.8 7995.4 8215.8 8219.3 7210.6 7347.9 7413.5 7438.4 7603.7 7042.1 7078.8 7127.0 7195.6 7488.8 6683.3 6780.9 6805.7 6814.6 6815.8 4924.5 4955.6 5042.0 5094.1 5281.9 5098.6 5262.2 5263.5 5281.1 5389.5 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | [#4] prototype.html Cycles:180 Average:4716.57 Median:5290.70 stddev:1351.08 (25.5%) stddev-sans-first:1314.51 02:58:21 INFO - PROCESS | 12724 | Values: 349.6 360.3 367.1 370.9 371.1 5380.8 5421.0 5432.5 5441.0 5448.4 5075.9 5208.5 5228.2 5234.3 5345.8 4141.3 4181.0 4212.2 4262.6 4282.0 4242.7 4252.9 4259.0 4276.9 4284.1 4147.5 4189.8 4210.3 4223.9 4225.9 4211.3 4215.1 4221.6 4222.2 4230.9 3781.5 3788.4 3789.1 3790.5 3795.3 5050.9 5183.7 5230.8 5245.3 5250.5 4819.4 4836.4 4841.1 4847.9 4870.7 5617.1 5619.6 5624.6 5632.4 5639.8 4073.3 4165.1 4173.4 4181.4 4190.2 5776.3 5777.8 5778.7 5781.3 5783.4 4238.2 4257.1 4265.2 4266.9 4300.4 3975.6 4151.9 4317.3 4326.0 4334.1 4771.2 4771.8 4785.7 4793.9 4810.9 5603.4 5667.3 5670.7 5672.8 5720.0 1397.8 1415.7 1423.5 1429.3 1429.7 1021.4 1028.3 1045.1 1050.4 1051.6 5252.5 5286.2 5289.0 5292.4 5311.4 5512.2 5520.0 5534.7 5552.5 5565.1 5181.7 5261.8 5268.7 5287.4 5522.6 3001.0 3015.3 3017.2 3020.2 3033.5 5724.3 5881.6 5890.0 5912.9 5929.3 5435.9 5655.8 5719.0 5724.9 5752.2 5782.7 5803.2 5808.6 5820.7 5823.2 5368.8 5584.3 5604.3 5607.6 5675.9 5520.3 5526.3 5539.3 5576.4 5579.9 5773.3 5798.0 5801.8 5825.2 5847.5 3945.9 4083.2 4095.3 4098.8 4108.4 5513.0 5622.4 5662.7 5771.2 5781.7 5588.4 5631.8 5660.8 5661.1 5665.4 5396.6 5620.8 5640.8 5644.7 5667.9 5580.2 5588.9 5601.6 5604.9 5606.2 5628.6 5654.2 5665.7 5666.7 5679.6 5305.9 5495.9 5518.8 5521.5 5526.9 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - PROCESS | 12724 | [#5] yui.html Cycles:180 Average:17476.84 Median:593.85 stddev:23282.03 (3920.5%) stddev-sans-first:23313.54 02:58:21 INFO - PROCESS | 12724 | Values: 770.3 787.3 798.7 806.1 849.4 14601.9 14668.6 14746.9 14816.9 15645.8 13571.9 14690.2 14832.9 14842.2 14848.9 843.4 864.1 864.6 866.1 866.4 854.9 856.8 859.0 859.3 859.4 886.0 886.8 886.9 887.6 887.7 879.0 879.5 879.8 879.9 880.2 643.1 646.0 646.7 647.2 647.9 13654.8 13719.7 13738.8 14339.4 14723.5 13597.8 13922.2 14181.2 14253.1 14322.4 11984.8 12367.3 12503.9 12518.9 12645.9 4432.1 4480.7 4492.8 4519.6 4546.2 67344.0 68278.0 68280.3 68444.0 68533.7 11045.3 11168.7 11173.0 11175.3 11406.3 20686.6 20811.6 20825.7 20868.5 20872.0 8112.7 8139.0 8247.2 8592.4 8667.6 4382.8 4567.6 4593.0 4641.2 4729.6 3222.5 3318.2 3324.2 3324.4 3331.0 593.6 594.1 596.0 610.6 611.0 584.3 615.7 677.7 688.3 689.9 9077.8 9101.5 9385.3 9536.7 9612.6 582.6 614.5 639.9 641.9 679.3 4335.9 4431.2 4488.6 4496.3 4535.6 70242.6 90058.5 92092.0 93203.5 93646.0 47634.0 48338.8 48952.3 59695.7 78720.0 70142.0 70282.0 70776.6 70863.7 71349.0 8500.8 8614.7 8709.7 8797.5 8919.7 49038.5 49641.3 50049.0 50096.0 50612.7 64092.0 66207.0 66483.7 66926.3 67761.0 11421.8 11602.2 11825.2 11953.2 11992.3 12700.0 12864.8 12896.9 12922.0 12948.4 11009.1 11045.3 11088.4 11134.0 11143.4 11034.6 11101.8 11193.2 11238.5 11374.7 11824.6 11846.9 11859.5 12073.5 12493.8 9347.2 9383.5 9566.2 9566.2 9652.8 9074.9 9092.9 9216.3 9218.9 9268.9 02:58:21 INFO - PROCESS | 12724 | -------- Summary: end -------- 02:58:21 INFO - PROCESS | 12724 | 02:58:21 INFO - TEST-INFO | 12724: exit 0 02:58:21 INFO - TEST-OK | dromaeo_css | took 1115083ms 02:58:21 INFO - TEST-START | kraken 02:58:21 INFO - operating with platform_type : linux_ 02:58:21 INFO - Initialising browser for kraken test... 02:58:21 INFO - TEST-INFO | started process 13040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpetZgia/profile http://localhost:58918/getInfo.html) 02:58:25 INFO - PROCESS | 13040 | __metrics Screen width/height:1600/1200 02:58:25 INFO - PROCESS | 13040 | colorDepth:24 02:58:25 INFO - PROCESS | 13040 | Browser inner width/height: 1024/697 02:58:25 INFO - PROCESS | 13040 | __metrics 02:58:26 INFO - PROCESS | 13040 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:58:26 INFO - PROCESS | 13040 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:26 INFO - PROCESS | 13040 | console.error: PushService: 02:58:26 INFO - PROCESS | 13040 | stateChangeProcessEnqueue: Error transitioning state 02:58:26 INFO - PROCESS | 13040 | UnknownError 02:58:27 INFO - TEST-INFO | 13040: exit 0 02:58:27 INFO - Browser initialized. 02:58:27 INFO - Running cycle 1/1 for kraken test... 02:58:27 INFO - TEST-INFO | started process 13134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpetZgia/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:39 INFO - PROCESS | 13134 | RSS: Main: 147070976 02:58:39 INFO - PROCESS | 13134 | 02:58:41 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58918/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:42 INFO - PROCESS | 13134 | RSS: Main: 188874752 02:58:42 INFO - PROCESS | 13134 | 02:58:45 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58918/tests/kraken/driver.html?testName=audio-dft) 02:58:45 INFO - PROCESS | 13134 | RSS: Main: 178782208 02:58:45 INFO - PROCESS | 13134 | 02:58:48 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58918/tests/kraken/driver.html?testName=audio-fft) 02:58:49 INFO - PROCESS | 13134 | RSS: Main: 269578240 02:58:49 INFO - PROCESS | 13134 | 02:58:51 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58918/tests/kraken/driver.html?testName=audio-oscillator) 02:58:51 INFO - PROCESS | 13134 | RSS: Main: 176324608 02:58:51 INFO - PROCESS | 13134 | 02:58:53 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58918/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:54 INFO - PROCESS | 13134 | RSS: Main: 178634752 02:58:54 INFO - PROCESS | 13134 | 02:58:57 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58918/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:57 INFO - PROCESS | 13134 | RSS: Main: 217202688 02:58:57 INFO - PROCESS | 13134 | 02:59:01 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58918/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:01 INFO - PROCESS | 13134 | RSS: Main: 215752704 02:59:01 INFO - PROCESS | 13134 | 02:59:04 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58918/tests/kraken/driver.html?testName=json-parse-financial) 02:59:05 INFO - PROCESS | 13134 | RSS: Main: 214192128 02:59:05 INFO - PROCESS | 13134 | 02:59:06 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58918/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:07 INFO - PROCESS | 13134 | RSS: Main: 176697344 02:59:07 INFO - PROCESS | 13134 | 02:59:08 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:09 INFO - PROCESS | 13134 | RSS: Main: 183451648 02:59:09 INFO - PROCESS | 13134 | 02:59:11 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:11 INFO - PROCESS | 13134 | RSS: Main: 190132224 02:59:11 INFO - PROCESS | 13134 | 02:59:14 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:15 INFO - PROCESS | 13134 | RSS: Main: 198897664 02:59:15 INFO - PROCESS | 13134 | 02:59:17 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:18 INFO - PROCESS | 13134 | RSS: Main: 196182016 02:59:18 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | Cycle 1(1): loaded http://localhost:58918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58918/tests/kraken/driver.html?testName=ai-astar) 02:59:20 INFO - PROCESS | 13134 | RSS: Main: 246718464 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | __start_tp_report 02:59:20 INFO - PROCESS | 13134 | _x_x_mozilla_page_load 02:59:20 INFO - PROCESS | 13134 | _x_x_mozilla_page_load_details 02:59:20 INFO - PROCESS | 13134 | |i|pagename|runs| 02:59:20 INFO - PROCESS | 13134 | |0;ai-astar;103;115;112;110;116;111;112;112;112;110 02:59:20 INFO - PROCESS | 13134 | |1;audio-beat-detection;152;122;123;156;123;123;121;122;148;128 02:59:20 INFO - PROCESS | 13134 | |2;audio-dft;160;160;161;161;161;160;160;160;158;161 02:59:20 INFO - PROCESS | 13134 | |3;audio-fft;74;76;76;109;76;75;74;76;108;74 02:59:20 INFO - PROCESS | 13134 | |4;audio-oscillator;81;82;117;83;89;81;101;81;81;115 02:59:20 INFO - PROCESS | 13134 | |5;imaging-gaussian-blur;117;117;117;118;116;116;116;117;117;117 02:59:20 INFO - PROCESS | 13134 | |6;imaging-darkroom;148;149;147;148;148;148;148;149;149;146 02:59:20 INFO - PROCESS | 13134 | |7;imaging-desaturate;85;85;84;85;84;84;85;85;84;85 02:59:20 INFO - PROCESS | 13134 | |8;json-parse-financial;49;52;50;50;50;52;50;50;49;50 02:59:20 INFO - PROCESS | 13134 | |9;json-stringify-tinderbox;58;59;57;58;60;58;59;57;58;58 02:59:20 INFO - PROCESS | 13134 | |10;stanford-crypto-aes;75;77;76;76;75;76;76;75;75;76 02:59:20 INFO - PROCESS | 13134 | |11;stanford-crypto-ccm;130;129;126;135;129;125;128;124;165;125 02:59:20 INFO - PROCESS | 13134 | |12;stanford-crypto-pbkdf2;157;155;156;158;161;160;159;158;155;162 02:59:20 INFO - PROCESS | 13134 | |13;stanford-crypto-sha256-iterative;64;66;64;65;65;63;63;64;63;64 02:59:20 INFO - PROCESS | 13134 | __end_tp_report 02:59:20 INFO - PROCESS | 13134 | __start_cc_report 02:59:20 INFO - PROCESS | 13134 | _x_x_mozilla_cycle_collect,1616 02:59:20 INFO - PROCESS | 13134 | __end_cc_report 02:59:20 INFO - PROCESS | 13134 | __startTimestamp1480762760400__endTimestamp 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | ------- Summary: start ------- 02:59:20 INFO - PROCESS | 13134 | Number of tests: 14 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:2.05 02:59:20 INFO - PROCESS | 13134 | Values: 103.0 115.0 112.0 110.0 116.0 111.0 112.0 112.0 112.0 110.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:125.50 stddev:14.19 (11.3%) stddev-sans-first:13.03 02:59:20 INFO - PROCESS | 13134 | Values: 152.0 122.0 123.0 156.0 123.0 123.0 121.0 122.0 148.0 128.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:0.92 (0.6%) stddev-sans-first:0.97 02:59:20 INFO - PROCESS | 13134 | Values: 160.0 160.0 161.0 161.0 161.0 160.0 160.0 160.0 158.0 161.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:14.10 (18.7%) stddev-sans-first:14.67 02:59:20 INFO - PROCESS | 13134 | Values: 74.0 76.0 76.0 109.0 76.0 75.0 74.0 76.0 108.0 74.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.00 stddev:14.53 (17.9%) stddev-sans-first:14.95 02:59:20 INFO - PROCESS | 13134 | Values: 81.0 82.0 117.0 83.0 89.0 81.0 101.0 81.0 81.0 115.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:59:20 INFO - PROCESS | 13134 | Values: 117.0 117.0 117.0 118.0 116.0 116.0 116.0 117.0 117.0 117.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 02:59:20 INFO - PROCESS | 13134 | Values: 148.0 149.0 147.0 148.0 148.0 148.0 148.0 149.0 149.0 146.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 02:59:20 INFO - PROCESS | 13134 | Values: 85.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.03 (2.1%) stddev-sans-first:1.00 02:59:20 INFO - PROCESS | 13134 | Values: 49.0 52.0 50.0 50.0 50.0 52.0 50.0 50.0 49.0 50.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 02:59:20 INFO - PROCESS | 13134 | Values: 58.0 59.0 57.0 58.0 60.0 58.0 59.0 57.0 58.0 58.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:0.67 (0.9%) stddev-sans-first:0.67 02:59:20 INFO - PROCESS | 13134 | Values: 75.0 77.0 76.0 76.0 75.0 76.0 76.0 75.0 75.0 76.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:129.00 stddev:12.17 (9.4%) stddev-sans-first:12.89 02:59:20 INFO - PROCESS | 13134 | Values: 130.0 129.0 126.0 135.0 129.0 125.0 128.0 124.0 165.0 125.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.50 stddev:2.42 (1.5%) stddev-sans-first:2.54 02:59:20 INFO - PROCESS | 13134 | Values: 157.0 155.0 156.0 158.0 161.0 160.0 159.0 158.0 155.0 162.0 02:59:20 INFO - PROCESS | 13134 | 02:59:20 INFO - PROCESS | 13134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 02:59:20 INFO - PROCESS | 13134 | Values: 64.0 66.0 64.0 65.0 65.0 63.0 63.0 64.0 63.0 64.0 02:59:20 INFO - PROCESS | 13134 | -------- Summary: end -------- 02:59:20 INFO - PROCESS | 13134 | 02:59:21 INFO - TEST-INFO | 13134: exit 0 02:59:21 INFO - TEST-OK | kraken | took 59504ms 02:59:21 INFO - SUITE-END | took 1174s 02:59:21 INFO - Completed test suite (00:19:34) 02:59:21 INFO - javascript benchmark 02:59:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.9185520361993, 3277.1807048237943, 3306.735461163106, 3317.6848199421047, 3336.9332613347733, 5565.220869078333, 5601.943980560199, 5667.659940403579, 5689.715514224288, 5699.031164702, 5553.805616803413, 5633.57748168888, 5634.3520495143075, 5645.435456454353, 5659.490645841874, 5067.822626208083, 5073.467285934979, 5087.643864929457, 5140.8971820563565, 5168.250603662485, 4981.302617633534, 4993.375828021497, 5197.298364720771, 5198.324217851674, 5204.739763011853, 5052.26742122392, 5062.367204099488, 5087.160618497944, 5096.51583099605, 5110.463401342861, 5103.795848166087, 5176.637635365526, 5184.844454666366, 5187.385968235601, 5216.947830521684, 4921.0, 5066.544011039025, 5086.21163719624, 5118.872028199287, 5148.304978827848, 5429.647072940246, 5477.972610136924, 5499.752511137009, 5499.945000549983, 5516.475934786189, 5865.472107510344, 5887.116932460165, 5955.583109182359, 5958.851028724273, 5986.221791167164, 5869.354371019184, 6039.275286965549, 6039.5772295939305, 6061.393860613947, 6063.757449702007, 5522.392536820947, 5587.608867379326, 5664.037113690682, 5673.886522269614, 5682.090865461506, 6189.473894718909, 6209.65846878417, 6210.813675589739, 6210.9068363974575, 6213.409726076015, 5669.914951275734, 5965.582409231399, 5970.611910225822, 5976.910346344808, 5986.640801551921, 5768.4808367246305, 5935.169076329317, 5955.464008239279, 5981.222441082631, 6074.757009719562, 6007.789727359609, 6022.066579680157, 6025.78909738157, 6030.7889223876955, 6057.909131363033, 5982.102684597258, 6032.095185722177, 6038.064100064497, 6049.364816694272, 6050.0017497112485, 4452.821887124479, 4479.0, 4545.749983750926, 4574.245249533789, 4589.196890544142, 4133.503979522417, 4140.4617399738445, 4143.56492568282, 4169.645580125723, 4181.707280490336, 5624.493795558419, 5629.296337957755, 5634.887302254014, 5636.2954630671165, 5673.574481913873, 5778.393268706809, 5811.2445382100905, 5988.550858685616, 6007.3992600739575, 6023.728932197974, 5743.368229494752, 5769.105788602773, 5770.798022069207, 5773.162891380726, 5777.653340799566, 5274.498922602346, 5276.551493123051, 5281.419043905167, 5282.286891269629, 5289.576833853283, 5908.940910590839, 5967.940320596738, 6035.818925432244, 6252.374762523711, 6260.311365749764, 5829.76680932758, 5882.676452795137, 5921.61509501881, 5935.0, 5951.7619295227705, 6065.272167339947, 6068.150458935841, 6077.392260773887, 6078.240219972504, 6086.087086936818, 5791.971040144772, 5794.159846822272, 5798.188253644409, 5800.332961709458, 5810.244668193108, 5945.34601193877, 5975.760969561343, 5982.282126144891, 6027.517798576191, 6046.03263477859, 5851.093080572518, 5872.677002764889, 5881.911771323519, 5892.558058145742, 5898.026825573732, 5702.942970570241, 5875.383084776037, 5881.382454842351, 5896.351401345934, 5898.734556945034, 5103.132467480463, 5596.300462442195, 5717.1995920570325, 5717.485426311652, 5828.154917536848, 5860.0, 5877.853053673693, 5879.265091863517, 5879.882402352015, 5887.087501437284, 5653.604247702621, 5714.171445140514, 5715.057015592547, 5715.657060576379, 5746.5402767779315], "value": 5516.426728525874, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.918671386006, 601.7442586900567, 633.2527617411453, 643.0964494884689, 651.5862427358629, 34749.65250347496, 45662.08675826486, 46416.303755443696, 46601.30098048532, 46827.0, 47109.52890471094, 47122.0, 47205.52794472054, 47646.0, 47698.0, 8195.34437245022, 8787.95606021969, 8924.107589241057, 8936.64253429862, 8937.240334571537, 8202.712905048325, 10597.576096956112, 10820.0, 10852.891471085306, 11178.552857885716, 10902.454877256145, 10903.29128606642, 10915.890841091566, 10920.781584368307, 10930.453477326142, 10814.29707069038, 10833.512491937881, 10860.945695271474, 10873.728156796104, 10884.782304353948, 10617.84073238902, 10674.626388076458, 10682.893171068268, 10687.732806679818, 10699.251052426256, 43666.56333436688, 43957.340639890426, 43989.560104398864, 44124.55875441269, 44172.0, 3734.3464893643504, 3789.905252368713, 3807.600201978808, 3842.4620553122586, 4005.619466150711, 33459.330813383596, 33475.83262083698, 33850.153746156546, 34262.0, 34742.826285868665, 4092.815823287959, 4093.9590604093873, 4135.462389889325, 4157.521884983235, 4178.289690752579, 395970.0, 396911.0, 397082.0, 397109.0, 398013.0, 62950.370496294454, 63479.365206348266, 63556.68221658862, 63577.68211158914, 63638.68180659067, 39701.80149099294, 40647.1870562593, 40925.59074409278, 42896.0, 42938.0, 17185.39851105205, 17414.825851741574, 17416.21627026787, 17421.47735567935, 17424.47726568205, 11960.222585532087, 12098.57654982089, 12807.423665935055, 12888.80666789999, 12950.935245323713, 19922.701159482618, 20879.8956005219, 20909.89545052265, 20936.37190884276, 21116.78883211179, 7438.925610743823, 7534.0, 7692.7692169235015, 7701.362365340379, 7827.6477558510005, 996.7209181429212, 1043.0820877627639, 1053.599632139782, 1059.4384975962753, 1102.7022703869911, 34330.31339373199, 34428.31143377118, 34780.82609586987, 34788.26058697055, 34864.825675871456, 1076.0907033556632, 1123.7920984617872, 1133.5295852221236, 1145.7479354541988, 1173.9354335511457, 16406.75389869129, 18094.63810723778, 18102.185401656956, 18594.907025465058, 18952.90523547401, 546726.0, 549971.0, 551034.0, 553513.0, 556173.0, 62040.0, 62584.0, 62674.37325626685, 62781.0, 63143.0, 1281.7564662714055, 1355.403622406138, 1361.237706884148, 1417.7944198091425, 1428.0860249440366, 31117.533237001917, 34495.65504345025, 34872.82563587166, 34983.825080874434, 35022.12444688903, 53921.0, 54681.0, 54681.45318546764, 54706.72646636901, 54721.72639136779, 340190.0, 341218.0, 341257.0, 342297.0, 342551.0, 30785.8460707695, 30819.383612328078, 31022.53466198054, 31685.683143169197, 32983.50524742083, 50348.0, 50376.0, 50406.747966259936, 50602.0, 50996.23505647492, 42512.0, 42589.0, 43088.0, 43882.780586096866, 44771.32843007422, 42225.155496890504, 42557.57442425536, 42695.786521067195, 42947.0, 44244.55755442533, 43726.78136609297, 44049.0, 44513.10973780571, 44671.32993005042, 44905.0, 35020.47469288014, 37612.0, 38371.6162838368, 38394.61605384022, 38696.80651596724, 29312.56031159577, 29953.55069673913, 29989.70010299869, 30003.54994675038, 30145.397092058476], "value": 21029.381084428842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.6707632664885, 417.4552209366777, 424.93877590529377, 429.2316753012108, 439.20065480824894, 15612.453564125259, 20308.390748277558, 21432.464188395297, 21620.8918955405, 21829.67255491167, 19260.61478770427, 19573.90213048933, 19660.213591456326, 20410.387688369334, 20526.69209961848, 5467.726613669311, 5692.117721753135, 5692.6299790513485, 5704.087346024637, 5704.2299289595785, 5387.730613469311, 5674.063779476382, 5677.48902598766, 5681.431856814306, 5685.118806584986, 5534.916976245359, 5650.406707295737, 5651.943480565204, 5655.886882262353, 5657.23627310312, 5486.945130548704, 5607.719614019303, 5626.887462250773, 5640.238567793336, 5641.68970706613, 5111.463296353866, 5115.693058416469, 5122.180451127839, 5124.9743751281, 5203.089459344637, 14037.859621403757, 14451.855481445262, 14469.638259043502, 14470.638234044232, 19901.303454379027, 2289.267434420986, 2316.6409206573007, 2336.906523739048, 2722.3058120179226, 2780.638516992778, 10954.616588419367, 11062.612808551743, 11153.498092585853, 11321.660350189508, 11420.31478111316, 1940.7380003699461, 1991.6614175590184, 2019.6061767955255, 2079.781622929586, 2087.081684059009, 78998.6050069746, 80197.0, 80942.19057809464, 90101.0, 95290.52354738182, 10566.154707623371, 11700.473478693479, 11960.222585531912, 12251.632451026484, 12312.445939932724, 14868.776968345483, 15361.6159596011, 15929.840701593068, 15954.1225232611, 15980.520584382488, 7525.962370188114, 8207.220314070153, 8330.291925186306, 8466.703665371682, 8547.316214702932, 7362.77911662651, 7387.85224295511, 7402.222766609536, 7774.455788094779, 7936.801579960547, 4927.507249275115, 5115.641905066684, 5141.53726164647, 5174.223866420067, 5262.7631756571045, 1863.1057092595358, 1963.4475182263002, 2029.797020297988, 2144.656854903208, 2145.227718021511, 949.3164921256684, 968.4867020479157, 979.5934687104772, 1024.8770147582338, 1089.9727506812394, 19597.314094006928, 19820.70268945967, 19931.302404415776, 20129.798702013086, 20326.08532616036, 1019.9031092046243, 1039.158281791751, 1039.6621098143135, 1068.8183008888507, 1069.8234791259356, 10428.612599004202, 11338.376389298668, 11351.148663850245, 11486.253393529394, 11517.251378660529, 387965.0, 397540.0, 401118.0, 477659.0, 489269.0, 93942.0, 105881.47059264808, 107154.46422767993, 107963.0, 108025.0, 1022.8925962773801, 1052.8473371360956, 1093.7375029992745, 1127.7180704823795, 1134.65393055119, 17933.73099403484, 18079.728804067687, 18282.634347312713, 18530.536736581693, 18905.432837014912, 44243.33634995542, 44828.77585612051, 46232.30651540297, 46555.0, 47566.52433475621, 64291.67854160699, 65029.349706502326, 65445.67277163584, 65845.68308633704, 67770.0, 8063.637136328996, 8904.626631438856, 8965.0, 9058.501782401767, 9306.348555601044, 13154.934225328812, 13957.720845583235, 14123.64690882736, 14140.858591413955, 14199.148051116967, 11792.351420671945, 12005.0, 12013.75972480563, 12277.815832762337, 12378.381080946097, 10801.945990269998, 11293.37886416255, 11319.547218111184, 11618.128640351839, 12370.938145309216, 11916.046716262852, 12148.453319600463, 12242.143049986771, 12519.061070419573, 12544.623661290176, 8367.748967530984, 8410.663573457237, 8466.322694184328, 8528.658853645784, 8549.401541892257, 10407.0, 12191.817122743343, 12294.877051229374, 12419.068569857478, 12998.285094319903], "value": 9393.540808984464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.8752306053982, 1512.6369671278892, 1666.2085509383044, 1769.5310742653207, 1798.6402719456105, 8050.838983220332, 8571.528565928871, 8575.699850505234, 8580.91419085809, 8586.613602387892, 7520.6991720331125, 7718.652660630271, 8026.759197224078, 8286.709965151222, 8404.62179201936, 2420.624803155509, 2449.326435230308, 2450.8529488230674, 2456.3736247256925, 2457.1645640482234, 2432.3631487616394, 2492.239866840613, 2497.1759319424546, 2499.7250302466805, 2500.499900019994, 2398.5083057973075, 2400.6519054737055, 2458.1765108688523, 2463.6797216361847, 2465.2973902437807, 2365.9999999999914, 2387.8328517003815, 2404.326788499223, 2405.302462285944, 2416.0, 2429.392651837041, 2436.9390765230833, 2456.6929133858266, 2457.1522824625476, 2460.126655037454, 8335.291500222489, 8511.914880851175, 8527.914720852774, 8529.23236908675, 8537.402381833273, 5188.974055129738, 5351.464853514617, 5371.704556249405, 5373.382061062989, 5376.731163441812, 3335.232896433834, 3358.462645976632, 3428.160100775301, 3494.475828625701, 3549.6095429502734, 1155.381870699172, 1166.241942737219, 1166.5158959031992, 1177.7585594953014, 1206.5173930427811, 11725.824112638316, 11769.470373833112, 11778.764424711459, 11796.882031179664, 11804.999999999915, 4496.303073023687, 4765.475797662254, 4825.613950883921, 4841.031793641286, 4855.562999330077, 9854.408735475894, 9856.408615482951, 9856.45789481571, 9856.704298871045, 9859.161971232383, 5322.14845624706, 5339.733013349317, 5389.191621256765, 5394.271773310631, 5403.189521571796, 4469.821207151743, 4497.572730590588, 4702.200625893606, 4914.164592019294, 4969.428515720666, 3945.3292940200236, 4035.7376770509823, 4047.3119569673227, 4069.5116586009867, 4155.688323375698, 1338.5716570697284, 1343.7648411527944, 1347.1041757231528, 1351.7566837969064, 1361.8229630148016, 938.5682586010512, 983.1250187333136, 997.8602995580625, 1006.5571148694551, 1011.5296387179997, 5939.762409503658, 5967.910481342783, 5978.85052873673, 6044.455998960115, 6062.514998800086, 493.77286448234213, 495.34119620904113, 503.29036059157147, 505.37838458695273, 506.7972810875679, 4053.3717273822604, 4151.418801367811, 4189.308764053958, 4197.97901010493, 4271.807768650418, 9876.654317098866, 10323.948380258202, 10364.689059328231, 10367.066963973128, 10386.688399348031, 10155.0, 10207.030332118436, 10241.180705543538, 10243.282970192015, 10245.641402550875, 7835.2948234658015, 7942.404319675932, 8009.919900801034, 8038.959805200937, 8043.798905027421, 5748.080307150836, 5801.709914504174, 5873.353931067664, 5898.764049437975, 5965.164876917148, 9427.717168484956, 9469.810603787748, 9499.952500237454, 9552.904470955202, 9611.231101511723, 9722.27082968766, 9722.75693107678, 9805.803883922425, 9825.213982881496, 9825.4104753715, 6847.21257055425, 6956.0, 6970.895436568354, 7547.849043018999, 7613.352865006536, 7261.5280006799385, 7882.842343153219, 7995.360371170176, 8215.794605134919, 8219.260266576037, 7210.567365958059, 7347.853042939005, 7413.518121322097, 7438.404927605887, 7603.657835397531, 7042.084529011196, 7078.752243671447, 7127.037849890406, 7195.604241766544, 7488.812779680552, 6683.331666833278, 6780.864382712417, 6805.693743781443, 6814.625195614289, 6815.795526134224, 4924.458309586014, 4955.628327875352, 5042.0, 5094.083065048327, 5281.880133495879, 5098.592112630907, 5262.237325404193, 5263.473652634706, 5281.128613778684, 5389.51494365509], "value": 4529.90871216942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.55082718706467, 360.27764332513306, 367.07130958674554, 370.9425039118936, 371.1352548561851, 5380.838574842751, 5421.0, 5432.483914028171, 5441.014029879096, 5448.37343705474, 5075.923861142086, 5208.531232189102, 5228.215767634857, 5234.267202591631, 5345.7594408251625, 4141.316682747351, 4181.0, 4212.220739163265, 4262.573742625744, 4282.0, 4242.705974677722, 4252.936205956913, 4258.978705106486, 4276.87169384919, 4284.100338928829, 4147.4815648044, 4189.832406703728, 4210.347396153601, 4223.936640950373, 4225.873223803275, 4211.263028969948, 4215.072684009513, 4221.620054195107, 4222.19778242133, 4230.894227644303, 3781.4516895050338, 3788.4317352397084, 3789.147441825567, 3790.4648617310036, 3795.2599243147597, 5050.949490505084, 5183.663061900965, 5230.764615592308, 5245.344331958505, 5250.5274525292525, 4819.44576373718, 4836.395450568679, 4841.128596852565, 4847.927281090787, 4870.732109733964, 5617.0731829248125, 5619.550435965113, 5624.55003599711, 5632.3804381518, 5639.774409023634, 4073.348264277701, 4165.10450253197, 4173.4157217989505, 4181.393697913785, 4190.245755763961, 5776.335721392052, 5777.768889244425, 5778.653280803165, 5781.277340332458, 5783.421657834225, 4238.21593005295, 4257.063446041866, 4265.210935976854, 4266.935995960063, 4300.397944287803, 3975.582563830756, 4151.91696166075, 4317.330813723878, 4325.97837010813, 4334.089841133397, 4771.23660214364, 4771.809127634925, 4785.688930219594, 4793.904121917542, 4810.855674329776, 5603.355614104348, 5667.336351914676, 5670.716464176775, 5672.801451949244, 5719.971400142973, 1397.82527184102, 1415.7168566286784, 1423.501774378959, 1429.3062720676032, 1429.685469196775, 1021.39737554843, 1028.28534168752, 1045.1273186889032, 1050.3907733514695, 1051.6319288249051, 5252.501012403815, 5286.15421532553, 5289.0, 5292.391374991848, 5311.433127227478, 5512.200730894078, 5520.0, 5534.667919924817, 5552.5280351169795, 5565.132233097958, 5181.740912954338, 5261.815836445706, 5268.6575372600655, 5287.365516138088, 5522.6134170608475, 3000.9549856752164, 3015.306479509681, 3017.230606195406, 3020.154356780105, 3033.453978283886, 5724.284464441945, 5881.588288819741, 5890.0, 5912.881742365214, 5929.318128415288, 5435.864103397367, 5655.768414216833, 5718.999175144333, 5724.940885936116, 5752.194692743019, 5782.653040817564, 5803.187553742479, 5808.564357673192, 5820.650760954356, 5823.155642431823, 5368.758405871823, 5584.301962254718, 5604.271444712162, 5607.635503692247, 5675.943240567542, 5520.309961254843, 5526.309211348582, 5539.282822325092, 5576.442355764553, 5579.944200558105, 5773.336066352424, 5798.0, 5801.767929282782, 5825.155352473783, 5847.502962248086, 3945.881623551183, 4083.2037752637953, 4095.3037983543463, 4098.815553300049, 4108.404281379243, 5512.972435137799, 5622.409646987007, 5662.716864156693, 5771.163181338767, 5781.682007489629, 5588.385277619377, 5631.774729010794, 5660.811229641821, 5661.122526008476, 5665.405132461197, 5396.595255355943, 5620.819627878192, 5640.774369025193, 5644.6613203207935, 5667.943320566742, 5580.1629755537, 5588.944110559005, 5601.579881508822, 5604.943950560442, 5606.215129881902, 5628.620987858001, 5654.247183373003, 5665.688387138582, 5666.716664166857, 5679.574031947538, 5305.867353316198, 5495.945040549544, 5518.751656175402, 5521.5306698929435, 5526.861828454321], "value": 4297.34932824795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.2605498721227, 787.3150359187508, 798.6525861250357, 806.1092492795459, 849.4011721736176, 14601.926990365033, 14668.633284167874, 14746.852531474682, 14816.925915370408, 15645.765313520293, 13571.864281357184, 14690.192039437827, 14832.925835370836, 14842.183679897602, 14848.851511484881, 843.3590471241854, 864.0970186155482, 864.6195673903494, 866.1122349591687, 866.4151697604124, 854.8974123105236, 856.7729551668813, 858.9785255368603, 859.2696208223023, 859.3812455032366, 885.9943963601327, 886.8492356299412, 886.8536691445904, 887.5784002598779, 887.6538150121457, 878.9516576588285, 879.4898958604026, 879.7800549862534, 879.8812160358366, 880.2429910277157, 643.0514990389186, 645.9903101453482, 646.6701981989172, 647.1845474701862, 647.870425914819, 13654.795178072336, 13719.725605487834, 13738.793918091236, 14339.354729037219, 14723.484678036217, 13597.844183244437, 13922.234277114754, 14181.175122668083, 14253.144811311355, 14322.427102915872, 11984.760304793856, 12367.257964522158, 12503.937480312632, 12518.937405313007, 12645.936770316182, 4432.091421258634, 4480.73115613061, 4492.775361231926, 4519.615832654228, 4546.181687296285, 67344.0, 68278.0, 68280.31719682839, 68444.0, 68533.65733171352, 11045.325835131933, 11168.664940051649, 11173.0, 11175.329480231212, 11406.315621062762, 20686.58626827455, 20811.583768324548, 20825.68761468579, 20868.47828804292, 20872.0, 8112.675492980333, 8138.959305203554, 8247.21651443112, 8592.44149130317, 8667.609957551798, 4382.846600368972, 4567.588916997486, 4592.954070459253, 4641.2109941310055, 4729.55069268419, 3222.548843161959, 3318.1870441741926, 3324.1523411529906, 3324.384988777084, 3330.966690333114, 593.5815250248564, 594.1236675903095, 595.9761609535657, 610.6305685060563, 611.0223642172489, 584.2667452347362, 615.7110421479513, 677.6848765324148, 688.3357559954668, 689.9448044156455, 9077.77305567366, 9101.499417531966, 9385.343025988252, 9536.713898583053, 9612.567434465465, 582.6358525921299, 614.5452365249683, 639.9168108145911, 641.916550848396, 679.3104998426601, 4335.891602709894, 4431.224535706238, 4488.58686182263, 4496.280595104768, 4535.614472769786, 70242.64878675676, 90058.54970725236, 92092.0, 93203.53398232965, 93646.0, 47634.0, 48338.75830620895, 48952.26571601429, 59695.701521492985, 78720.0, 70142.0, 70282.0, 70776.64611676909, 70863.74817510863, 71349.0, 8500.829983400421, 8614.741557753277, 8709.695160669346, 8797.516136612549, 8919.73240802777, 49038.50961490339, 49641.255381170035, 50049.0, 50096.0, 50612.74693626508, 64092.0, 66207.0, 66483.66758166178, 66926.330736692, 67760.98358524725, 11421.771564568828, 11602.245854019462, 11825.231359961575, 11953.22304050234, 11992.340421276913, 12700.0, 12864.807027894401, 12896.871031289567, 12921.96624270075, 12948.417321220379, 11009.06422954058, 11045.282056666612, 11088.445577721242, 11134.0, 11143.442827858737, 11034.558617655204, 11101.777964440827, 11193.216474846682, 11238.494267757807, 11374.658760237206, 11824.586139485076, 11846.881531184577, 11859.525618975144, 12073.456694448947, 12493.812592810933, 9347.205487533636, 9383.483908384831, 9566.234701223746, 9566.234701224024, 9652.75868103275, 9074.863877041718, 9092.90907090947, 9216.308776841897, 9218.861717074384, 9268.860967085364], "value": 7021.700224166326, "unit": "score"}], "name": "dromaeo_css", "value": 7280.850147874014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 112.0, 110.0, 116.0, 111.0, 112.0, 112.0, 112.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 123.0, 156.0, 123.0, 123.0, 121.0, 122.0, 148.0, 128.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 158.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 109.0, 76.0, 75.0, 74.0, 76.0, 108.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 117.0, 83.0, 89.0, 81.0, 101.0, 81.0, 81.0, 115.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 146.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 52.0, 50.0, 50.0, 50.0, 52.0, 50.0, 50.0, 49.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 58.0, 60.0, 58.0, 59.0, 57.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 76.0, 75.0, 76.0, 76.0, 75.0, 75.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 126.0, 135.0, 129.0, 125.0, 128.0, 124.0, 165.0, 125.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 156.0, 158.0, 161.0, 160.0, 159.0, 158.0, 155.0, 162.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1463.4999999999998, "alertThreshold": 2.0}]} 02:59:21 INFO - Return code: 0 02:59:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:21 INFO - # TBPL SUCCESS # 02:59:21 INFO - Running post-action listener: _resource_record_post_action 02:59:21 INFO - [mozharness: 2016-12-03 10:59:21.717760Z] Finished run-tests step (success) 02:59:21 INFO - Running post-run listener: _resource_record_post_run 02:59:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 606208; Write bytes: 357584896; Read time: 184; Write time: 209852 02:59:21 INFO - TinderboxPrint: CPU usage
13.0% 02:59:21 INFO - TinderboxPrint: I/O read bytes / time
606,208 / 184 02:59:21 INFO - TinderboxPrint: I/O write bytes / time
357,584,896 / 209,852 02:59:21 INFO - TinderboxPrint: CPU idle
8,268.9 (87.0%) 02:59:21 INFO - TinderboxPrint: CPU user
1,191.3 (12.5%) 02:59:21 INFO - TinderboxPrint: Swap in / out
0 / 0 02:59:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107778048; Read time: 0; Write time: 86032 02:59:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 602112; Write bytes: 249057280; Read time: 156; Write time: 123760 02:59:22 INFO - Running post-run listener: _upload_blobber_files 02:59:22 INFO - Blob upload gear active. 02:59:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:22 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 02:59:22 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'] 02:59:22 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 02:59:22 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:23 INFO - (blobuploader) - INFO - Done attempting. 02:59:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:27 INFO - (blobuploader) - INFO - Done attempting. 02:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:28 INFO - (blobuploader) - INFO - Done attempting. 02:59:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:28 INFO - Return code: 0 02:59:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb61a30a478e3f690de472406b7a0aadc3ccc3c446e728f98c6825bb90b5c8802d9304cca0cc619742fb697f9f5553961f5fa30b212675f8a1769326db291902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/997386c5da639e47be95e3387127e8cc2f05e0eca9bb77ca02d6720bafe2a89136e80d69a85525c190727ee3872f41222f801c23ba17a256848ec7ffdbd59d6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41db4e35f045a6b0742f968645cd9c58c6cc572615bff6e7fc1379e4b343d4dc7d8000881bea6cd4af6502687b53908b824b990d3e243d7ad027d97e446a06f"} 02:59:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:28 INFO - Contents: 02:59:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb61a30a478e3f690de472406b7a0aadc3ccc3c446e728f98c6825bb90b5c8802d9304cca0cc619742fb697f9f5553961f5fa30b212675f8a1769326db291902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/997386c5da639e47be95e3387127e8cc2f05e0eca9bb77ca02d6720bafe2a89136e80d69a85525c190727ee3872f41222f801c23ba17a256848ec7ffdbd59d6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41db4e35f045a6b0742f968645cd9c58c6cc572615bff6e7fc1379e4b343d4dc7d8000881bea6cd4af6502687b53908b824b990d3e243d7ad027d97e446a06f"} 02:59:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:28 INFO - Copying logs to upload dir... 02:59:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.914337 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-03 02:59:27.830369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 02:59:27.833825) ========= 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=836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb61a30a478e3f690de472406b7a0aadc3ccc3c446e728f98c6825bb90b5c8802d9304cca0cc619742fb697f9f5553961f5fa30b212675f8a1769326db291902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/997386c5da639e47be95e3387127e8cc2f05e0eca9bb77ca02d6720bafe2a89136e80d69a85525c190727ee3872f41222f801c23ba17a256848ec7ffdbd59d6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41db4e35f045a6b0742f968645cd9c58c6cc572615bff6e7fc1379e4b343d4dc7d8000881bea6cd4af6502687b53908b824b990d3e243d7ad027d97e446a06f"} build_url:https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011948 build_url: 'https://queue.taskcluster.net/v1/task/UF1KvK7RTxK1vdGwN3DsLA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb61a30a478e3f690de472406b7a0aadc3ccc3c446e728f98c6825bb90b5c8802d9304cca0cc619742fb697f9f5553961f5fa30b212675f8a1769326db291902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/997386c5da639e47be95e3387127e8cc2f05e0eca9bb77ca02d6720bafe2a89136e80d69a85525c190727ee3872f41222f801c23ba17a256848ec7ffdbd59d6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41db4e35f045a6b0742f968645cd9c58c6cc572615bff6e7fc1379e4b343d4dc7d8000881bea6cd4af6502687b53908b824b990d3e243d7ad027d97e446a06f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 02:59:27.859958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:59:27.860394) ========= 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=836cfdc75598d54cb747368e000001a9-1480761418.768920-1171139401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 02:59:27.943703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 02:59:27.944035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 02:59:27.944392) ========= ========= Total master_lag: 0.18 =========