builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1479153273.07 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.067267) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.067738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.068037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.080145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.080476) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 11:54:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-11-14 11:54:33 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092549 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.186925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.187251) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.236754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.237150) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --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 f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --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=31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 11:54:33,799 truncating revision to first 12 chars 2016-11-14 11:54:33,799 Setting DEBUG logging. 2016-11-14 11:54:33,799 attempt 1/10 2016-11-14 11:54:33,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f11ca24b2382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:54:34,122 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.899325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.899665) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.900312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.900616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:54:33.909942) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 11:54:33.910350) ========= /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=31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:54:34 INFO - MultiFileLogger online at 20161114 11:54:34 in /builds/slave/test 11:54:34 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 11:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:34 INFO - {'append_to_log': False, 11:54:34 INFO - 'base_work_dir': '/builds/slave/test', 11:54:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:34 INFO - 'branch': 'Mozilla-Aurora', 11:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:34 INFO - 'config_files': ('talos/linux_config.py',), 11:54:34 INFO - 'default_actions': ('clobber', 11:54:34 INFO - 'read-buildbot-config', 11:54:34 INFO - 'download-and-extract', 11:54:34 INFO - 'populate-webroot', 11:54:34 INFO - 'create-virtualenv', 11:54:34 INFO - 'install', 11:54:34 INFO - 'run-tests'), 11:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:34 INFO - 'download_minidump_stackwalk': True, 11:54:34 INFO - 'download_symbols': 'ondemand', 11:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:34 INFO - 'installer_path': 'installer.exe', 11:54:34 INFO - 'log_level': 'info', 11:54:34 INFO - 'log_name': 'talos', 11:54:34 INFO - 'log_to_console': True, 11:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:54:34 INFO - 'opt_config_files': (), 11:54:34 INFO - 'pip_index': False, 11:54:34 INFO - 'sps_profile': False, 11:54:34 INFO - 'sps_profile_interval': 0, 11:54:34 INFO - 'suite': 'dromaeojs', 11:54:34 INFO - 'system_bits': '32', 11:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:34 INFO - 'title': 'talos-linux64-ix-014', 11:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:34 INFO - 'use_talos_json': True, 11:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:34 INFO - 'work_dir': 'build'} 11:54:34 INFO - [mozharness: 2016-11-14 19:54:34.572368Z] Running clobber step. 11:54:34 INFO - Running pre-action listener: _resource_record_pre_action 11:54:34 INFO - Running main action method: clobber 11:54:34 INFO - rmtree: /builds/slave/test/build 11:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:35 INFO - Running post-action listener: _resource_record_post_action 11:54:35 INFO - [mozharness: 2016-11-14 19:54:35.055531Z] Finished clobber step (success) 11:54:35 INFO - [mozharness: 2016-11-14 19:54:35.055633Z] Running read-buildbot-config step. 11:54:35 INFO - Running pre-action listener: _resource_record_pre_action 11:54:35 INFO - Running main action method: read_buildbot_config 11:54:35 INFO - Using buildbot properties: 11:54:35 INFO - { 11:54:35 INFO - "project": "", 11:54:35 INFO - "product": "firefox", 11:54:35 INFO - "script_repo_revision": "production", 11:54:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:54:35 INFO - "repository": "", 11:54:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:54:35 INFO - "buildid": "20161114081542", 11:54:35 INFO - "pgo_build": "True", 11:54:35 INFO - "basedir": "/builds/slave/test", 11:54:35 INFO - "buildnumber": 901, 11:54:35 INFO - "slavename": "talos-linux64-ix-014", 11:54:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:54:35 INFO - "platform": "ubuntu64_hw", 11:54:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:54:35 INFO - "branch": "mozilla-aurora", 11:54:35 INFO - "repo_path": "releases/mozilla-aurora", 11:54:35 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:54:35 INFO - "stage_platform": "linux64-pgo", 11:54:35 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:54:35 INFO - "slavebuilddir": "test" 11:54:35 INFO - } 11:54:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:54:35 INFO - Running post-action listener: _resource_record_post_action 11:54:35 INFO - [mozharness: 2016-11-14 19:54:35.058127Z] Finished read-buildbot-config step (success) 11:54:35 INFO - [mozharness: 2016-11-14 19:54:35.058216Z] Running download-and-extract step. 11:54:35 INFO - Running pre-action listener: _resource_record_pre_action 11:54:35 INFO - Running main action method: download_and_extract 11:54:35 INFO - mkdir: /builds/slave/test/build/tests 11:54:35 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')]} 11:54:35 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:54:35 INFO - Downloading https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/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 11:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/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 11:54:35 INFO - Downloaded 1361 bytes. 11:54:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:54:35 INFO - Using the following test package requirements: 11:54:35 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:54:35 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:54:35 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:54:35 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'jsshell-linux-x86_64.zip'], 11:54:35 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:54:35 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:54:35 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:54:35 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:54:35 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:54:35 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:54:35 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:54:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:54:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:54:35 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:54:36 INFO - Http code: 200 11:54:36 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 11:54:36 INFO - x-amz-cf-id: eyMqE2w0SkmC2jZIHGhxsjRYq95SFJnojA8mLl3Uw3fRiTeIIithKw== 11:54:36 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:54:36 INFO - Expected file size: 21998930 11:54:36 INFO - Obtained file size: 21998930 11:54:40 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 11:54:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:54:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:54:40 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:54:41 INFO - Http code: 200 11:54:41 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 11:54:41 INFO - x-amz-cf-id: Wk4LyRlRU3CDIddWDIlKhUXlHaBkb0wHhszg27kYxw0kK4A4OfI4Hg== 11:54:41 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:54:41 INFO - Expected file size: 21998930 11:54:41 INFO - Obtained file size: 21998930 11:54:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:54:45 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:54:46 INFO - Http code: 200 11:54:46 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 11:54:46 INFO - x-amz-cf-id: _zIpiPGBbyqyEpJwj2CEAg8Tl8Hj5hIkigtUjeE2WluxAVD5RjySkQ== 11:54:46 INFO - x-amz-version-id: TSlfhXB2os_hWn6_vAXqk2ibQDA0EcOh 11:54:46 INFO - Expected file size: 14409038 11:54:46 INFO - Obtained file size: 14409038 11:54: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')]} 11:54:46 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:54:46 INFO - Downloading https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/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 11:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/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 11:54:48 INFO - Downloaded 63942402 bytes. 11:54:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:54:48 INFO - mkdir: /builds/slave/test/properties 11:54:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:48 INFO - Contents: 11:54:48 INFO - build_url:https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:54:48 INFO - Running post-action listener: _resource_record_post_action 11:54:48 INFO - Running post-action listener: set_extra_try_arguments 11:54:48 INFO - [mozharness: 2016-11-14 19:54:48.706777Z] Finished download-and-extract step (success) 11:54:48 INFO - [mozharness: 2016-11-14 19:54:48.707001Z] Running populate-webroot step. 11:54:48 INFO - Running pre-action listener: _resource_record_pre_action 11:54:48 INFO - Running main action method: populate_webroot 11:54:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:48 INFO - '--tppagecycles', 11:54:48 INFO - '7'], 11:54:48 INFO - 'tests': ['tsvgm']}}, 11:54:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:54:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:54:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:54:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['damp', 'tps']}, 11:54:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'tests': ['damp', 'tps']}, 11:54:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['dromaeo_dom']}, 11:54:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['basic_compositor_video']}, 11:54:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:54:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tsvgx', 11:54:48 INFO - 'tsvgr_opacity', 11:54:48 INFO - 'tart', 11:54:48 INFO - 'tscrollx', 11:54:48 INFO - 'cart']}, 11:54:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:54:48 INFO - 'tsvgr_opacity', 11:54:48 INFO - 'tart', 11:54:48 INFO - 'tscrollx', 11:54:48 INFO - 'cart']}, 11:54:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tp5o']}, 11:54:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'tests': ['tp5o']}, 11:54:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s', 11:54:48 INFO - '--xperf_path', 11:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:48 INFO - 'tests': ['tp5n']}, 11:54:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--xperf_path', 11:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:48 INFO - 'tests': ['tp5n']}}, 11:54:48 INFO - 'talos.zip': {'path': '', 11:54:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:48 INFO - Running post-action listener: _resource_record_post_action 11:54:48 INFO - [mozharness: 2016-11-14 19:54:48.726731Z] Finished populate-webroot step (success) 11:54:48 INFO - [mozharness: 2016-11-14 19:54:48.726819Z] Running create-virtualenv step. 11:54:48 INFO - Running pre-action listener: _resource_record_pre_action 11:54:48 INFO - Running main action method: create_virtualenv 11:54:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:48 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 11:54:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:48 INFO - Using real prefix '/usr' 11:54:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:51 INFO - Installing pip.................done. 11:54:51 INFO - Return code: 0 11:54:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:54:51 INFO - Reading from file tmpfile_stdout 11:54:51 INFO - Output received: 11:54:51 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) 11:54:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:54:51 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 11:54:51 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 11:54:51 INFO - Using env: {'DISPLAY': ':0', 11:54:51 INFO - 'HOME': '/home/cltbld', 11:54:51 INFO - 'LANG': 'en_US.UTF-8', 11:54:51 INFO - 'LANGUAGE': 'en_US:en', 11:54:51 INFO - 'LOGNAME': 'cltbld', 11:54:51 INFO - 'MAIL': '/var/mail/cltbld', 11:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:51 INFO - 'MOZ_NO_REMOTE': '1', 11:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:51 INFO - 'NO_EM_RESTART': '1', 11:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:51 INFO - 'PWD': '/builds/slave/test', 11:54:51 INFO - 'SHELL': '/bin/bash', 11:54:51 INFO - 'SHLVL': '1', 11:54:51 INFO - 'TERM': 'linux', 11:54:51 INFO - 'TMOUT': '86400', 11:54:51 INFO - 'USER': 'cltbld', 11:54:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:51 INFO - '_': '/tools/buildbot/bin/python'} 11:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:51 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 11:54:51 INFO - Cleaning up... 11:54:51 INFO - Return code: 0 11:54:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:51 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:54:51 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 11:54:51 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 11:54:51 INFO - Using env: {'DISPLAY': ':0', 11:54:51 INFO - 'HOME': '/home/cltbld', 11:54:51 INFO - 'LANG': 'en_US.UTF-8', 11:54:51 INFO - 'LANGUAGE': 'en_US:en', 11:54:51 INFO - 'LOGNAME': 'cltbld', 11:54:51 INFO - 'MAIL': '/var/mail/cltbld', 11:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:51 INFO - 'MOZ_NO_REMOTE': '1', 11:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:51 INFO - 'NO_EM_RESTART': '1', 11:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:51 INFO - 'PWD': '/builds/slave/test', 11:54:51 INFO - 'SHELL': '/bin/bash', 11:54:51 INFO - 'SHLVL': '1', 11:54:51 INFO - 'TERM': 'linux', 11:54:51 INFO - 'TMOUT': '86400', 11:54:51 INFO - 'USER': 'cltbld', 11:54:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:51 INFO - '_': '/tools/buildbot/bin/python'} 11:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:51 INFO - Downloading/unpacking psutil>=3.1.1 11:54:51 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 11:54:51 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 11:54:51 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 11:54:51 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 11:54:51 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 11:54:51 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 11:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:54 INFO - Installing collected packages: psutil 11:54:54 INFO - Running setup.py install for psutil 11:54:54 INFO - building 'psutil._psutil_linux' extension 11:54:54 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 11:54:54 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 11:54:54 INFO - building 'psutil._psutil_posix' extension 11:54:54 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 11:54:54 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 11:54:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:54 INFO - Successfully installed psutil 11:54:54 INFO - Cleaning up... 11:54:54 INFO - Return code: 0 11:54:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:54 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:54:54 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 11:54:54 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 11:54:54 INFO - Using env: {'DISPLAY': ':0', 11:54:54 INFO - 'HOME': '/home/cltbld', 11:54:54 INFO - 'LANG': 'en_US.UTF-8', 11:54:54 INFO - 'LANGUAGE': 'en_US:en', 11:54:54 INFO - 'LOGNAME': 'cltbld', 11:54:54 INFO - 'MAIL': '/var/mail/cltbld', 11:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:54 INFO - 'MOZ_NO_REMOTE': '1', 11:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:54 INFO - 'NO_EM_RESTART': '1', 11:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:54 INFO - 'PWD': '/builds/slave/test', 11:54:54 INFO - 'SHELL': '/bin/bash', 11:54:54 INFO - 'SHLVL': '1', 11:54:54 INFO - 'TERM': 'linux', 11:54:54 INFO - 'TMOUT': '86400', 11:54:54 INFO - 'USER': 'cltbld', 11:54:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:54 INFO - '_': '/tools/buildbot/bin/python'} 11:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 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 11:54:54 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 11:54:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:54:56 INFO - Installing collected packages: mozsystemmonitor 11:54:56 INFO - Running setup.py install for mozsystemmonitor 11:54:56 INFO - Successfully installed mozsystemmonitor 11:54:56 INFO - Cleaning up... 11:54:56 INFO - Return code: 0 11:54:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:54:56 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')]} 11:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:56 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')]} 11:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:56 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:54:56 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 11:54:56 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 11:54:56 INFO - Using env: {'DISPLAY': ':0', 11:54:56 INFO - 'HOME': '/home/cltbld', 11:54:56 INFO - 'LANG': 'en_US.UTF-8', 11:54:56 INFO - 'LANGUAGE': 'en_US:en', 11:54:56 INFO - 'LOGNAME': 'cltbld', 11:54:56 INFO - 'MAIL': '/var/mail/cltbld', 11:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:56 INFO - 'MOZ_NO_REMOTE': '1', 11:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:56 INFO - 'NO_EM_RESTART': '1', 11:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:56 INFO - 'PWD': '/builds/slave/test', 11:54:56 INFO - 'SHELL': '/bin/bash', 11:54:56 INFO - 'SHLVL': '1', 11:54:56 INFO - 'TERM': 'linux', 11:54:56 INFO - 'TMOUT': '86400', 11:54:56 INFO - 'USER': 'cltbld', 11:54:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:56 INFO - '_': '/tools/buildbot/bin/python'} 11:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:54:57 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 11:54:57 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 11:54:57 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 11:54:57 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 11:54:57 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 11:54:57 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 11:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:54:59 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 11:54:59 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 11:54:59 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 11:54:59 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 11:54:59 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 11:54:59 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 11:54:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:59 INFO - warning: no files found matching '*.txt' 11:54:59 INFO - no previously-included directories found matching 'build' 11:54:59 INFO - no previously-included directories found matching 'dist' 11:54:59 INFO - no previously-included directories found matching '.git*' 11:54:59 INFO - Installing collected packages: jsonschema, functools32 11:54:59 INFO - Running setup.py install for functools32 11:54:59 INFO - warning: no files found matching '*.txt' 11:54:59 INFO - no previously-included directories found matching 'build' 11:54:59 INFO - no previously-included directories found matching 'dist' 11:54:59 INFO - no previously-included directories found matching '.git*' 11:54:59 INFO - Successfully installed jsonschema functools32 11:54:59 INFO - Cleaning up... 11:54:59 INFO - Return code: 0 11:54:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:54:59 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')]} 11:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:59 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')]} 11:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:59 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:54:59 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 11:54:59 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 11:54:59 INFO - Using env: {'DISPLAY': ':0', 11:54:59 INFO - 'HOME': '/home/cltbld', 11:54:59 INFO - 'LANG': 'en_US.UTF-8', 11:54:59 INFO - 'LANGUAGE': 'en_US:en', 11:54:59 INFO - 'LOGNAME': 'cltbld', 11:54:59 INFO - 'MAIL': '/var/mail/cltbld', 11:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:59 INFO - 'MOZ_NO_REMOTE': '1', 11:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:59 INFO - 'NO_EM_RESTART': '1', 11:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:59 INFO - 'PWD': '/builds/slave/test', 11:54:59 INFO - 'SHELL': '/bin/bash', 11:54:59 INFO - 'SHLVL': '1', 11:54:59 INFO - 'TERM': 'linux', 11:54:59 INFO - 'TMOUT': '86400', 11:54:59 INFO - 'USER': 'cltbld', 11:54:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:59 INFO - '_': '/tools/buildbot/bin/python'} 11:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:54:59 INFO - Cleaning up... 11:54:59 INFO - Return code: 0 11:54:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54:59 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')]} 11:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:59 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')]} 11:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:59 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:54:59 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 11:54:59 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 11:54:59 INFO - Using env: {'DISPLAY': ':0', 11:54:59 INFO - 'HOME': '/home/cltbld', 11:54:59 INFO - 'LANG': 'en_US.UTF-8', 11:54:59 INFO - 'LANGUAGE': 'en_US:en', 11:54:59 INFO - 'LOGNAME': 'cltbld', 11:54:59 INFO - 'MAIL': '/var/mail/cltbld', 11:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:59 INFO - 'MOZ_NO_REMOTE': '1', 11:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:59 INFO - 'NO_EM_RESTART': '1', 11:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:59 INFO - 'PWD': '/builds/slave/test', 11:54:59 INFO - 'SHELL': '/bin/bash', 11:54:59 INFO - 'SHLVL': '1', 11:54:59 INFO - 'TERM': 'linux', 11:54:59 INFO - 'TMOUT': '86400', 11:54:59 INFO - 'USER': 'cltbld', 11:54:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:59 INFO - '_': '/tools/buildbot/bin/python'} 11:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:00 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 11:55:00 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 11:55:00 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 11:55:00 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 11:55:00 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 11:55:00 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 11:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 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 11:55:02 INFO - Downloading docopt-0.6.1.tar.gz 11:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:02 INFO - Running setup.py install for blobuploader 11:55:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:02 INFO - Running setup.py install for requests 11:55:03 INFO - Running setup.py install for docopt 11:55:03 INFO - Successfully installed blobuploader requests docopt 11:55:03 INFO - Cleaning up... 11:55:03 INFO - Return code: 0 11:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:03 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')]} 11:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:03 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')]} 11:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:03 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:55:03 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 11:55:03 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 11:55:03 INFO - Using env: {'DISPLAY': ':0', 11:55:03 INFO - 'HOME': '/home/cltbld', 11:55:03 INFO - 'LANG': 'en_US.UTF-8', 11:55:03 INFO - 'LANGUAGE': 'en_US:en', 11:55:03 INFO - 'LOGNAME': 'cltbld', 11:55:03 INFO - 'MAIL': '/var/mail/cltbld', 11:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:03 INFO - 'MOZ_NO_REMOTE': '1', 11:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:03 INFO - 'NO_EM_RESTART': '1', 11:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:03 INFO - 'PWD': '/builds/slave/test', 11:55:03 INFO - 'SHELL': '/bin/bash', 11:55:03 INFO - 'SHLVL': '1', 11:55:03 INFO - 'TERM': 'linux', 11:55:03 INFO - 'TMOUT': '86400', 11:55:03 INFO - 'USER': 'cltbld', 11:55:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:03 INFO - '_': '/tools/buildbot/bin/python'} 11:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:03 INFO - Running setup.py (path:/tmp/pip-DIEH4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:03 INFO - Running setup.py (path:/tmp/pip-VdEmRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:03 INFO - Running setup.py (path:/tmp/pip-1qluvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:03 INFO - Running setup.py (path:/tmp/pip-5WQFDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:03 INFO - Running setup.py (path:/tmp/pip-mReWYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:03 INFO - Running setup.py (path:/tmp/pip-SiPLKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:04 INFO - Running setup.py (path:/tmp/pip-bDK5H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:04 INFO - Running setup.py (path:/tmp/pip-2uwfj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:04 INFO - Running setup.py (path:/tmp/pip-nrHQQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:04 INFO - Running setup.py (path:/tmp/pip-ma_Z5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:04 INFO - Running setup.py (path:/tmp/pip-27ZEoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:04 INFO - Running setup.py (path:/tmp/pip-FVtlzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:04 INFO - Running setup.py (path:/tmp/pip-3wAwxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:04 INFO - Running setup.py (path:/tmp/pip-Jb1Z4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:04 INFO - Running setup.py (path:/tmp/pip-gJ1OPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:04 INFO - Running setup.py (path:/tmp/pip-OxL99j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:04 INFO - Running setup.py (path:/tmp/pip-GDSp4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:04 INFO - Running setup.py install for manifestparser 11:55:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:04 INFO - Running setup.py install for mozcrash 11:55:05 INFO - Running setup.py install for mozdebug 11:55:05 INFO - Running setup.py install for mozdevice 11:55:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Running setup.py install for mozfile 11:55:05 INFO - Running setup.py install for mozhttpd 11:55:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Running setup.py install for mozinfo 11:55:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Running setup.py install for mozInstall 11:55:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Running setup.py install for mozleak 11:55:05 INFO - Running setup.py install for mozlog 11:55:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Running setup.py install for moznetwork 11:55:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:05 INFO - Running setup.py install for mozprocess 11:55:06 INFO - Running setup.py install for mozprofile 11:55:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:06 INFO - Running setup.py install for mozrunner 11:55:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:06 INFO - Running setup.py install for mozscreenshot 11:55:06 INFO - Running setup.py install for moztest 11:55:06 INFO - Running setup.py install for mozversion 11:55:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:06 INFO - Cleaning up... 11:55:06 INFO - Return code: 0 11:55:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:06 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:55:06 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 11:55:06 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 11:55:06 INFO - Using env: {'DISPLAY': ':0', 11:55:06 INFO - 'HOME': '/home/cltbld', 11:55:06 INFO - 'LANG': 'en_US.UTF-8', 11:55:06 INFO - 'LANGUAGE': 'en_US:en', 11:55:06 INFO - 'LOGNAME': 'cltbld', 11:55:06 INFO - 'MAIL': '/var/mail/cltbld', 11:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:06 INFO - 'MOZ_NO_REMOTE': '1', 11:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:06 INFO - 'NO_EM_RESTART': '1', 11:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:06 INFO - 'PWD': '/builds/slave/test', 11:55:06 INFO - 'SHELL': '/bin/bash', 11:55:06 INFO - 'SHLVL': '1', 11:55:06 INFO - 'TERM': 'linux', 11:55:06 INFO - 'TMOUT': '86400', 11:55:06 INFO - 'USER': 'cltbld', 11:55:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:06 INFO - '_': '/tools/buildbot/bin/python'} 11:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:06 INFO - Running setup.py (path:/tmp/pip-ddsFjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:06 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)) 11:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:06 INFO - Running setup.py (path:/tmp/pip-bD9CyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:07 INFO - Running setup.py (path:/tmp/pip-jA7lB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:07 INFO - Running setup.py (path:/tmp/pip-y5JFgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:07 INFO - Running setup.py (path:/tmp/pip-U95tuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:07 INFO - Running setup.py (path:/tmp/pip-dAPN7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:07 INFO - Running setup.py (path:/tmp/pip-QOrELV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:07 INFO - Running setup.py (path:/tmp/pip-OJ5ThQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:07 INFO - Running setup.py (path:/tmp/pip-1Dm4at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:07 INFO - Running setup.py (path:/tmp/pip-YS4FFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:07 INFO - Running setup.py (path:/tmp/pip-NkI1mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:07 INFO - Running setup.py (path:/tmp/pip-q6G1Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:07 INFO - Running setup.py (path:/tmp/pip-Vkhitn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:07 INFO - Running setup.py (path:/tmp/pip-F0N4en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:07 INFO - Running setup.py (path:/tmp/pip-SEVEak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:07 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)) 11:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:07 INFO - Running setup.py (path:/tmp/pip-meLc0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:08 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)) 11:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:08 INFO - Running setup.py (path:/tmp/pip-0aDu3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:08 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)) 11:55:08 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)) 11:55:08 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)) 11:55:08 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)) 11:55:08 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)) 11:55:08 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)) 11:55:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:10 INFO - Downloading blessings-1.6.tar.gz 11:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:10 INFO - Installing collected packages: blessings 11:55:10 INFO - Running setup.py install for blessings 11:55:10 INFO - Successfully installed blessings 11:55:10 INFO - Cleaning up... 11:55:10 INFO - Return code: 0 11:55:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:10 INFO - Reading from file tmpfile_stdout 11:55:10 INFO - Current package versions: 11:55:10 INFO - argparse == 1.2.1 11:55:10 INFO - blessings == 1.6 11:55:10 INFO - blobuploader == 1.2.4 11:55:10 INFO - docopt == 0.6.1 11:55:10 INFO - functools32 == 3.2.3-2 11:55:10 INFO - jsonschema == 2.5.1 11:55:10 INFO - manifestparser == 1.1 11:55:10 INFO - mozInstall == 1.12 11:55:10 INFO - mozcrash == 1.0 11:55:10 INFO - mozdebug == 0.1 11:55:10 INFO - mozdevice == 0.48 11:55:10 INFO - mozfile == 1.2 11:55:10 INFO - mozhttpd == 0.7 11:55:10 INFO - mozinfo == 0.9 11:55:10 INFO - mozleak == 0.1 11:55:10 INFO - mozlog == 3.4 11:55:10 INFO - moznetwork == 0.27 11:55:10 INFO - mozprocess == 0.23 11:55:10 INFO - mozprofile == 0.28 11:55:10 INFO - mozrunner == 6.13 11:55:10 INFO - mozscreenshot == 0.1 11:55:10 INFO - mozsystemmonitor == 0.3 11:55:10 INFO - moztest == 0.7 11:55:10 INFO - mozversion == 1.4 11:55:10 INFO - psutil == 3.1.1 11:55:10 INFO - requests == 1.2.3 11:55:10 INFO - wsgiref == 0.1.2 11:55:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:10 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 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:55:10 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 11:55:10 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 11:55:10 INFO - Using env: {'DISPLAY': ':0', 11:55:10 INFO - 'HOME': '/home/cltbld', 11:55:10 INFO - 'LANG': 'en_US.UTF-8', 11:55:10 INFO - 'LANGUAGE': 'en_US:en', 11:55:10 INFO - 'LOGNAME': 'cltbld', 11:55:10 INFO - 'MAIL': '/var/mail/cltbld', 11:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:10 INFO - 'MOZ_NO_REMOTE': '1', 11:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:10 INFO - 'NO_EM_RESTART': '1', 11:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:10 INFO - 'PWD': '/builds/slave/test', 11:55:10 INFO - 'SHELL': '/bin/bash', 11:55:10 INFO - 'SHLVL': '1', 11:55:10 INFO - 'TERM': 'linux', 11:55:10 INFO - 'TMOUT': '86400', 11:55:10 INFO - 'USER': 'cltbld', 11:55:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:10 INFO - '_': '/tools/buildbot/bin/python'} 11:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 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)) 11:55:10 INFO - Cleaning up... 11:55:10 INFO - Return code: 0 11:55:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff734d20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', '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 11:55: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', 'jsonschema'] in /builds/slave/test/build 11:55: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 jsonschema 11:55:10 INFO - Using env: {'DISPLAY': ':0', 11:55:10 INFO - 'HOME': '/home/cltbld', 11:55:10 INFO - 'LANG': 'en_US.UTF-8', 11:55:10 INFO - 'LANGUAGE': 'en_US:en', 11:55:10 INFO - 'LOGNAME': 'cltbld', 11:55:10 INFO - 'MAIL': '/var/mail/cltbld', 11:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:10 INFO - 'MOZ_NO_REMOTE': '1', 11:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:10 INFO - 'NO_EM_RESTART': '1', 11:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:10 INFO - 'PWD': '/builds/slave/test', 11:55:10 INFO - 'SHELL': '/bin/bash', 11:55:10 INFO - 'SHLVL': '1', 11:55:10 INFO - 'TERM': 'linux', 11:55:10 INFO - 'TMOUT': '86400', 11:55:10 INFO - 'USER': 'cltbld', 11:55:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:10 INFO - '_': '/tools/buildbot/bin/python'} 11:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:10 INFO - Cleaning up... 11:55:11 INFO - Return code: 0 11:55:11 INFO - Running post-action listener: _resource_record_post_action 11:55:11 INFO - Running post-action listener: _start_resource_monitoring 11:55:11 INFO - Starting resource monitoring. 11:55:11 INFO - [mozharness: 2016-11-14 19:55:11.041048Z] Finished create-virtualenv step (success) 11:55:11 INFO - [mozharness: 2016-11-14 19:55:11.041722Z] Running install step. 11:55:11 INFO - Running pre-action listener: _resource_record_pre_action 11:55:11 INFO - Running main action method: install 11:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:11 INFO - Reading from file tmpfile_stdout 11:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:11 INFO - Reading from file tmpfile_stdout 11:55:11 INFO - Output received: 11:55:11 INFO - Usage: mozinstall [options] installer 11:55:11 INFO - Options: 11:55:11 INFO - -h, --help show this help message and exit 11:55:11 INFO - -d DEST, --destination=DEST 11:55:11 INFO - Directory to install application into. [default: 11:55:11 INFO - "/builds/slave/test"] 11:55:11 INFO - --app=APP Application being installed. [default: firefox] 11:55:11 INFO - mkdir: /builds/slave/test/build/application 11:55:11 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'] 11:55:11 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 11:55:27 INFO - Reading from file tmpfile_stdout 11:55:27 INFO - Output received: 11:55:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:55:27 INFO - Running post-action listener: _resource_record_post_action 11:55:27 INFO - [mozharness: 2016-11-14 19:55:27.257017Z] Finished install step (success) 11:55:27 INFO - [mozharness: 2016-11-14 19:55:27.257387Z] Running run-tests step. 11:55:27 INFO - Running pre-action listener: _resource_record_pre_action 11:55:27 INFO - Running main action method: run_tests 11:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:27 INFO - Python 2.7.3 11:55:27 INFO - Return code: 0 11:55:27 INFO - grabbing minidump binary from tooltool 11:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:27 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 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:27 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 11:55:27 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 11:55:27 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 11:55:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:27 INFO - Return code: 0 11:55:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:55:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:55:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:27 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/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:55:27 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/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 11:55:27 INFO - Using env: {'DISPLAY': ':0', 11:55:27 INFO - 'HOME': '/home/cltbld', 11:55:27 INFO - 'LANG': 'en_US.UTF-8', 11:55:27 INFO - 'LANGUAGE': 'en_US:en', 11:55:27 INFO - 'LOGNAME': 'cltbld', 11:55:27 INFO - 'MAIL': '/var/mail/cltbld', 11:55:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:27 INFO - 'MOZ_NO_REMOTE': '1', 11:55:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:27 INFO - 'NO_EM_RESTART': '1', 11:55:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:27 INFO - 'PWD': '/builds/slave/test', 11:55:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:27 INFO - 'SHELL': '/bin/bash', 11:55:27 INFO - 'SHLVL': '1', 11:55:27 INFO - 'TERM': 'linux', 11:55:27 INFO - 'TMOUT': '86400', 11:55:27 INFO - 'USER': 'cltbld', 11:55:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482', 11:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:27 INFO - '_': '/tools/buildbot/bin/python'} 11:55:27 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/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:55:27 INFO - mozversion application_buildid: 20161114081542 11:55:27 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:55:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:55:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:27 INFO - mozversion application_name: Firefox 11:55:27 INFO - mozversion application_remotingname: firefox-dev 11:55:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:55:27 INFO - mozversion application_vendor: Mozilla 11:55:27 INFO - mozversion application_version: 52.0a2 11:55:27 INFO - mozversion platform_buildid: 20161114081542 11:55:27 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:55:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:55:27 INFO - mozversion platform_version: 52.0a2 11:55:27 INFO - using testdate: 1479153327 11:55:27 INFO - actual date: 1479153327 11:55:27 INFO - starting webserver on 'localhost:33393' 11:55:27 INFO - SUITE-START | Running 2 tests 11:55:27 INFO - TEST-START | dromaeo_css 11:55:27 INFO - operating with platform_type : linux_ 11:55:27 INFO - Initialising browser for dromaeo_css test... 11:55:27 INFO - TEST-INFO | started process 17317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxWRMGa/profile http://localhost:33393/getInfo.html) 11:55:30 ERROR - PROCESS | 17317 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:55:31 INFO - PROCESS | 17317 | __metrics Screen width/height:1600/1200 11:55:31 INFO - PROCESS | 17317 | colorDepth:24 11:55:31 INFO - PROCESS | 17317 | Browser inner width/height: 1024/697 11:55:31 INFO - PROCESS | 17317 | __metrics 11:55:31 INFO - PROCESS | 17317 | 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" 11:55:31 INFO - PROCESS | 17317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:32 INFO - PROCESS | 17317 | console.error: PushService: 11:55:32 INFO - PROCESS | 17317 | stateChangeProcessEnqueue: Error transitioning state 11:55:32 INFO - PROCESS | 17317 | UnknownError 11:55:32 INFO - TEST-INFO | 17317: exit 0 11:55:32 INFO - Browser initialized. 11:55:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:55:32 INFO - TEST-INFO | started process 17412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxWRMGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:44 INFO - PROCESS | 17412 | RSS: Main: 144621568 11:55:44 INFO - PROCESS | 17412 | 11:56:36 INFO - PROCESS | 17412 | 1479153396223 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] 11:58:46 INFO - PROCESS | 17412 | Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33393/tests/dromaeo/cssquery-ext.html) 11:58:47 INFO - PROCESS | 17412 | RSS: Main: 242384896 11:58:47 INFO - PROCESS | 17412 | 12:01:49 INFO - PROCESS | 17412 | Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-ext.html (next: http://localhost:33393/tests/dromaeo/cssquery-jquery.html) 12:01:50 INFO - PROCESS | 17412 | RSS: Main: 231956480 12:01:50 INFO - PROCESS | 17412 | 12:04:52 INFO - PROCESS | 17412 | Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33393/tests/dromaeo/cssquery-mootools.html) 12:04:53 INFO - PROCESS | 17412 | RSS: Main: 228720640 12:04:53 INFO - PROCESS | 17412 | 12:07:55 INFO - PROCESS | 17412 | Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33393/tests/dromaeo/cssquery-prototype.html) 12:07:55 INFO - PROCESS | 17412 | RSS: Main: 222261248 12:07:55 INFO - PROCESS | 17412 | 12:10:58 INFO - PROCESS | 17412 | Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33393/tests/dromaeo/cssquery-yui.html) 12:10:59 INFO - PROCESS | 17412 | RSS: Main: 175534080 12:10:59 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | Cycle 1(1): loaded http://localhost:33393/tests/dromaeo/cssquery-yui.html (next: http://localhost:33393/tests/dromaeo/cssquery-dojo.html) 12:14:01 INFO - PROCESS | 17412 | RSS: Main: 262705152 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | __start_tp_report 12:14:01 INFO - PROCESS | 17412 | _x_x_mozilla_page_load 12:14:01 INFO - PROCESS | 17412 | _x_x_mozilla_page_load_details 12:14:01 INFO - PROCESS | 17412 | |i|pagename|runs| 12:14:01 INFO - PROCESS | 17412 | |0;dojo.html;3121.3133110715644;3168.730657894079;3180.4593219152734;3185.729213016895;3197.8720851165954;5332.33345831771;5364.812231571896;5419;5433.076377015902;5440.3743569489525;5625.043742563764;5640.153976903466;5652.717364131798;5659.264295641571;5665.263515742948;5076.44159142494;5090.847274581759;5159.922601160967;5173.43092259853;5174.249733788598;4900.779464924087;4919.065377578267;5144.048351055067;5177.585793136559;5193.350831146106;4940.357753492041;4987.276844857493;4993.201087825949;5000.524950129732;5102.540771330579;5071.644984851062;5105.463926287724;5161.406438259611;5166.870828229286;5189.818356357509;4830.227163653799;5069.986002799455;5082.771275292584;5128.307678463397;5138.537531622172;5405.891882162374;5423.945760542383;5453.100238460649;5465.480779325958;5512.972435137839;5884.52923766102;5885.970570147165;5977.970110149421;5995.700214989233;5998.490128339096;5908.852278693024;6021.51827853775;6028.6985650717725;6043.033114701627;6046.516278697693;5493.587980901409;5506.807261745819;5530.944690553123;5562.443755624486;5568.1091025435735;6086.847828804315;6094.664793436404;6104.4505994460715;6104.664243466563;6109.20580324555;5614.9157762633595;5815.244018277597;5830.62100963436;5837.416258374214;5842.328132264759;5709.714514274269;5859.5019423349495;5917.082852157922;5917.970410147922;6011.098335249748;5937.753071854872;5945.732442040032;5952.791652292236;5953.970230148821;6001.609895356875;5913.201717768046;5914.645121292736;5949.2266005419015;5971.731272092767;5974.462298393166;4497.415336006364;4540.069285796404;4556.726596404226;4597.908041839211;4604.424446944132;4088.8773336799945;4105.384192371109;4115.650169735546;4128.2156390285745;4142.79286035697;5709.800156994568;5713.314402271754;5714.371419143891;5719.195875464629;5721.77112915487;5662.773489060474;5709.600327977002;5814.244148260699;5856.443637854482;6063.514918806485;5596.748146333425;5605.579581531401;5612.35457922336;5617.831465056055;5635;5069.746512674352;5094.159463688524;5113.028524580318;5114.795408183631;5143.691378517301;6051.606645568112;6106.755729770848;6118.571699980958;6137.7447333336595;6139.57023008394;5658.971705141448;5754.8849023018465;5758.366579676316;5791.362950075404;5848.707564621837;6000.489958353589;6002.0996850472775;6009.308929472992;6011.879762404815;6020.759169633166;5693;5697.3448053474385;5699.2590963174525;5701.030824759884;5713.714314284352;5803.158542011469;5832.795852145155;5909.497692696169;5924.585279030426;5996.970015149896;5769.086910336826;5800.912986305293;5806.44838740319;5808.912866307093;5825.854353641193;5802.564807639528;5813.970930145491;5814.360420353673;5823.4467725566;5823.970880145572;5634.32388113429;5649.774009039593;5664.603477756517;5668.914966275592;5707.172459993195;5859.414058594107;5862.179294898803;5862.267216597926;5865.970670146793;5880.794172203952;5614.07367784311;5661.348944871228;5711.771529138788;5718.571107167062;5721.313442386941 12:14:01 INFO - PROCESS | 17412 | |1;ext.html;570.8059259851652;604.9879002419951;615.8337248942786;626.6647343671137;628.0735914526077;29503.704962950364;36612.63387366125;37437.81281093594;37468.81265593675;37507.812460937654;38089.42865857014;38176;38258.087095645176;38302.425463618;38559.42160867589;8416.326693864492;8550.828983420328;8555.614997325105;8555.95722021389;8558.358123140759;8432.072472028072;8511.702090426836;8515.701950431736;8516.8722469163;8518.318534517255;8496.872546911802;8550.059493455716;8555.315574754035;8555.914440855606;8557.315414766836;8526.616302266382;8562.74311770648;8563.529005904673;8564.229219370225;8571.871421928676;8414.705485307984;8470.068292487822;8475.915240847575;8481.236688698047;8487.40588158829;36189.095272618135;36438.089047773756;36457;36544;36564.0858978525;3245.4807230842953;3261.836908154583;3331.766776325658;3569.4824250483794;3737.4580685800406;28282;28760;28915.56626650602;28917.277068073257;29665.555016674767;4383.145286669101;4441.578050085237;4464.330350447426;4503.594676479132;4520.773961301922;337176;338121;340625;340675.9999999975;341251;31310.530342044887;48014.51985480171;48264;48271.5172848274;48324;37879.431808522895;40248.1950360997;40333.39499907504;40337.39493907594;40389.79805100956;15371.15458649785;15613.531594052196;15617.843821561866;15620.921895390451;15646.2176891155;12468.501259949682;12598;12604;12607.495700172074;12614.180078294881;8683.869741953877;8688.174623410765;8713.390062695551;8767.167119123673;8768.605412756313;3275.082976766509;3288.8191149487006;3304.15743985287;3307.140143562691;3318.352921180395;993.9155171810332;1033.4471057983942;1038.4548112241134;1045.3780000899453;1105.077260487502;31668.208294792814;32499.675003249664;32566;32589.18527036843;33344.49983250253;950.9904900951041;977.1449981266392;981.40134517944;993.3543196922059;1043.113353649392;15561.221938903009;15775.211239437982;15927.840721592867;16071.276792544364;16074.598135046483;540480;546242;546850;547720;548543;56652.433475664715;57133.85732285331;57308;57316.42683573111;57416.71291643515;1119.1662211652372;1157.398152960456;1160.5415860735131;1211.4911737070452;1217.0446199733344;28987.275318117216;31947.520787187746;32038.83980580082;32657.346853062332;32807;49009.2648610264;49800.50199497959;49825.50174498209;50114.74942625409;50210.497895020584;379963;381369;381794;383024;383497;24815.503689926463;26167.86916065484;26357.736422636295;27442.862785685942;27495.862520687268;42997;44272.33591496194;46720.29919551277;46821.765891170326;47171.764141179076;33869.15327116842;34281;34350.31299374049;34350.48474272938;34509.13727156841;34231;34272.65727342795;34370.48444273288;34378.14054648654;34439.139021524665;34212.48681269733;34447.311053778285;34961.12597185091;35031.47452788159;35105.47341789824;31286;33635.85534854874;33812.323753525285;33928.491072634424;34407.827960860035;25325.0672079885;25344.239672809847;25540.10609628654;25577.232683019538;25624.359391015372 12:14:01 INFO - PROCESS | 17412 | |2;jquery.html;405.9553449120597;415.68615695150174;419.74815110933423;432.5371852118234;445.18308903162693;16065;17216.65566688667;17912.104394780275;18865.245390184395;18873.245070197194;16282.83717162828;16700.248488818;16816.32734690614;16906.323747050134;17170.39903603374;5184.377874655047;5191.351081114851;5317.813876514323;5353.785848566053;5363.195520671911;5332.093544097513;5417.404085550606;5423.755930983115;5423.972880135613;5424.321959755031;5238.423773384944;5260.763265653055;5326.547243484309;5418.106012507931;5429.375621803503;5237.554807841338;5272.868178295535;5276.366835979668;5277.498637629457;5277.604179686519;4963.90072198554;5155.536001759822;5156.407013193493;5209.166533354645;5276.81531146408;13594.864051359558;13936.372863221179;13980.370883310276;15645.765313520305;21470.785292147033;2252.358077947777;2407.9759202407927;2523.8107141964424;2531.341851118704;2771.2240572639694;9824.90175098254;10388.065074143364;10406.895931040668;10715.410652414113;10761.946190268998;2008.4978755311172;2026.3211824038965;2032.2582257475915;2049.825764809993;2058.166442590753;57853.089439751035;79891.60054199692;84238;89299.55350223207;91171.54414227953;11016.567846179945;11044.723881902855;11085.778284434266;11138.164637652208;11608.419579021016;14583.270836458134;16189.919050404673;16198.919005404898;16208.10855402964;16210.270537825827;7475.327220550176;7741.380689544823;8061.072976607648;8072.596370181467;8086.312663423675;7256.528325658815;7365.189829118793;7776.300132988058;7964.8805267921025;8070.83858322842;4623.375844261049;4734.431868175772;4829.7469851029;4891.192953162759;4893.853184404474;1834.321301118568;1948.0551932312817;1951.853610979154;1953.4920920560758;1980.5345743750206;728.2608152724988;827.5613924619961;849.762066621347;898.0929261445856;1005.9698209053594;17063.744043839353;18193.272269109086;18324.54188645268;18353.357632483065;18625.348112815987;883.6951251818112;901.7745563609097;918.169057003413;920.0385597051097;949.9620015199453;9658.806823863624;9944.850827237597;9999.150072243796;10071.748206294755;10163.695089147337;459490;463173;463305;463573;469355;92719;94382;95515;96691.51654241684;97366.5131674337;894.3471265975874;908.6456282050138;933.6078846884325;946.0539460539461;956.5217391304348;15812.68374632524;16263.75604365959;16727.414540491023;16741;17040.659186816443;40495.79752101221;45015.32477012913;45589.77205113953;46819.76590117164;47682.52317476781;56115;58493.70753146207;60102.699486502286;66242;66941;8545.145485451405;8816.911830881865;8827.514486703036;9100.180983711498;9134.269258459175;9743.75640608962;12969.675758106123;13607.523736669169;13637.454501820213;13649.454021839016;11378.487968041292;11547.769044619228;11633.88366116328;11663.825042624198;11843.526258949545;11612.419379031184;11784.58753943608;11899.286042837457;12008.459619316976;12058;11665.766684666429;11666.416679166177;11747.882521174679;11938.28370297785;11997.100217483898;8763.91236087631;8917.73246802597;8989.595468203815;9073.59168837417;9165.541722913695;11147.72130696739;11314.321140731583;11438.370889601152;11530.827037594276;11718.121140914636 12:14:01 INFO - PROCESS | 17412 | |3;mootools.html;1162.383936513647;1223.908206884484;1231.0643910627923;1289.2393487842173;1384.729044367238;6975.965120174398;7536.208698086697;7891.368690504746;7894.48685835421;8021.518708877471;7811.296983271504;8088.11030786613;8094.797630059252;8250.834983300345;8256.298214651746;2439.951200975979;2471.7157526884457;2475.0718480569785;2478.50429914017;2478.6653801736807;2374.27584586701;2474.2453551666736;2478.2069737683946;2481.10680155144;2482.689663792026;2426.575349313872;2453.2272334214754;2457.9799383255927;2459.372859920718;2460.015993602555;2368.230325144335;2394.1620432848626;2401.903923843044;2402.8918698658604;2426.1751004658413;2388.4506563490495;2389.5340408620327;2447.6940382452194;2448.7673671001226;2449.5713250181147;6754.797356079325;6926.965365173141;8223.259906608375;8312.1687831217;8364.03813561442;5116.872078198037;5263.31576895005;5287.391949925769;5335.866603334947;5353.2237825515085;3538.7345949053924;3574.1779390740276;3641.6540428659237;3641.817909104534;3643.198496330803;1250.8498980122351;1251.7621651886113;1257.3273298785107;1298.3573131299972;1304.6673098359952;11328.773424531546;11417.543298268143;11513.769724605461;11565.959063684224;11588.942055289754;4607.193741095362;4780.928286075712;4849.102915960559;4852.4662287148385;4864.732439715779;9436.480993545421;9444;9446.291528135418;9460.52697365129;9466.621335146654;5378.596605254622;5382.461753824665;5393.7303134843105;5400.4599540046465;5403.108487099585;4827.686200396963;4836.758162091881;4894.926576101361;4904.362432883702;4914.680545764514;3705.370087085202;3718.8326525306425;3765.077555998798;3781.6596506314563;3831.59768224338;1299.155548893227;1345.549241004255;1357.5180810812217;1369.2127026959538;1373.8626137386182;829.1376967953381;843.3801156150224;887.3477993674644;915.3409545127497;917.6833992272656;5685.147227915763;5900.20347253124;6094.177286066413;6096.146539484475;6228.065790131426;826.4008593769469;827.7889138269824;847.894013248344;875.916787905148;881.316979341003;3598.9100272493397;3704.5554533456157;3746.550413950343;3776.4146557283666;3834.8657796976972;8970.82058358829;9355.719328420158;9728.902710972941;9957.900420995697;10013.699589012342;9938.950305248572;10256.794864102825;10269.845952310721;10283.434411107311;10285.845712314322;7472.887906681404;7660.885086723703;7674.462787604925;7723.65243564041;7750.379969602531;5622.803201887914;5870.295564532284;5890.175375447355;5919.585629005928;5986.431289027535;9464.668736594185;9470.763230919281;9522.047795220422;9575.856362154434;9589.136977672042;9558.904410955802;9718.319717619699;9793.412395256022;9801.9019809801;9829.459379734184;7252.782416527512;7349.228331025165;7359.558426494214;7362;7377.963110184414;7767.72812951544;7786.961065194638;7836;7838.255365740246;7839.608019598883;7007.859842803014;7088.184858741311;7195.244499327705;7209.423246140401;7226.385757210696;7053.0830991970715;7086.787396378117;7126.5011449198055;7154.463415243981;7154.821129471805;6542.378474044958;6642.535022548375;6645.634490103091;6656.900146497903;6666.26671066192;4843.128236917248;4920.041876919583;4958.900821983612;4964.826231081895;5117.795288188431;4842.297866809364;4865.416150062015;4936.333594964777;4987.700737955734;5108.974455127701 12:14:01 INFO - PROCESS | 17412 | |4;prototype.html;342.43498227923925;344.2890431259449;350.458615688468;353.58100650728875;358.3388647944543;5358.49094336038;5366.89266214676;5371.462853714626;5373.247745315659;5393.730313484325;5066.214736715815;5152.433232344439;5177.143028443806;5184.507471790183;5313.920291195625;4158;4173.979130104345;4179.602937720919;4184.518780340254;4193.140406216734;4173.916521669565;4194.538600753915;4198.496180458349;4199.2651286024975;4220.451341325624;3860.74905131167;3890.727649064567;4116.320807066845;4125.236831186226;4183.393407955845;4136.358864376027;4137.213929353413;4138.255114079465;4145.54399016108;4150.128473020684;3676.283124790667;3705.869709738529;3717.237966216919;3717.5353080864893;3719.8698045568276;5059.6458247922665;5180.378354597435;5181.81863634771;5184.403793563751;5205.765740541647;4772.284157376386;4781.641376896712;4783.617310615143;4805.783739731721;4808;5555.694436805974;5561.416051314634;5563.443655634444;5577.2191893135;5582.497575218209;3937.8818635440985;4052.63526282636;4080.6939479538855;4109.452139673392;4116.217918595457;5734.397888221718;5739.708565572754;5747.540196784247;5753.223314852483;5769.769209231626;4147.2534943710425;4148.937765933513;4149.439825623502;4153.854615088458;4171.582841715865;3937.5865534118507;4064.898377540526;4221.662267018693;4225.126913698715;4236.131593023423;4694.413198350207;4695.859124226278;4707.082118986833;4708;4717.9056418872115;5581.2186293918885;5581.995240856685;5582.7766889324785;5621.4659607337235;5678.119891416837;1337.404854839587;1396.3506969259342;1402.747505449029;1403.8525954774807;1404.817373741407;899.4738078224182;908.8773015642936;947.3226642950324;957.9941061884992;976.3946353260882;5181.792728290826;5202.687838729613;5210.557102646242;5233.226390013299;5250.159974404077;5475.890482190413;5485.286912701324;5495.395506494282;5505.843772807675;5561.860953476114;5207.29701490294;5231.136862417735;5458.781648734085;5497.780088796483;5529.115341545334;2959.704029597066;2977.1217490840254;2981.8956336528117;2984.4478771427357;2990.8953186638364;5660.264165658438;5763.279590051244;5800.984827655144;5810.5061069809535;5822.301323841166;5605.411431799684;5642.081692224663;5646.548276137899;5671.829845104653;5708.571857110734;5748.5688573357165;5754.654720716687;5761.6254943429385;5766.394528574523;5767.740451679769;5275.762590683506;5467.234587157722;5508.256385387921;5527.613067085265;5552.833414997556;5420.376656684532;5425;5440.972795136157;5448.4006759257245;5449.773800894767;5471.2887324647545;5657.944709856632;5713.342965559014;5721.370649228665;5776.96014717355;3974.582668819732;4003.959960400359;4006.9198616028098;4027.7715296834745;4027.8993025174605;5539.390667026704;5553.666779993213;5562.443755624405;5567.5545956322585;5573.414791447002;5316.734163291897;5408.37803652585;5449.945500544944;5456.48163424474;5457.317835270591;5582.972085139549;5611.054196546846;5612.905483430692;5625.184348269396;5630.887382252414;5338.599605029561;5460.754266058117;5563.8609034772835;5564.276644036411;5576.721163941867;5501.889962200654;5587.3015873015875;5622.690752008679;5631.408702086386;5636.802711905064;5479.671219726829;5484;5494.36814766307;5515.200295957144;5519.613627046068 12:14:01 INFO - PROCESS | 17412 | |5;yui.html;636.2778246690006;644.6003477843738;652.2499126005097;677.2009029345373;683.1358331710386;13671.179729216241;14424.062435941669;14512.782308265358;14560.92719536401;14590.78113828292;12651.304178270215;12785.232886026844;12814.80777788334;12814.871851281508;12817;563.5097465205267;591.500182345917;604.3050491934267;615.7998650438603;667.1194023888469;719.5215181904027;722.5014739829527;724.0623392706432;725.8169184229698;730.1056206147454;764.8202672371988;770.4991755359006;770.5030255485209;772.4052479590712;774.6204359863655;604.0697326117752;647.4173244080318;647.7959442775534;663.9973639803931;762.6949220311864;461.81989024280557;463.19173043039774;464.846600621794;464.8582182434356;466.0934482431672;12207.877921220763;12319.322437265946;12352;12364.814527782091;12366.44351004207;12608;12636;12787.808182877265;12825.23048617086;13001.804972925414;12055.33695646739;12072.879271207263;12284.570040048644;12391.814122788166;12454.190477618926;4131.35963925592;4163.958360416417;4169.332906734908;4173.5409104998425;4226.070264541796;60564.69717651427;61269.85555505536;61610.075848862754;61674.69162654158;64486;10075.3954762713;10190.235732319958;10253.692389228187;10352.5341359639;10682.038616524394;16782.909110907753;16793.664126717642;16794.16029198535;16803.07583082942;16810.243539040774;7417.703291868264;7485.550866947891;7627.54234745917;7737.264959828807;7806.804829879298;4401.361802538614;4449.777511124431;4455.153520831096;4514.300283456069;4685.390899183084;3360.56312679355;3460.463628137643;3462.5325581046236;3462.8441720122655;3462.913427164341;619.0775744141287;631.9462845658171;643.810076027573;644.7517705683252;646.8027251688186;564.94350564944;610.4414460768347;636.0649844728242;645.2128403347908;645.8449972006684;9025.41334813235;9063.536869212025;9274.443533387883;9280.7679808004;9292.210162136294;527.8390091022198;610.5420934299276;615.7536985205953;630.5460068750492;631.9715612797435;4338.197433474817;4481.641468682497;4526.909461810746;4534.750588717587;4542.523035081335;51810.481895180565;57145.714271429206;92268;93037;94301.5284923571;53428.465715343125;58233;76286.6185669068;79897.60051199707;83462.58268708618;73425.22736022141;74034;74058.25941740513;75838.24161758312;76161;8692;8740.169683880022;8801.515916624647;8806.691765788166;8916.15296546827;50914.745426274116;51214;51326.230106547686;52141.21788173256;52712.47287527076;63241;69602;72026.27973720196;72032;73448.26551734415;9928.404295742279;9948.303618746619;10020.298579099393;10262.486875656337;10334.586616535255;11201.327920324806;11283.097352211968;11471;11491.080713543064;11502.827457587975;9747.756306092404;9801.166900813225;9918.256130790363;9969.252306076929;10114.8482772757;10457.163426925676;10562.102221311274;10580.4709764513;10733.892661073289;10764.46177691128;10601.363918164934;10635.202359823199;10639.8936010642;10716.464176791285;11463.254888432559;8605.053444121268;8700.086490918362;8731.825363492822;8795.868061978947;9069.410488318239;9109.316801239802;10236.283460158016;10425.895741042492;10721.30311529748;11048.723781905517 12:14:01 INFO - PROCESS | 17412 | __end_tp_report 12:14:01 INFO - PROCESS | 17412 | __start_cc_report 12:14:01 INFO - PROCESS | 17412 | _x_x_mozilla_cycle_collect,1013 12:14:01 INFO - PROCESS | 17412 | __end_cc_report 12:14:01 INFO - PROCESS | 17412 | __startTimestamp1479154441518__endTimestamp 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | ------- Summary: start ------- 12:14:01 INFO - PROCESS | 17412 | Number of tests: 6 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | [#0] dojo.html Cycles:165 Average:5499.21 Median:5701.03 stddev:612.81 (10.7%) stddev-sans-first:585.61 12:14:01 INFO - PROCESS | 17412 | Values: 3121.3 3168.7 3180.5 3185.7 3197.9 5332.3 5364.8 5419.0 5433.1 5440.4 5625.0 5640.2 5652.7 5659.3 5665.3 5076.4 5090.8 5159.9 5173.4 5174.2 4900.8 4919.1 5144.0 5177.6 5193.4 4940.4 4987.3 4993.2 5000.5 5102.5 5071.6 5105.5 5161.4 5166.9 5189.8 4830.2 5070.0 5082.8 5128.3 5138.5 5405.9 5423.9 5453.1 5465.5 5513.0 5884.5 5886.0 5978.0 5995.7 5998.5 5908.9 6021.5 6028.7 6043.0 6046.5 5493.6 5506.8 5530.9 5562.4 5568.1 6086.8 6094.7 6104.5 6104.7 6109.2 5614.9 5815.2 5830.6 5837.4 5842.3 5709.7 5859.5 5917.1 5918.0 6011.1 5937.8 5945.7 5952.8 5954.0 6001.6 5913.2 5914.6 5949.2 5971.7 5974.5 4497.4 4540.1 4556.7 4597.9 4604.4 4088.9 4105.4 4115.7 4128.2 4142.8 5709.8 5713.3 5714.4 5719.2 5721.8 5662.8 5709.6 5814.2 5856.4 6063.5 5596.7 5605.6 5612.4 5617.8 5635.0 5069.7 5094.2 5113.0 5114.8 5143.7 6051.6 6106.8 6118.6 6137.7 6139.6 5659.0 5754.9 5758.4 5791.4 5848.7 6000.5 6002.1 6009.3 6011.9 6020.8 5693.0 5697.3 5699.3 5701.0 5713.7 5803.2 5832.8 5909.5 5924.6 5997.0 5769.1 5800.9 5806.4 5808.9 5825.9 5802.6 5814.0 5814.4 5823.4 5824.0 5634.3 5649.8 5664.6 5668.9 5707.2 5859.4 5862.2 5862.3 5866.0 5880.8 5614.1 5661.3 5711.8 5718.6 5721.3 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | [#1] ext.html Cycles:180 Average:55758.81 Median:36588.36 stddev:114940.33 (314.1%) stddev-sans-first:115188.08 12:14:01 INFO - PROCESS | 17412 | Values: 570.8 605.0 615.8 626.7 628.1 29503.7 36612.6 37437.8 37468.8 37507.8 38089.4 38176.0 38258.1 38302.4 38559.4 8416.3 8550.8 8555.6 8556.0 8558.4 8432.1 8511.7 8515.7 8516.9 8518.3 8496.9 8550.1 8555.3 8555.9 8557.3 8526.6 8562.7 8563.5 8564.2 8571.9 8414.7 8470.1 8475.9 8481.2 8487.4 36189.1 36438.1 36457.0 36544.0 36564.1 3245.5 3261.8 3331.8 3569.5 3737.5 28282.0 28760.0 28915.6 28917.3 29665.6 4383.1 4441.6 4464.3 4503.6 4520.8 337176.0 338121.0 340625.0 340676.0 341251.0 31310.5 48014.5 48264.0 48271.5 48324.0 37879.4 40248.2 40333.4 40337.4 40389.8 15371.2 15613.5 15617.8 15620.9 15646.2 12468.5 12598.0 12604.0 12607.5 12614.2 8683.9 8688.2 8713.4 8767.2 8768.6 3275.1 3288.8 3304.2 3307.1 3318.4 993.9 1033.4 1038.5 1045.4 1105.1 31668.2 32499.7 32566.0 32589.2 33344.5 951.0 977.1 981.4 993.4 1043.1 15561.2 15775.2 15927.8 16071.3 16074.6 540480.0 546242.0 546850.0 547720.0 548543.0 56652.4 57133.9 57308.0 57316.4 57416.7 1119.2 1157.4 1160.5 1211.5 1217.0 28987.3 31947.5 32038.8 32657.3 32807.0 49009.3 49800.5 49825.5 50114.7 50210.5 379963.0 381369.0 381794.0 383024.0 383497.0 24815.5 26167.9 26357.7 27442.9 27495.9 42997.0 44272.3 46720.3 46821.8 47171.8 33869.2 34281.0 34350.3 34350.5 34509.1 34231.0 34272.7 34370.5 34378.1 34439.1 34212.5 34447.3 34961.1 35031.5 35105.5 31286.0 33635.9 33812.3 33928.5 34407.8 25325.1 25344.2 25540.1 25577.2 25624.4 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | [#2] jquery.html Cycles:180 Average:28121.58 Median:233898.19 stddev:76846.13 (32.9%) stddev-sans-first:77033.53 12:14:01 INFO - PROCESS | 17412 | Values: 406.0 415.7 419.7 432.5 445.2 16065.0 17216.7 17912.1 18865.2 18873.2 16282.8 16700.2 16816.3 16906.3 17170.4 5184.4 5191.4 5317.8 5353.8 5363.2 5332.1 5417.4 5423.8 5424.0 5424.3 5238.4 5260.8 5326.5 5418.1 5429.4 5237.6 5272.9 5276.4 5277.5 5277.6 4963.9 5155.5 5156.4 5209.2 5276.8 13594.9 13936.4 13980.4 15645.8 21470.8 2252.4 2408.0 2523.8 2531.3 2771.2 9824.9 10388.1 10406.9 10715.4 10761.9 2008.5 2026.3 2032.3 2049.8 2058.2 57853.1 79891.6 84238.0 89299.6 91171.5 11016.6 11044.7 11085.8 11138.2 11608.4 14583.3 16189.9 16198.9 16208.1 16210.3 7475.3 7741.4 8061.1 8072.6 8086.3 7256.5 7365.2 7776.3 7964.9 8070.8 4623.4 4734.4 4829.7 4891.2 4893.9 1834.3 1948.1 1951.9 1953.5 1980.5 728.3 827.6 849.8 898.1 1006.0 17063.7 18193.3 18324.5 18353.4 18625.3 883.7 901.8 918.2 920.0 950.0 9658.8 9944.9 9999.2 10071.7 10163.7 459490.0 463173.0 463305.0 463573.0 469355.0 92719.0 94382.0 95515.0 96691.5 97366.5 894.3 908.6 933.6 946.1 956.5 15812.7 16263.8 16727.4 16741.0 17040.7 40495.8 45015.3 45589.8 46819.8 47682.5 56115.0 58493.7 60102.7 66242.0 66941.0 8545.1 8816.9 8827.5 9100.2 9134.3 9743.8 12969.7 13607.5 13637.5 13649.5 11378.5 11547.8 11633.9 11663.8 11843.5 11612.4 11784.6 11899.3 12008.5 12058.0 11665.8 11666.4 11747.9 11938.3 11997.1 8763.9 8917.7 8989.6 9073.6 9165.5 11147.7 11314.3 11438.4 11530.8 11718.1 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | [#3] mootools.html Cycles:180 Average:5505.65 Median:5380.53 stddev:2973.21 (55.3%) stddev-sans-first:2963.63 12:14:01 INFO - PROCESS | 17412 | Values: 1162.4 1223.9 1231.1 1289.2 1384.7 6976.0 7536.2 7891.4 7894.5 8021.5 7811.3 8088.1 8094.8 8250.8 8256.3 2440.0 2471.7 2475.1 2478.5 2478.7 2374.3 2474.2 2478.2 2481.1 2482.7 2426.6 2453.2 2458.0 2459.4 2460.0 2368.2 2394.2 2401.9 2402.9 2426.2 2388.5 2389.5 2447.7 2448.8 2449.6 6754.8 6927.0 8223.3 8312.2 8364.0 5116.9 5263.3 5287.4 5335.9 5353.2 3538.7 3574.2 3641.7 3641.8 3643.2 1250.8 1251.8 1257.3 1298.4 1304.7 11328.8 11417.5 11513.8 11566.0 11588.9 4607.2 4780.9 4849.1 4852.5 4864.7 9436.5 9444.0 9446.3 9460.5 9466.6 5378.6 5382.5 5393.7 5400.5 5403.1 4827.7 4836.8 4894.9 4904.4 4914.7 3705.4 3718.8 3765.1 3781.7 3831.6 1299.2 1345.5 1357.5 1369.2 1373.9 829.1 843.4 887.3 915.3 917.7 5685.1 5900.2 6094.2 6096.1 6228.1 826.4 827.8 847.9 875.9 881.3 3598.9 3704.6 3746.6 3776.4 3834.9 8970.8 9355.7 9728.9 9957.9 10013.7 9939.0 10256.8 10269.8 10283.4 10285.8 7472.9 7660.9 7674.5 7723.7 7750.4 5622.8 5870.3 5890.2 5919.6 5986.4 9464.7 9470.8 9522.0 9575.9 9589.1 9558.9 9718.3 9793.4 9801.9 9829.5 7252.8 7349.2 7359.6 7362.0 7378.0 7767.7 7787.0 7836.0 7838.3 7839.6 7007.9 7088.2 7195.2 7209.4 7226.4 7053.1 7086.8 7126.5 7154.5 7154.8 6542.4 6642.5 6645.6 6656.9 6666.3 4843.1 4920.0 4958.9 4964.8 5117.8 4842.3 4865.4 4936.3 4987.7 5109.0 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | [#4] prototype.html Cycles:180 Average:4651.58 Median:5362.69 stddev:1349.34 (25.2%) stddev-sans-first:1313.79 12:14:01 INFO - PROCESS | 17412 | Values: 342.4 344.3 350.5 353.6 358.3 5358.5 5366.9 5371.5 5373.2 5393.7 5066.2 5152.4 5177.1 5184.5 5313.9 4158.0 4174.0 4179.6 4184.5 4193.1 4173.9 4194.5 4198.5 4199.3 4220.5 3860.7 3890.7 4116.3 4125.2 4183.4 4136.4 4137.2 4138.3 4145.5 4150.1 3676.3 3705.9 3717.2 3717.5 3719.9 5059.6 5180.4 5181.8 5184.4 5205.8 4772.3 4781.6 4783.6 4805.8 4808.0 5555.7 5561.4 5563.4 5577.2 5582.5 3937.9 4052.6 4080.7 4109.5 4116.2 5734.4 5739.7 5747.5 5753.2 5769.8 4147.3 4148.9 4149.4 4153.9 4171.6 3937.6 4064.9 4221.7 4225.1 4236.1 4694.4 4695.9 4707.1 4708.0 4717.9 5581.2 5582.0 5582.8 5621.5 5678.1 1337.4 1396.4 1402.7 1403.9 1404.8 899.5 908.9 947.3 958.0 976.4 5181.8 5202.7 5210.6 5233.2 5250.2 5475.9 5485.3 5495.4 5505.8 5561.9 5207.3 5231.1 5458.8 5497.8 5529.1 2959.7 2977.1 2981.9 2984.4 2990.9 5660.3 5763.3 5801.0 5810.5 5822.3 5605.4 5642.1 5646.5 5671.8 5708.6 5748.6 5754.7 5761.6 5766.4 5767.7 5275.8 5467.2 5508.3 5527.6 5552.8 5420.4 5425.0 5441.0 5448.4 5449.8 5471.3 5657.9 5713.3 5721.4 5777.0 3974.6 4004.0 4006.9 4027.8 4027.9 5539.4 5553.7 5562.4 5567.6 5573.4 5316.7 5408.4 5449.9 5456.5 5457.3 5583.0 5611.1 5612.9 5625.2 5630.9 5338.6 5460.8 5563.9 5564.3 5576.7 5501.9 5587.3 5622.7 5631.4 5636.8 5479.7 5484.0 5494.4 5515.2 5519.6 12:14:01 INFO - PROCESS | 17412 | 12:14:01 INFO - PROCESS | 17412 | [#5] yui.html Cycles:180 Average:17160.48 Median:26995.99 stddev:23726.69 (87.9%) stddev-sans-first:23760.81 12:14:01 INFO - PROCESS | 17412 | Values: 636.3 644.6 652.2 677.2 683.1 13671.2 14424.1 14512.8 14560.9 14590.8 12651.3 12785.2 12814.8 12814.9 12817.0 563.5 591.5 604.3 615.8 667.1 719.5 722.5 724.1 725.8 730.1 764.8 770.5 770.5 772.4 774.6 604.1 647.4 647.8 664.0 762.7 461.8 463.2 464.8 464.9 466.1 12207.9 12319.3 12352.0 12364.8 12366.4 12608.0 12636.0 12787.8 12825.2 13001.8 12055.3 12072.9 12284.6 12391.8 12454.2 4131.4 4164.0 4169.3 4173.5 4226.1 60564.7 61269.9 61610.1 61674.7 64486.0 10075.4 10190.2 10253.7 10352.5 10682.0 16782.9 16793.7 16794.2 16803.1 16810.2 7417.7 7485.6 7627.5 7737.3 7806.8 4401.4 4449.8 4455.2 4514.3 4685.4 3360.6 3460.5 3462.5 3462.8 3462.9 619.1 631.9 643.8 644.8 646.8 564.9 610.4 636.1 645.2 645.8 9025.4 9063.5 9274.4 9280.8 9292.2 527.8 610.5 615.8 630.5 632.0 4338.2 4481.6 4526.9 4534.8 4542.5 51810.5 57145.7 92268.0 93037.0 94301.5 53428.5 58233.0 76286.6 79897.6 83462.6 73425.2 74034.0 74058.3 75838.2 76161.0 8692.0 8740.2 8801.5 8806.7 8916.2 50914.7 51214.0 51326.2 52141.2 52712.5 63241.0 69602.0 72026.3 72032.0 73448.3 9928.4 9948.3 10020.3 10262.5 10334.6 11201.3 11283.1 11471.0 11491.1 11502.8 9747.8 9801.2 9918.3 9969.3 10114.8 10457.2 10562.1 10580.5 10733.9 10764.5 10601.4 10635.2 10639.9 10716.5 11463.3 8605.1 8700.1 8731.8 8795.9 9069.4 9109.3 10236.3 10425.9 10721.3 11048.7 12:14:01 INFO - PROCESS | 17412 | -------- Summary: end -------- 12:14:01 INFO - PROCESS | 17412 | 12:14:02 INFO - TEST-INFO | 17412: exit 0 12:14:02 INFO - TEST-OK | dromaeo_css | took 1114745ms 12:14:02 INFO - TEST-START | kraken 12:14:02 INFO - operating with platform_type : linux_ 12:14:02 INFO - Initialising browser for kraken test... 12:14:02 INFO - TEST-INFO | started process 17728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgMzJhL/profile http://localhost:33393/getInfo.html) 12:14:05 ERROR - PROCESS | 17728 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 12:14:06 INFO - PROCESS | 17728 | __metrics Screen width/height:1600/1200 12:14:06 INFO - PROCESS | 17728 | colorDepth:24 12:14:06 INFO - PROCESS | 17728 | Browser inner width/height: 1024/697 12:14:06 INFO - PROCESS | 17728 | __metrics 12:14:06 INFO - PROCESS | 17728 | 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" 12:14:06 INFO - PROCESS | 17728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:07 INFO - PROCESS | 17728 | console.error: PushService: 12:14:07 INFO - PROCESS | 17728 | stateChangeProcessEnqueue: Error transitioning state 12:14:07 INFO - PROCESS | 17728 | UnknownError 12:14:07 INFO - TEST-INFO | 17728: exit 0 12:14:07 INFO - Browser initialized. 12:14:07 INFO - Running cycle 1/1 for kraken test... 12:14:07 INFO - TEST-INFO | started process 17823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgMzJhL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:19 INFO - PROCESS | 17823 | RSS: Main: 144871424 12:14:19 INFO - PROCESS | 17823 | 12:14:21 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:22 INFO - PROCESS | 17823 | RSS: Main: 186376192 12:14:22 INFO - PROCESS | 17823 | 12:14:25 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-dft) 12:14:25 INFO - PROCESS | 17823 | RSS: Main: 175579136 12:14:25 INFO - PROCESS | 17823 | 12:14:28 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-fft) 12:14:29 INFO - PROCESS | 17823 | RSS: Main: 267370496 12:14:29 INFO - PROCESS | 17823 | 12:14:31 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33393/tests/kraken/driver.html?testName=audio-oscillator) 12:14:31 INFO - PROCESS | 17823 | RSS: Main: 173215744 12:14:31 INFO - PROCESS | 17823 | 12:14:34 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:14:34 INFO - PROCESS | 17823 | RSS: Main: 175525888 12:14:34 INFO - PROCESS | 17823 | 12:14:37 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33393/tests/kraken/driver.html?testName=imaging-darkroom) 12:14:38 INFO - PROCESS | 17823 | RSS: Main: 214749184 12:14:38 INFO - PROCESS | 17823 | 12:14:41 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33393/tests/kraken/driver.html?testName=imaging-desaturate) 12:14:42 INFO - PROCESS | 17823 | RSS: Main: 213118976 12:14:42 INFO - PROCESS | 17823 | 12:14:44 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33393/tests/kraken/driver.html?testName=json-parse-financial) 12:14:45 INFO - PROCESS | 17823 | RSS: Main: 212668416 12:14:45 INFO - PROCESS | 17823 | 12:14:46 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:47 INFO - PROCESS | 17823 | RSS: Main: 174731264 12:14:47 INFO - PROCESS | 17823 | 12:14:49 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:49 INFO - PROCESS | 17823 | RSS: Main: 180994048 12:14:49 INFO - PROCESS | 17823 | 12:14:51 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:52 INFO - PROCESS | 17823 | RSS: Main: 190386176 12:14:52 INFO - PROCESS | 17823 | 12:14:54 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:55 INFO - PROCESS | 17823 | RSS: Main: 199417856 12:14:55 INFO - PROCESS | 17823 | 12:14:58 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:58 INFO - PROCESS | 17823 | RSS: Main: 195833856 12:14:58 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | Cycle 1(1): loaded http://localhost:33393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33393/tests/kraken/driver.html?testName=ai-astar) 12:15:00 INFO - PROCESS | 17823 | RSS: Main: 247300096 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | __start_tp_report 12:15:00 INFO - PROCESS | 17823 | _x_x_mozilla_page_load 12:15:00 INFO - PROCESS | 17823 | _x_x_mozilla_page_load_details 12:15:00 INFO - PROCESS | 17823 | |i|pagename|runs| 12:15:00 INFO - PROCESS | 17823 | |0;ai-astar;109;111;111;110;112;111;110;109;111;112 12:15:00 INFO - PROCESS | 17823 | |1;audio-beat-detection;142;122;126;158;126;122;120;120;149;122 12:15:00 INFO - PROCESS | 17823 | |2;audio-dft;160;161;160;160;160;161;160;160;161;161 12:15:00 INFO - PROCESS | 17823 | |3;audio-fft;75;75;75;122;77;76;77;82;96;75 12:15:00 INFO - PROCESS | 17823 | |4;audio-oscillator;81;82;111;81;82;82;109;82;82;107 12:15:00 INFO - PROCESS | 17823 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 12:15:00 INFO - PROCESS | 17823 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;145;146 12:15:00 INFO - PROCESS | 17823 | |7;imaging-desaturate;84;85;84;85;84;85;84;85;86;85 12:15:00 INFO - PROCESS | 17823 | |8;json-parse-financial;49;50;48;50;49;57;51;50;50;56 12:15:00 INFO - PROCESS | 17823 | |9;json-stringify-tinderbox;58;59;58;58;58;58;58;58;59;62 12:15:00 INFO - PROCESS | 17823 | |10;stanford-crypto-aes;75;74;74;73;74;74;74;73;74;73 12:15:00 INFO - PROCESS | 17823 | |11;stanford-crypto-ccm;129;129;128;130;134;132;124;123;171;125 12:15:00 INFO - PROCESS | 17823 | |12;stanford-crypto-pbkdf2;157;156;153;156;158;158;155;160;154;156 12:15:00 INFO - PROCESS | 17823 | |13;stanford-crypto-sha256-iterative;66;64;63;62;62;62;63;61;61;61 12:15:00 INFO - PROCESS | 17823 | __end_tp_report 12:15:00 INFO - PROCESS | 17823 | __start_cc_report 12:15:00 INFO - PROCESS | 17823 | _x_x_mozilla_cycle_collect,1615 12:15:00 INFO - PROCESS | 17823 | __end_cc_report 12:15:00 INFO - PROCESS | 17823 | __startTimestamp1479154500836__endTimestamp 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | ------- Summary: start ------- 12:15:00 INFO - PROCESS | 17823 | Number of tests: 14 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.07 (1.0%) stddev-sans-first:0.97 12:15:00 INFO - PROCESS | 17823 | Values: 109.0 111.0 111.0 110.0 112.0 111.0 110.0 109.0 111.0 112.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:126.00 stddev:13.78 (10.9%) stddev-sans-first:13.99 12:15:00 INFO - PROCESS | 17823 | Values: 142.0 122.0 126.0 158.0 126.0 122.0 120.0 120.0 149.0 122.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 12:15:00 INFO - PROCESS | 17823 | Values: 160.0 161.0 160.0 160.0 160.0 161.0 160.0 160.0 161.0 161.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:15.16 (19.8%) stddev-sans-first:15.80 12:15:00 INFO - PROCESS | 17823 | Values: 75.0 75.0 75.0 122.0 77.0 76.0 77.0 82.0 96.0 75.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.22 (16.1%) stddev-sans-first:13.62 12:15:00 INFO - PROCESS | 17823 | Values: 81.0 82.0 111.0 81.0 82.0 82.0 109.0 82.0 82.0 107.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:15:00 INFO - PROCESS | 17823 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:15:00 INFO - PROCESS | 17823 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 12:15:00 INFO - PROCESS | 17823 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 84.0 85.0 86.0 85.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:50.00 stddev:3.02 (6.0%) stddev-sans-first:3.11 12:15:00 INFO - PROCESS | 17823 | Values: 49.0 50.0 48.0 50.0 49.0 57.0 51.0 50.0 50.0 56.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.00 stddev:1.26 (2.2%) stddev-sans-first:1.32 12:15:00 INFO - PROCESS | 17823 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 62.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 12:15:00 INFO - PROCESS | 17823 | Values: 75.0 74.0 74.0 73.0 74.0 74.0 74.0 73.0 74.0 73.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:129.50 stddev:13.96 (10.8%) stddev-sans-first:14.75 12:15:00 INFO - PROCESS | 17823 | Values: 129.0 129.0 128.0 130.0 134.0 132.0 124.0 123.0 171.0 125.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.50 stddev:2.06 (1.3%) stddev-sans-first:2.17 12:15:00 INFO - PROCESS | 17823 | Values: 157.0 156.0 153.0 156.0 158.0 158.0 155.0 160.0 154.0 156.0 12:15:00 INFO - PROCESS | 17823 | 12:15:00 INFO - PROCESS | 17823 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.58 (2.5%) stddev-sans-first:1.05 12:15:00 INFO - PROCESS | 17823 | Values: 66.0 64.0 63.0 62.0 62.0 62.0 63.0 61.0 61.0 61.0 12:15:00 INFO - PROCESS | 17823 | -------- Summary: end -------- 12:15:00 INFO - PROCESS | 17823 | 12:15:01 INFO - TEST-INFO | 17823: exit 0 12:15:01 INFO - TEST-OK | kraken | took 59615ms 12:15:01 INFO - SUITE-END | took 1174s 12:15:02 INFO - Completed test suite (00:19:34) 12:15:02 INFO - javascript benchmark 12:15:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.3133110715644, 3168.730657894079, 3180.4593219152734, 3185.729213016895, 3197.8720851165954, 5332.33345831771, 5364.812231571896, 5419.0, 5433.076377015902, 5440.3743569489525, 5625.043742563764, 5640.153976903466, 5652.717364131798, 5659.264295641571, 5665.263515742948, 5076.44159142494, 5090.847274581759, 5159.922601160967, 5173.43092259853, 5174.249733788598, 4900.779464924087, 4919.065377578267, 5144.048351055067, 5177.585793136559, 5193.350831146106, 4940.357753492041, 4987.276844857493, 4993.201087825949, 5000.524950129732, 5102.540771330579, 5071.644984851062, 5105.463926287724, 5161.406438259611, 5166.870828229286, 5189.818356357509, 4830.227163653799, 5069.986002799455, 5082.771275292584, 5128.307678463397, 5138.537531622172, 5405.891882162374, 5423.945760542383, 5453.100238460649, 5465.480779325958, 5512.972435137839, 5884.52923766102, 5885.970570147165, 5977.970110149421, 5995.700214989233, 5998.490128339096, 5908.852278693024, 6021.51827853775, 6028.6985650717725, 6043.033114701627, 6046.516278697693, 5493.587980901409, 5506.807261745819, 5530.944690553123, 5562.443755624486, 5568.1091025435735, 6086.847828804315, 6094.664793436404, 6104.4505994460715, 6104.664243466563, 6109.20580324555, 5614.9157762633595, 5815.244018277597, 5830.62100963436, 5837.416258374214, 5842.328132264759, 5709.714514274269, 5859.5019423349495, 5917.082852157922, 5917.970410147922, 6011.098335249748, 5937.753071854872, 5945.732442040032, 5952.791652292236, 5953.970230148821, 6001.609895356875, 5913.201717768046, 5914.645121292736, 5949.2266005419015, 5971.731272092767, 5974.462298393166, 4497.415336006364, 4540.069285796404, 4556.726596404226, 4597.908041839211, 4604.424446944132, 4088.8773336799945, 4105.384192371109, 4115.650169735546, 4128.2156390285745, 4142.79286035697, 5709.800156994568, 5713.314402271754, 5714.371419143891, 5719.195875464629, 5721.77112915487, 5662.773489060474, 5709.600327977002, 5814.244148260699, 5856.443637854482, 6063.514918806485, 5596.748146333425, 5605.579581531401, 5612.35457922336, 5617.831465056055, 5635.0, 5069.746512674352, 5094.159463688524, 5113.028524580318, 5114.795408183631, 5143.691378517301, 6051.606645568112, 6106.755729770848, 6118.571699980958, 6137.7447333336595, 6139.57023008394, 5658.971705141448, 5754.8849023018465, 5758.366579676316, 5791.362950075404, 5848.707564621837, 6000.489958353589, 6002.0996850472775, 6009.308929472992, 6011.879762404815, 6020.759169633166, 5693.0, 5697.3448053474385, 5699.2590963174525, 5701.030824759884, 5713.714314284352, 5803.158542011469, 5832.795852145155, 5909.497692696169, 5924.585279030426, 5996.970015149896, 5769.086910336826, 5800.912986305293, 5806.44838740319, 5808.912866307093, 5825.854353641193, 5802.564807639528, 5813.970930145491, 5814.360420353673, 5823.4467725566, 5823.970880145572, 5634.32388113429, 5649.774009039593, 5664.603477756517, 5668.914966275592, 5707.172459993195, 5859.414058594107, 5862.179294898803, 5862.267216597926, 5865.970670146793, 5880.794172203952, 5614.07367784311, 5661.348944871228, 5711.771529138788, 5718.571107167062, 5721.313442386941], "value": 5458.295174661348, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8059259851652, 604.9879002419951, 615.8337248942786, 626.6647343671137, 628.0735914526077, 29503.704962950364, 36612.63387366125, 37437.81281093594, 37468.81265593675, 37507.812460937654, 38089.42865857014, 38176.0, 38258.087095645176, 38302.425463618, 38559.42160867589, 8416.326693864492, 8550.828983420328, 8555.614997325105, 8555.95722021389, 8558.358123140759, 8432.072472028072, 8511.702090426836, 8515.701950431736, 8516.8722469163, 8518.318534517255, 8496.872546911802, 8550.059493455716, 8555.315574754035, 8555.914440855606, 8557.315414766836, 8526.616302266382, 8562.74311770648, 8563.529005904673, 8564.229219370225, 8571.871421928676, 8414.705485307984, 8470.068292487822, 8475.915240847575, 8481.236688698047, 8487.40588158829, 36189.095272618135, 36438.089047773756, 36457.0, 36544.0, 36564.0858978525, 3245.4807230842953, 3261.836908154583, 3331.766776325658, 3569.4824250483794, 3737.4580685800406, 28282.0, 28760.0, 28915.56626650602, 28917.277068073257, 29665.555016674767, 4383.145286669101, 4441.578050085237, 4464.330350447426, 4503.594676479132, 4520.773961301922, 337176.0, 338121.0, 340625.0, 340675.9999999975, 341251.0, 31310.530342044887, 48014.51985480171, 48264.0, 48271.5172848274, 48324.0, 37879.431808522895, 40248.1950360997, 40333.39499907504, 40337.39493907594, 40389.79805100956, 15371.15458649785, 15613.531594052196, 15617.843821561866, 15620.921895390451, 15646.2176891155, 12468.501259949682, 12598.0, 12604.0, 12607.495700172074, 12614.180078294881, 8683.869741953877, 8688.174623410765, 8713.390062695551, 8767.167119123673, 8768.605412756313, 3275.082976766509, 3288.8191149487006, 3304.15743985287, 3307.140143562691, 3318.352921180395, 993.9155171810332, 1033.4471057983942, 1038.4548112241134, 1045.3780000899453, 1105.077260487502, 31668.208294792814, 32499.675003249664, 32566.0, 32589.18527036843, 33344.49983250253, 950.9904900951041, 977.1449981266392, 981.40134517944, 993.3543196922059, 1043.113353649392, 15561.221938903009, 15775.211239437982, 15927.840721592867, 16071.276792544364, 16074.598135046483, 540480.0, 546242.0, 546850.0, 547720.0, 548543.0, 56652.433475664715, 57133.85732285331, 57308.0, 57316.42683573111, 57416.71291643515, 1119.1662211652372, 1157.398152960456, 1160.5415860735131, 1211.4911737070452, 1217.0446199733344, 28987.275318117216, 31947.520787187746, 32038.83980580082, 32657.346853062332, 32807.0, 49009.2648610264, 49800.50199497959, 49825.50174498209, 50114.74942625409, 50210.497895020584, 379963.0, 381369.0, 381794.0, 383024.0, 383497.0, 24815.503689926463, 26167.86916065484, 26357.736422636295, 27442.862785685942, 27495.862520687268, 42997.0, 44272.33591496194, 46720.29919551277, 46821.765891170326, 47171.764141179076, 33869.15327116842, 34281.0, 34350.31299374049, 34350.48474272938, 34509.13727156841, 34231.0, 34272.65727342795, 34370.48444273288, 34378.14054648654, 34439.139021524665, 34212.48681269733, 34447.311053778285, 34961.12597185091, 35031.47452788159, 35105.47341789824, 31286.0, 33635.85534854874, 33812.323753525285, 33928.491072634424, 34407.827960860035, 25325.0672079885, 25344.239672809847, 25540.10609628654, 25577.232683019538, 25624.359391015372], "value": 17793.687814754678, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.9553449120597, 415.68615695150174, 419.74815110933423, 432.5371852118234, 445.18308903162693, 16065.0, 17216.65566688667, 17912.104394780275, 18865.245390184395, 18873.245070197194, 16282.83717162828, 16700.248488818, 16816.32734690614, 16906.323747050134, 17170.39903603374, 5184.377874655047, 5191.351081114851, 5317.813876514323, 5353.785848566053, 5363.195520671911, 5332.093544097513, 5417.404085550606, 5423.755930983115, 5423.972880135613, 5424.321959755031, 5238.423773384944, 5260.763265653055, 5326.547243484309, 5418.106012507931, 5429.375621803503, 5237.554807841338, 5272.868178295535, 5276.366835979668, 5277.498637629457, 5277.604179686519, 4963.90072198554, 5155.536001759822, 5156.407013193493, 5209.166533354645, 5276.81531146408, 13594.864051359558, 13936.372863221179, 13980.370883310276, 15645.765313520305, 21470.785292147033, 2252.358077947777, 2407.9759202407927, 2523.8107141964424, 2531.341851118704, 2771.2240572639694, 9824.90175098254, 10388.065074143364, 10406.895931040668, 10715.410652414113, 10761.946190268998, 2008.4978755311172, 2026.3211824038965, 2032.2582257475915, 2049.825764809993, 2058.166442590753, 57853.089439751035, 79891.60054199692, 84238.0, 89299.55350223207, 91171.54414227953, 11016.567846179945, 11044.723881902855, 11085.778284434266, 11138.164637652208, 11608.419579021016, 14583.270836458134, 16189.919050404673, 16198.919005404898, 16208.10855402964, 16210.270537825827, 7475.327220550176, 7741.380689544823, 8061.072976607648, 8072.596370181467, 8086.312663423675, 7256.528325658815, 7365.189829118793, 7776.300132988058, 7964.8805267921025, 8070.83858322842, 4623.375844261049, 4734.431868175772, 4829.7469851029, 4891.192953162759, 4893.853184404474, 1834.321301118568, 1948.0551932312817, 1951.853610979154, 1953.4920920560758, 1980.5345743750206, 728.2608152724988, 827.5613924619961, 849.762066621347, 898.0929261445856, 1005.9698209053594, 17063.744043839353, 18193.272269109086, 18324.54188645268, 18353.357632483065, 18625.348112815987, 883.6951251818112, 901.7745563609097, 918.169057003413, 920.0385597051097, 949.9620015199453, 9658.806823863624, 9944.850827237597, 9999.150072243796, 10071.748206294755, 10163.695089147337, 459490.0, 463173.0, 463305.0, 463573.0, 469355.0, 92719.0, 94382.0, 95515.0, 96691.51654241684, 97366.5131674337, 894.3471265975874, 908.6456282050138, 933.6078846884325, 946.0539460539461, 956.5217391304348, 15812.68374632524, 16263.75604365959, 16727.414540491023, 16741.0, 17040.659186816443, 40495.79752101221, 45015.32477012913, 45589.77205113953, 46819.76590117164, 47682.52317476781, 56115.0, 58493.70753146207, 60102.699486502286, 66242.0, 66941.0, 8545.145485451405, 8816.911830881865, 8827.514486703036, 9100.180983711498, 9134.269258459175, 9743.75640608962, 12969.675758106123, 13607.523736669169, 13637.454501820213, 13649.454021839016, 11378.487968041292, 11547.769044619228, 11633.88366116328, 11663.825042624198, 11843.526258949545, 11612.419379031184, 11784.58753943608, 11899.286042837457, 12008.459619316976, 12058.0, 11665.766684666429, 11666.416679166177, 11747.882521174679, 11938.28370297785, 11997.100217483898, 8763.91236087631, 8917.73246802597, 8989.595468203815, 9073.59168837417, 9165.541722913695, 11147.72130696739, 11314.321140731583, 11438.370889601152, 11530.827037594276, 11718.121140914636], "value": 8941.200345669968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1162.383936513647, 1223.908206884484, 1231.0643910627923, 1289.2393487842173, 1384.729044367238, 6975.965120174398, 7536.208698086697, 7891.368690504746, 7894.48685835421, 8021.518708877471, 7811.296983271504, 8088.11030786613, 8094.797630059252, 8250.834983300345, 8256.298214651746, 2439.951200975979, 2471.7157526884457, 2475.0718480569785, 2478.50429914017, 2478.6653801736807, 2374.27584586701, 2474.2453551666736, 2478.2069737683946, 2481.10680155144, 2482.689663792026, 2426.575349313872, 2453.2272334214754, 2457.9799383255927, 2459.372859920718, 2460.015993602555, 2368.230325144335, 2394.1620432848626, 2401.903923843044, 2402.8918698658604, 2426.1751004658413, 2388.4506563490495, 2389.5340408620327, 2447.6940382452194, 2448.7673671001226, 2449.5713250181147, 6754.797356079325, 6926.965365173141, 8223.259906608375, 8312.1687831217, 8364.03813561442, 5116.872078198037, 5263.31576895005, 5287.391949925769, 5335.866603334947, 5353.2237825515085, 3538.7345949053924, 3574.1779390740276, 3641.6540428659237, 3641.817909104534, 3643.198496330803, 1250.8498980122351, 1251.7621651886113, 1257.3273298785107, 1298.3573131299972, 1304.6673098359952, 11328.773424531546, 11417.543298268143, 11513.769724605461, 11565.959063684224, 11588.942055289754, 4607.193741095362, 4780.928286075712, 4849.102915960559, 4852.4662287148385, 4864.732439715779, 9436.480993545421, 9444.0, 9446.291528135418, 9460.52697365129, 9466.621335146654, 5378.596605254622, 5382.461753824665, 5393.7303134843105, 5400.4599540046465, 5403.108487099585, 4827.686200396963, 4836.758162091881, 4894.926576101361, 4904.362432883702, 4914.680545764514, 3705.370087085202, 3718.8326525306425, 3765.077555998798, 3781.6596506314563, 3831.59768224338, 1299.155548893227, 1345.549241004255, 1357.5180810812217, 1369.2127026959538, 1373.8626137386182, 829.1376967953381, 843.3801156150224, 887.3477993674644, 915.3409545127497, 917.6833992272656, 5685.147227915763, 5900.20347253124, 6094.177286066413, 6096.146539484475, 6228.065790131426, 826.4008593769469, 827.7889138269824, 847.894013248344, 875.916787905148, 881.316979341003, 3598.9100272493397, 3704.5554533456157, 3746.550413950343, 3776.4146557283666, 3834.8657796976972, 8970.82058358829, 9355.719328420158, 9728.902710972941, 9957.900420995697, 10013.699589012342, 9938.950305248572, 10256.794864102825, 10269.845952310721, 10283.434411107311, 10285.845712314322, 7472.887906681404, 7660.885086723703, 7674.462787604925, 7723.65243564041, 7750.379969602531, 5622.803201887914, 5870.295564532284, 5890.175375447355, 5919.585629005928, 5986.431289027535, 9464.668736594185, 9470.763230919281, 9522.047795220422, 9575.856362154434, 9589.136977672042, 9558.904410955802, 9718.319717619699, 9793.412395256022, 9801.9019809801, 9829.459379734184, 7252.782416527512, 7349.228331025165, 7359.558426494214, 7362.0, 7377.963110184414, 7767.72812951544, 7786.961065194638, 7836.0, 7838.255365740246, 7839.608019598883, 7007.859842803014, 7088.184858741311, 7195.244499327705, 7209.423246140401, 7226.385757210696, 7053.0830991970715, 7086.787396378117, 7126.5011449198055, 7154.463415243981, 7154.821129471805, 6542.378474044958, 6642.535022548375, 6645.634490103091, 6656.900146497903, 6666.26671066192, 4843.128236917248, 4920.041876919583, 4958.900821983612, 4964.826231081895, 5117.795288188431, 4842.297866809364, 4865.416150062015, 4936.333594964777, 4987.700737955734, 5108.974455127701], "value": 4482.46656050466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.43498227923925, 344.2890431259449, 350.458615688468, 353.58100650728875, 358.3388647944543, 5358.49094336038, 5366.89266214676, 5371.462853714626, 5373.247745315659, 5393.730313484325, 5066.214736715815, 5152.433232344439, 5177.143028443806, 5184.507471790183, 5313.920291195625, 4158.0, 4173.979130104345, 4179.602937720919, 4184.518780340254, 4193.140406216734, 4173.916521669565, 4194.538600753915, 4198.496180458349, 4199.2651286024975, 4220.451341325624, 3860.74905131167, 3890.727649064567, 4116.320807066845, 4125.236831186226, 4183.393407955845, 4136.358864376027, 4137.213929353413, 4138.255114079465, 4145.54399016108, 4150.128473020684, 3676.283124790667, 3705.869709738529, 3717.237966216919, 3717.5353080864893, 3719.8698045568276, 5059.6458247922665, 5180.378354597435, 5181.81863634771, 5184.403793563751, 5205.765740541647, 4772.284157376386, 4781.641376896712, 4783.617310615143, 4805.783739731721, 4808.0, 5555.694436805974, 5561.416051314634, 5563.443655634444, 5577.2191893135, 5582.497575218209, 3937.8818635440985, 4052.63526282636, 4080.6939479538855, 4109.452139673392, 4116.217918595457, 5734.397888221718, 5739.708565572754, 5747.540196784247, 5753.223314852483, 5769.769209231626, 4147.2534943710425, 4148.937765933513, 4149.439825623502, 4153.854615088458, 4171.582841715865, 3937.5865534118507, 4064.898377540526, 4221.662267018693, 4225.126913698715, 4236.131593023423, 4694.413198350207, 4695.859124226278, 4707.082118986833, 4708.0, 4717.9056418872115, 5581.2186293918885, 5581.995240856685, 5582.7766889324785, 5621.4659607337235, 5678.119891416837, 1337.404854839587, 1396.3506969259342, 1402.747505449029, 1403.8525954774807, 1404.817373741407, 899.4738078224182, 908.8773015642936, 947.3226642950324, 957.9941061884992, 976.3946353260882, 5181.792728290826, 5202.687838729613, 5210.557102646242, 5233.226390013299, 5250.159974404077, 5475.890482190413, 5485.286912701324, 5495.395506494282, 5505.843772807675, 5561.860953476114, 5207.29701490294, 5231.136862417735, 5458.781648734085, 5497.780088796483, 5529.115341545334, 2959.704029597066, 2977.1217490840254, 2981.8956336528117, 2984.4478771427357, 2990.8953186638364, 5660.264165658438, 5763.279590051244, 5800.984827655144, 5810.5061069809535, 5822.301323841166, 5605.411431799684, 5642.081692224663, 5646.548276137899, 5671.829845104653, 5708.571857110734, 5748.5688573357165, 5754.654720716687, 5761.6254943429385, 5766.394528574523, 5767.740451679769, 5275.762590683506, 5467.234587157722, 5508.256385387921, 5527.613067085265, 5552.833414997556, 5420.376656684532, 5425.0, 5440.972795136157, 5448.4006759257245, 5449.773800894767, 5471.2887324647545, 5657.944709856632, 5713.342965559014, 5721.370649228665, 5776.96014717355, 3974.582668819732, 4003.959960400359, 4006.9198616028098, 4027.7715296834745, 4027.8993025174605, 5539.390667026704, 5553.666779993213, 5562.443755624405, 5567.5545956322585, 5573.414791447002, 5316.734163291897, 5408.37803652585, 5449.945500544944, 5456.48163424474, 5457.317835270591, 5582.972085139549, 5611.054196546846, 5612.905483430692, 5625.184348269396, 5630.887382252414, 5338.599605029561, 5460.754266058117, 5563.8609034772835, 5564.276644036411, 5576.721163941867, 5501.889962200654, 5587.3015873015875, 5622.690752008679, 5631.408702086386, 5636.802711905064, 5479.671219726829, 5484.0, 5494.36814766307, 5515.200295957144, 5519.613627046068], "value": 4224.373852000508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.2778246690006, 644.6003477843738, 652.2499126005097, 677.2009029345373, 683.1358331710386, 13671.179729216241, 14424.062435941669, 14512.782308265358, 14560.92719536401, 14590.78113828292, 12651.304178270215, 12785.232886026844, 12814.80777788334, 12814.871851281508, 12817.0, 563.5097465205267, 591.500182345917, 604.3050491934267, 615.7998650438603, 667.1194023888469, 719.5215181904027, 722.5014739829527, 724.0623392706432, 725.8169184229698, 730.1056206147454, 764.8202672371988, 770.4991755359006, 770.5030255485209, 772.4052479590712, 774.6204359863655, 604.0697326117752, 647.4173244080318, 647.7959442775534, 663.9973639803931, 762.6949220311864, 461.81989024280557, 463.19173043039774, 464.846600621794, 464.8582182434356, 466.0934482431672, 12207.877921220763, 12319.322437265946, 12352.0, 12364.814527782091, 12366.44351004207, 12608.0, 12636.0, 12787.808182877265, 12825.23048617086, 13001.804972925414, 12055.33695646739, 12072.879271207263, 12284.570040048644, 12391.814122788166, 12454.190477618926, 4131.35963925592, 4163.958360416417, 4169.332906734908, 4173.5409104998425, 4226.070264541796, 60564.69717651427, 61269.85555505536, 61610.075848862754, 61674.69162654158, 64486.0, 10075.3954762713, 10190.235732319958, 10253.692389228187, 10352.5341359639, 10682.038616524394, 16782.909110907753, 16793.664126717642, 16794.16029198535, 16803.07583082942, 16810.243539040774, 7417.703291868264, 7485.550866947891, 7627.54234745917, 7737.264959828807, 7806.804829879298, 4401.361802538614, 4449.777511124431, 4455.153520831096, 4514.300283456069, 4685.390899183084, 3360.56312679355, 3460.463628137643, 3462.5325581046236, 3462.8441720122655, 3462.913427164341, 619.0775744141287, 631.9462845658171, 643.810076027573, 644.7517705683252, 646.8027251688186, 564.94350564944, 610.4414460768347, 636.0649844728242, 645.2128403347908, 645.8449972006684, 9025.41334813235, 9063.536869212025, 9274.443533387883, 9280.7679808004, 9292.210162136294, 527.8390091022198, 610.5420934299276, 615.7536985205953, 630.5460068750492, 631.9715612797435, 4338.197433474817, 4481.641468682497, 4526.909461810746, 4534.750588717587, 4542.523035081335, 51810.481895180565, 57145.714271429206, 92268.0, 93037.0, 94301.5284923571, 53428.465715343125, 58233.0, 76286.6185669068, 79897.60051199707, 83462.58268708618, 73425.22736022141, 74034.0, 74058.25941740513, 75838.24161758312, 76161.0, 8692.0, 8740.169683880022, 8801.515916624647, 8806.691765788166, 8916.15296546827, 50914.745426274116, 51214.0, 51326.230106547686, 52141.21788173256, 52712.47287527076, 63241.0, 69602.0, 72026.27973720196, 72032.0, 73448.26551734415, 9928.404295742279, 9948.303618746619, 10020.298579099393, 10262.486875656337, 10334.586616535255, 11201.327920324806, 11283.097352211968, 11471.0, 11491.080713543064, 11502.827457587975, 9747.756306092404, 9801.166900813225, 9918.256130790363, 9969.252306076929, 10114.8482772757, 10457.163426925676, 10562.102221311274, 10580.4709764513, 10733.892661073289, 10764.46177691128, 10601.363918164934, 10635.202359823199, 10639.8936010642, 10716.464176791285, 11463.254888432559, 8605.053444121268, 8700.086490918362, 8731.825363492822, 8795.868061978947, 9069.410488318239, 9109.316801239802, 10236.283460158016, 10425.895741042492, 10721.30311529748, 11048.723781905517], "value": 6512.430129236179, "unit": "score"}], "name": "dromaeo_css", "value": 6891.234255183737, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 110.0, 112.0, 111.0, 110.0, 109.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 126.0, 158.0, 126.0, 122.0, 120.0, 120.0, 149.0, 122.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 122.0, 77.0, 76.0, 77.0, 82.0, 96.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 111.0, 81.0, 82.0, 82.0, 109.0, 82.0, 82.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 86.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 48.0, 50.0, 49.0, 57.0, 51.0, 50.0, 50.0, 56.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 62.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0, 73.0, 74.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 128.0, 130.0, 134.0, 132.0, 124.0, 123.0, 171.0, 125.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 153.0, 156.0, 158.0, 158.0, 155.0, 160.0, 154.0, 156.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1456.6, "alertThreshold": 2.0}]} 12:15:02 INFO - Return code: 0 12:15:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:02 ERROR - # TBPL SUCCESS # 12:15:02 INFO - Running post-action listener: _resource_record_post_action 12:15:02 INFO - [mozharness: 2016-11-14 20:15:02.152831Z] Finished run-tests step (success) 12:15:02 INFO - Running post-run listener: _resource_record_post_run 12:15:02 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 357302272; Read time: 0; Write time: 230352 12:15:02 INFO - TinderboxPrint: CPU usage
13.0% 12:15:02 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:15:02 INFO - TinderboxPrint: I/O write bytes / time
357,302,272 / 230,352 12:15:02 INFO - TinderboxPrint: CPU idle
8,271.9 (87.0%) 12:15:02 INFO - TinderboxPrint: CPU user
1,191.1 (12.5%) 12:15:02 INFO - TinderboxPrint: Swap in / out
0 / 0 12:15:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107282432; Read time: 0; Write time: 69868 12:15:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249475072; Read time: 0; Write time: 160484 12:15:02 INFO - Running post-run listener: _upload_blobber_files 12:15:02 INFO - Blob upload gear active. 12:15:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:02 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 12:15:02 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'] 12:15:02 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 12:15:03 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:03 INFO - (blobuploader) - INFO - Done attempting. 12:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:06 INFO - (blobuploader) - INFO - Done attempting. 12:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:07 INFO - (blobuploader) - INFO - Done attempting. 12:15:07 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:07 INFO - Return code: 0 12:15:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44c95ec7de405b533b8dfd22ebea5fdc783dd15757f8fc1e35abed89b0f0156db244495dcd9e588719a100342f0a847adbb0633ebaca59ebc47a67d482e32bf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a670581fe55b53588e02d32e346ede56b79083ad1d0cfe3e9debc89071afc523fb4b3e51e4b26840731911a7e512608e24c3e3b627f1b0aff6ba2b9f61f6c05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/961b54b78c972ed15f6e513a755739872a7157461f94c89f72e0e8f086b16d6d53734a3f93a018835464003a086377ee455969166656db30f812918e4dd79555"} 12:15:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:07 INFO - Contents: 12:15:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44c95ec7de405b533b8dfd22ebea5fdc783dd15757f8fc1e35abed89b0f0156db244495dcd9e588719a100342f0a847adbb0633ebaca59ebc47a67d482e32bf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a670581fe55b53588e02d32e346ede56b79083ad1d0cfe3e9debc89071afc523fb4b3e51e4b26840731911a7e512608e24c3e3b627f1b0aff6ba2b9f61f6c05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/961b54b78c972ed15f6e513a755739872a7157461f94c89f72e0e8f086b16d6d53734a3f93a018835464003a086377ee455969166656db30f812918e4dd79555"} 12:15:07 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:07 INFO - Copying logs to upload dir... 12:15:07 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.334186 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 12:15:07.261808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:07.265046) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482 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/44c95ec7de405b533b8dfd22ebea5fdc783dd15757f8fc1e35abed89b0f0156db244495dcd9e588719a100342f0a847adbb0633ebaca59ebc47a67d482e32bf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a670581fe55b53588e02d32e346ede56b79083ad1d0cfe3e9debc89071afc523fb4b3e51e4b26840731911a7e512608e24c3e3b627f1b0aff6ba2b9f61f6c05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/961b54b78c972ed15f6e513a755739872a7157461f94c89f72e0e8f086b16d6d53734a3f93a018835464003a086377ee455969166656db30f812918e4dd79555"} build_url:https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011887 build_url: 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/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/44c95ec7de405b533b8dfd22ebea5fdc783dd15757f8fc1e35abed89b0f0156db244495dcd9e588719a100342f0a847adbb0633ebaca59ebc47a67d482e32bf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a670581fe55b53588e02d32e346ede56b79083ad1d0cfe3e9debc89071afc523fb4b3e51e4b26840731911a7e512608e24c3e3b627f1b0aff6ba2b9f61f6c05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/961b54b78c972ed15f6e513a755739872a7157461f94c89f72e0e8f086b16d6d53734a3f93a018835464003a086377ee455969166656db30f812918e4dd79555"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:07.290943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:07.291306) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479153272.838355-676147482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:07.375503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:15:07.375859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:15:07.376170) ========= ========= Total master_lag: 0.17 =========