builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1479153335.67 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:35.672949) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:35.673443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:35.673761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:35.688981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:35.689378) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 11:55:35-- 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% 222M=0s 2016-11-14 11:55:36 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.348581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.051987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.052323) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024146 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.102670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.103042) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 11:55:36,217 truncating revision to first 12 chars 2016-11-14 11:55:36,218 Setting DEBUG logging. 2016-11-14 11:55:36,218 attempt 1/10 2016-11-14 11:55:36,218 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:55:36,587 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.877336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.877699) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.878114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.878406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:36.888434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-14 11:55:36.888897) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:55:37 INFO - MultiFileLogger online at 20161114 11:55:37 in /builds/slave/test 11:55:37 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:55:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:37 INFO - {'append_to_log': False, 11:55:37 INFO - 'base_work_dir': '/builds/slave/test', 11:55:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:55:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:37 INFO - 'branch': 'Mozilla-Aurora', 11:55:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:37 INFO - 'config_files': ('talos/linux_config.py',), 11:55:37 INFO - 'default_actions': ('clobber', 11:55:37 INFO - 'read-buildbot-config', 11:55:37 INFO - 'download-and-extract', 11:55:37 INFO - 'populate-webroot', 11:55:37 INFO - 'create-virtualenv', 11:55:37 INFO - 'install', 11:55:37 INFO - 'run-tests'), 11:55:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:37 INFO - 'download_minidump_stackwalk': True, 11:55:37 INFO - 'download_symbols': 'ondemand', 11:55:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:37 INFO - 'installer_path': 'installer.exe', 11:55:37 INFO - 'log_level': 'info', 11:55:37 INFO - 'log_name': 'talos', 11:55:37 INFO - 'log_to_console': True, 11:55:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:55:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:55:37 INFO - 'opt_config_files': (), 11:55:37 INFO - 'pip_index': False, 11:55:37 INFO - 'sps_profile': False, 11:55:37 INFO - 'sps_profile_interval': 0, 11:55:37 INFO - 'suite': 'dromaeojs', 11:55:37 INFO - 'system_bits': '32', 11:55:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:37 INFO - 'title': 'talos-linux64-ix-041', 11:55:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:37 INFO - 'use_talos_json': True, 11:55:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:37 INFO - 'work_dir': 'build'} 11:55:37 INFO - [mozharness: 2016-11-14 19:55:37.100545Z] Running clobber step. 11:55:37 INFO - Running pre-action listener: _resource_record_pre_action 11:55:37 INFO - Running main action method: clobber 11:55:37 INFO - rmtree: /builds/slave/test/build 11:55:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:37 INFO - Running post-action listener: _resource_record_post_action 11:55:37 INFO - [mozharness: 2016-11-14 19:55:37.545234Z] Finished clobber step (success) 11:55:37 INFO - [mozharness: 2016-11-14 19:55:37.545336Z] Running read-buildbot-config step. 11:55:37 INFO - Running pre-action listener: _resource_record_pre_action 11:55:37 INFO - Running main action method: read_buildbot_config 11:55:37 INFO - Using buildbot properties: 11:55:37 INFO - { 11:55:37 INFO - "project": "", 11:55:37 INFO - "product": "firefox", 11:55:37 INFO - "script_repo_revision": "production", 11:55:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:55:37 INFO - "repository": "", 11:55:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:55:37 INFO - "buildid": "20161114081542", 11:55:37 INFO - "pgo_build": "True", 11:55:37 INFO - "basedir": "/builds/slave/test", 11:55:37 INFO - "buildnumber": 903, 11:55:37 INFO - "slavename": "talos-linux64-ix-041", 11:55:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:55:37 INFO - "platform": "ubuntu64_hw", 11:55:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:55:37 INFO - "branch": "mozilla-aurora", 11:55:37 INFO - "repo_path": "releases/mozilla-aurora", 11:55:37 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:55:37 INFO - "stage_platform": "linux64-pgo", 11:55:37 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:55:37 INFO - "slavebuilddir": "test" 11:55:37 INFO - } 11:55:37 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:55:37 INFO - Running post-action listener: _resource_record_post_action 11:55:37 INFO - [mozharness: 2016-11-14 19:55:37.547778Z] Finished read-buildbot-config step (success) 11:55:37 INFO - [mozharness: 2016-11-14 19:55:37.547863Z] Running download-and-extract step. 11:55:37 INFO - Running pre-action listener: _resource_record_pre_action 11:55:37 INFO - Running main action method: download_and_extract 11:55:37 INFO - mkdir: /builds/slave/test/build/tests 11:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:37 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:55:37 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:55:37 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:55:38 INFO - Downloaded 1361 bytes. 11:55:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:38 INFO - Using the following test package requirements: 11:55:38 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:55:38 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:55:38 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:55:38 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'jsshell-linux-x86_64.zip'], 11:55:38 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:55:38 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:55:38 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:55:38 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:55:38 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:55:38 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:38 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:55:38 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:55:38 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:55:38 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:55:38 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:55:38 INFO - Http code: 200 11:55:38 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 11:55:38 INFO - x-amz-cf-id: 9LSG9eDbWS1hBWyH-KOtf3eRX9bTadifXbKSOhbHREAyqeJwcT-ONQ== 11:55:38 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:55:38 INFO - Expected file size: 21998930 11:55:39 INFO - Obtained file size: 21998930 11:55:43 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:55:43 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:55:43 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:55:43 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:55:43 INFO - Http code: 200 11:55:43 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 11:55:43 INFO - x-amz-cf-id: n9lgNG5VwglAZuMYvDRYZkN_oH4wO5XYVrqXK0zy2ienb9EzyCRimg== 11:55:43 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:55:43 INFO - Expected file size: 21998930 11:55:43 INFO - Obtained file size: 21998930 11:55:48 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:55:48 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:55:48 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:55:48 INFO - Http code: 200 11:55:48 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 11:55:48 INFO - x-amz-cf-id: UochWuMbrw59CoqtqEVfaN82TkGpGCWBYaqAAJFzVQIq9CrLirhTtg== 11:55:48 INFO - x-amz-version-id: TSlfhXB2os_hWn6_vAXqk2ibQDA0EcOh 11:55:49 INFO - Expected file size: 14409038 11:55:49 INFO - Obtained file size: 14409038 11:55:49 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:49 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:49 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:55:49 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:55:50 INFO - Downloaded 63942402 bytes. 11:55:50 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:55:50 INFO - mkdir: /builds/slave/test/properties 11:55:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:50 INFO - Contents: 11:55:50 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:55:51 INFO - Running post-action listener: _resource_record_post_action 11:55:51 INFO - Running post-action listener: set_extra_try_arguments 11:55:51 INFO - [mozharness: 2016-11-14 19:55:51.143099Z] Finished download-and-extract step (success) 11:55:51 INFO - [mozharness: 2016-11-14 19:55:51.143324Z] Running populate-webroot step. 11:55:51 INFO - Running pre-action listener: _resource_record_pre_action 11:55:51 INFO - Running main action method: populate_webroot 11:55:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:51 INFO - '--tppagecycles', 11:55:51 INFO - '7'], 11:55:51 INFO - 'tests': ['tsvgm']}}, 11:55:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['damp', 'tps']}, 11:55:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'tests': ['damp', 'tps']}, 11:55:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['dromaeo_dom']}, 11:55:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['basic_compositor_video']}, 11:55:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['a11yr', 11:55:51 INFO - 'ts_paint', 11:55:51 INFO - 'tpaint', 11:55:51 INFO - 'sessionrestore', 11:55:51 INFO - 'sessionrestore_no_auto_restore', 11:55:51 INFO - 'tabpaint']}, 11:55:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:51 INFO - 'ts_paint', 11:55:51 INFO - 'tpaint', 11:55:51 INFO - 'sessionrestore', 11:55:51 INFO - 'sessionrestore_no_auto_restore', 11:55:51 INFO - 'tabpaint']}, 11:55:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:51 INFO - 'ts_paint', 11:55:51 INFO - 'tpaint', 11:55:51 INFO - 'sessionrestore', 11:55:51 INFO - 'sessionrestore_no_auto_restore', 11:55:51 INFO - 'tabpaint']}, 11:55:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:51 INFO - 'ts_paint', 11:55:51 INFO - 'tpaint', 11:55:51 INFO - 'sessionrestore', 11:55:51 INFO - 'sessionrestore_no_auto_restore', 11:55:51 INFO - 'tabpaint']}, 11:55:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['a11yr', 11:55:51 INFO - 'ts_paint', 11:55:51 INFO - 'tpaint', 11:55:51 INFO - 'sessionrestore', 11:55:51 INFO - 'sessionrestore_no_auto_restore', 11:55:51 INFO - 'tabpaint']}, 11:55:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['a11yr', 11:55:51 INFO - 'ts_paint', 11:55:51 INFO - 'tpaint', 11:55:51 INFO - 'sessionrestore', 11:55:51 INFO - 'sessionrestore_no_auto_restore', 11:55:51 INFO - 'tabpaint']}, 11:55:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['tsvgx', 11:55:51 INFO - 'tsvgr_opacity', 11:55:51 INFO - 'tart', 11:55:51 INFO - 'tscrollx', 11:55:51 INFO - 'cart']}, 11:55:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:51 INFO - 'tsvgr_opacity', 11:55:51 INFO - 'tart', 11:55:51 INFO - 'tscrollx', 11:55:51 INFO - 'cart']}, 11:55:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'talos_options': ['--disable-e10s'], 11:55:51 INFO - 'tests': ['tp5o']}, 11:55:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'tests': ['tp5o']}, 11:55:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'talos_options': ['--disable-e10s', 11:55:51 INFO - '--xperf_path', 11:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:51 INFO - 'tests': ['tp5n']}, 11:55:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:51 INFO - 'talos_options': ['--xperf_path', 11:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:51 INFO - 'tests': ['tp5n']}}, 11:55:51 INFO - 'talos.zip': {'path': '', 11:55:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:51 INFO - Running post-action listener: _resource_record_post_action 11:55:51 INFO - [mozharness: 2016-11-14 19:55:51.160103Z] Finished populate-webroot step (success) 11:55:51 INFO - [mozharness: 2016-11-14 19:55:51.160189Z] Running create-virtualenv step. 11:55:51 INFO - Running pre-action listener: _resource_record_pre_action 11:55:51 INFO - Running main action method: create_virtualenv 11:55:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:51 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:55:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:51 INFO - Using real prefix '/usr' 11:55:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:53 INFO - Installing pip.................done. 11:55:53 INFO - Return code: 0 11:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:55:53 INFO - Reading from file tmpfile_stdout 11:55:53 INFO - Output received: 11:55:53 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:55:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:53 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:53 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:55:53 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:55:53 INFO - Using env: {'DISPLAY': ':0', 11:55:53 INFO - 'HOME': '/home/cltbld', 11:55:53 INFO - 'LANG': 'en_US.UTF-8', 11:55:53 INFO - 'LANGUAGE': 'en_US:en', 11:55:53 INFO - 'LOGNAME': 'cltbld', 11:55:53 INFO - 'MAIL': '/var/mail/cltbld', 11:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:53 INFO - 'MOZ_NO_REMOTE': '1', 11:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:53 INFO - 'NO_EM_RESTART': '1', 11:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:53 INFO - 'PWD': '/builds/slave/test', 11:55:53 INFO - 'SHELL': '/bin/bash', 11:55:53 INFO - 'SHLVL': '1', 11:55:53 INFO - 'TERM': 'linux', 11:55:53 INFO - 'TMOUT': '86400', 11:55:53 INFO - 'USER': 'cltbld', 11:55:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:53 INFO - '_': '/tools/buildbot/bin/python'} 11:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:54 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:55:54 INFO - Cleaning up... 11:55:54 INFO - Return code: 0 11:55:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55: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:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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', '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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:55: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 psutil>=3.1.1 11:55:54 INFO - Using env: {'DISPLAY': ':0', 11:55:54 INFO - 'HOME': '/home/cltbld', 11:55:54 INFO - 'LANG': 'en_US.UTF-8', 11:55:54 INFO - 'LANGUAGE': 'en_US:en', 11:55:54 INFO - 'LOGNAME': 'cltbld', 11:55:54 INFO - 'MAIL': '/var/mail/cltbld', 11:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:54 INFO - 'MOZ_NO_REMOTE': '1', 11:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:54 INFO - 'NO_EM_RESTART': '1', 11:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:54 INFO - 'PWD': '/builds/slave/test', 11:55:54 INFO - 'SHELL': '/bin/bash', 11:55:54 INFO - 'SHLVL': '1', 11:55:54 INFO - 'TERM': 'linux', 11:55:54 INFO - 'TMOUT': '86400', 11:55:54 INFO - 'USER': 'cltbld', 11:55:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:54 INFO - '_': '/tools/buildbot/bin/python'} 11:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:54 INFO - Downloading/unpacking psutil>=3.1.1 11:55: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:55: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:55: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:55: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:55: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:55: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:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:56 INFO - Installing collected packages: psutil 11:55:56 INFO - Running setup.py install for psutil 11:55:56 INFO - building 'psutil._psutil_linux' extension 11:55:56 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:55:56 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:55:56 INFO - building 'psutil._psutil_posix' extension 11:55:56 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:55:56 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:55:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:56 INFO - Successfully installed psutil 11:55:56 INFO - Cleaning up... 11:55:57 INFO - Return code: 0 11:55:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:57 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:57 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:55:57 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:55:57 INFO - Using env: {'DISPLAY': ':0', 11:55:57 INFO - 'HOME': '/home/cltbld', 11:55:57 INFO - 'LANG': 'en_US.UTF-8', 11:55:57 INFO - 'LANGUAGE': 'en_US:en', 11:55:57 INFO - 'LOGNAME': 'cltbld', 11:55:57 INFO - 'MAIL': '/var/mail/cltbld', 11:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:57 INFO - 'MOZ_NO_REMOTE': '1', 11:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:57 INFO - 'NO_EM_RESTART': '1', 11:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:57 INFO - 'PWD': '/builds/slave/test', 11:55:57 INFO - 'SHELL': '/bin/bash', 11:55:57 INFO - 'SHLVL': '1', 11:55:57 INFO - 'TERM': 'linux', 11:55:57 INFO - 'TMOUT': '86400', 11:55:57 INFO - 'USER': 'cltbld', 11:55:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:57 INFO - '_': '/tools/buildbot/bin/python'} 11:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55: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:55: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:55: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:55: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:55: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:55: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:55:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:59 INFO - Installing collected packages: mozsystemmonitor 11:55:59 INFO - Running setup.py install for mozsystemmonitor 11:55:59 INFO - Successfully installed mozsystemmonitor 11:55:59 INFO - Cleaning up... 11:55:59 INFO - Return code: 0 11:55:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55: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:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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', '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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:55: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 jsonschema==2.5.1 11:55:59 INFO - Using env: {'DISPLAY': ':0', 11:55:59 INFO - 'HOME': '/home/cltbld', 11:55:59 INFO - 'LANG': 'en_US.UTF-8', 11:55:59 INFO - 'LANGUAGE': 'en_US:en', 11:55:59 INFO - 'LOGNAME': 'cltbld', 11:55:59 INFO - 'MAIL': '/var/mail/cltbld', 11:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:59 INFO - 'MOZ_NO_REMOTE': '1', 11:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:59 INFO - 'NO_EM_RESTART': '1', 11:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:59 INFO - 'PWD': '/builds/slave/test', 11:55:59 INFO - 'SHELL': '/bin/bash', 11:55:59 INFO - 'SHLVL': '1', 11:55:59 INFO - 'TERM': 'linux', 11:55:59 INFO - 'TMOUT': '86400', 11:55:59 INFO - 'USER': 'cltbld', 11:55:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:59 INFO - '_': '/tools/buildbot/bin/python'} 11:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:55: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:55: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:55: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:55: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:55: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:55: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:56:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:56:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:56:01 INFO - warning: no files found matching '*.txt' 11:56:01 INFO - no previously-included directories found matching 'build' 11:56:01 INFO - no previously-included directories found matching 'dist' 11:56:01 INFO - no previously-included directories found matching '.git*' 11:56:01 INFO - Installing collected packages: jsonschema, functools32 11:56:01 INFO - Running setup.py install for functools32 11:56:01 INFO - warning: no files found matching '*.txt' 11:56:01 INFO - no previously-included directories found matching 'build' 11:56:01 INFO - no previously-included directories found matching 'dist' 11:56:01 INFO - no previously-included directories found matching '.git*' 11:56:01 INFO - Successfully installed jsonschema functools32 11:56:01 INFO - Cleaning up... 11:56:02 INFO - Return code: 0 11:56:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:56:02 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:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:02 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:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:02 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:56:02 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:56:02 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:56:02 INFO - Using env: {'DISPLAY': ':0', 11:56:02 INFO - 'HOME': '/home/cltbld', 11:56:02 INFO - 'LANG': 'en_US.UTF-8', 11:56:02 INFO - 'LANGUAGE': 'en_US:en', 11:56:02 INFO - 'LOGNAME': 'cltbld', 11:56:02 INFO - 'MAIL': '/var/mail/cltbld', 11:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:02 INFO - 'MOZ_NO_REMOTE': '1', 11:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:02 INFO - 'NO_EM_RESTART': '1', 11:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:02 INFO - 'PWD': '/builds/slave/test', 11:56:02 INFO - 'SHELL': '/bin/bash', 11:56:02 INFO - 'SHLVL': '1', 11:56:02 INFO - 'TERM': 'linux', 11:56:02 INFO - 'TMOUT': '86400', 11:56:02 INFO - 'USER': 'cltbld', 11:56:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:02 INFO - '_': '/tools/buildbot/bin/python'} 11:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:56:02 INFO - Cleaning up... 11:56:02 INFO - Return code: 0 11:56:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:56:02 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:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:02 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:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:02 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:56:02 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:56:02 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:56:02 INFO - Using env: {'DISPLAY': ':0', 11:56:02 INFO - 'HOME': '/home/cltbld', 11:56:02 INFO - 'LANG': 'en_US.UTF-8', 11:56:02 INFO - 'LANGUAGE': 'en_US:en', 11:56:02 INFO - 'LOGNAME': 'cltbld', 11:56:02 INFO - 'MAIL': '/var/mail/cltbld', 11:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:02 INFO - 'MOZ_NO_REMOTE': '1', 11:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:02 INFO - 'NO_EM_RESTART': '1', 11:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:02 INFO - 'PWD': '/builds/slave/test', 11:56:02 INFO - 'SHELL': '/bin/bash', 11:56:02 INFO - 'SHLVL': '1', 11:56:02 INFO - 'TERM': 'linux', 11:56:02 INFO - 'TMOUT': '86400', 11:56:02 INFO - 'USER': 'cltbld', 11:56:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:02 INFO - '_': '/tools/buildbot/bin/python'} 11:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:56: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:56: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:56: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:56: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:56: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:56: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:56:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:56:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:56:04 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:56:04 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:56:04 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:56:04 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:56:04 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:56:04 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:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:56:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:56:04 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:56:04 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:56:04 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:56:04 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:56:04 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:56:04 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:56:05 INFO - Downloading docopt-0.6.1.tar.gz 11:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:56:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:56:05 INFO - Running setup.py install for blobuploader 11:56:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:56:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:56:05 INFO - Running setup.py install for requests 11:56:05 INFO - Running setup.py install for docopt 11:56:05 INFO - Successfully installed blobuploader requests docopt 11:56:05 INFO - Cleaning up... 11:56:05 INFO - Return code: 0 11:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:05 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:56:05 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:56:05 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:56:05 INFO - Using env: {'DISPLAY': ':0', 11:56:05 INFO - 'HOME': '/home/cltbld', 11:56:05 INFO - 'LANG': 'en_US.UTF-8', 11:56:05 INFO - 'LANGUAGE': 'en_US:en', 11:56:05 INFO - 'LOGNAME': 'cltbld', 11:56:05 INFO - 'MAIL': '/var/mail/cltbld', 11:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:05 INFO - 'MOZ_NO_REMOTE': '1', 11:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:05 INFO - 'NO_EM_RESTART': '1', 11:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:05 INFO - 'PWD': '/builds/slave/test', 11:56:05 INFO - 'SHELL': '/bin/bash', 11:56:05 INFO - 'SHLVL': '1', 11:56:05 INFO - 'TERM': 'linux', 11:56:05 INFO - 'TMOUT': '86400', 11:56:05 INFO - 'USER': 'cltbld', 11:56:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:05 INFO - '_': '/tools/buildbot/bin/python'} 11:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:56:06 INFO - Running setup.py (path:/tmp/pip-FsgV7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:56:06 INFO - Running setup.py (path:/tmp/pip-hHde_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:56:06 INFO - Running setup.py (path:/tmp/pip-CPJgpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:56:06 INFO - Running setup.py (path:/tmp/pip-ziBGO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:56:06 INFO - Running setup.py (path:/tmp/pip-iYReno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:56:06 INFO - Running setup.py (path:/tmp/pip-OIYu9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:56:06 INFO - Running setup.py (path:/tmp/pip-zn4yhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:56:06 INFO - Running setup.py (path:/tmp/pip-7FR_oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:56:06 INFO - Running setup.py (path:/tmp/pip-iDyW0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:56:06 INFO - Running setup.py (path:/tmp/pip-e3W3Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:56:06 INFO - Running setup.py (path:/tmp/pip-SIhGOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:56:06 INFO - Running setup.py (path:/tmp/pip-1_TLN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:56:06 INFO - Running setup.py (path:/tmp/pip-ovk2Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:56:06 INFO - Running setup.py (path:/tmp/pip-QzEzx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:07 INFO - Running setup.py (path:/tmp/pip-aqDpK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:56:07 INFO - Running setup.py (path:/tmp/pip-Mlhw9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:56:07 INFO - Running setup.py (path:/tmp/pip-VKDz9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:56:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:56:07 INFO - Running setup.py install for manifestparser 11:56:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:56:07 INFO - Running setup.py install for mozcrash 11:56:07 INFO - Running setup.py install for mozdebug 11:56:07 INFO - Running setup.py install for mozdevice 11:56:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:56:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:56:07 INFO - Running setup.py install for mozfile 11:56:07 INFO - Running setup.py install for mozhttpd 11:56:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:56:07 INFO - Running setup.py install for mozinfo 11:56:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:56:07 INFO - Running setup.py install for mozInstall 11:56:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Running setup.py install for mozleak 11:56:08 INFO - Running setup.py install for mozlog 11:56:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Running setup.py install for moznetwork 11:56:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Running setup.py install for mozprocess 11:56:08 INFO - Running setup.py install for mozprofile 11:56:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Running setup.py install for mozrunner 11:56:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:56:08 INFO - Running setup.py install for mozscreenshot 11:56:08 INFO - Running setup.py install for moztest 11:56:08 INFO - Running setup.py install for mozversion 11:56:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:56:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:56:09 INFO - Cleaning up... 11:56:09 INFO - Return code: 0 11:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:09 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:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:09 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:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:09 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:56:09 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:56:09 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:56:09 INFO - Using env: {'DISPLAY': ':0', 11:56:09 INFO - 'HOME': '/home/cltbld', 11:56:09 INFO - 'LANG': 'en_US.UTF-8', 11:56:09 INFO - 'LANGUAGE': 'en_US:en', 11:56:09 INFO - 'LOGNAME': 'cltbld', 11:56:09 INFO - 'MAIL': '/var/mail/cltbld', 11:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:09 INFO - 'MOZ_NO_REMOTE': '1', 11:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:09 INFO - 'NO_EM_RESTART': '1', 11:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:09 INFO - 'PWD': '/builds/slave/test', 11:56:09 INFO - 'SHELL': '/bin/bash', 11:56:09 INFO - 'SHLVL': '1', 11:56:09 INFO - 'TERM': 'linux', 11:56:09 INFO - 'TMOUT': '86400', 11:56:09 INFO - 'USER': 'cltbld', 11:56:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:09 INFO - '_': '/tools/buildbot/bin/python'} 11:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:56:09 INFO - Running setup.py (path:/tmp/pip-f6qRoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:56:09 INFO - Running setup.py (path:/tmp/pip-IH3vto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:56:09 INFO - Running setup.py (path:/tmp/pip-xknlZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:56:09 INFO - Running setup.py (path:/tmp/pip-Fs0yoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:56:09 INFO - Running setup.py (path:/tmp/pip-YKAmvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:56:09 INFO - Running setup.py (path:/tmp/pip-7U2M5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:56:09 INFO - Running setup.py (path:/tmp/pip-b6aaPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:56:09 INFO - Running setup.py (path:/tmp/pip-0YnNAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:56:09 INFO - Running setup.py (path:/tmp/pip-CKZNPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:56:09 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:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:56:09 INFO - Running setup.py (path:/tmp/pip-1eLmQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:56:10 INFO - Running setup.py (path:/tmp/pip-_QvwFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:56:10 INFO - Running setup.py (path:/tmp/pip-JfQQVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:56:10 INFO - Running setup.py (path:/tmp/pip-tO_VCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:56:10 INFO - Running setup.py (path:/tmp/pip-4eb7FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:10 INFO - Running setup.py (path:/tmp/pip-DQIADm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:56:10 INFO - Running setup.py (path:/tmp/pip-7e2XxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:56:10 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:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:56:10 INFO - Running setup.py (path:/tmp/pip-KU3g_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:56:10 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:56:10 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:56:10 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:56:10 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:56:10 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:56:10 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:56:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:12 INFO - Downloading blessings-1.6.tar.gz 11:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:56:12 INFO - Installing collected packages: blessings 11:56:12 INFO - Running setup.py install for blessings 11:56:12 INFO - Successfully installed blessings 11:56:12 INFO - Cleaning up... 11:56:12 INFO - Return code: 0 11:56:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:12 INFO - Reading from file tmpfile_stdout 11:56:12 INFO - Current package versions: 11:56:12 INFO - argparse == 1.2.1 11:56:12 INFO - blessings == 1.6 11:56:12 INFO - blobuploader == 1.2.4 11:56:12 INFO - docopt == 0.6.1 11:56:12 INFO - functools32 == 3.2.3-2 11:56:12 INFO - jsonschema == 2.5.1 11:56:12 INFO - manifestparser == 1.1 11:56:12 INFO - mozInstall == 1.12 11:56:12 INFO - mozcrash == 1.0 11:56:12 INFO - mozdebug == 0.1 11:56:12 INFO - mozdevice == 0.48 11:56:12 INFO - mozfile == 1.2 11:56:12 INFO - mozhttpd == 0.7 11:56:12 INFO - mozinfo == 0.9 11:56:12 INFO - mozleak == 0.1 11:56:12 INFO - mozlog == 3.4 11:56:12 INFO - moznetwork == 0.27 11:56:12 INFO - mozprocess == 0.23 11:56:12 INFO - mozprofile == 0.28 11:56:12 INFO - mozrunner == 6.13 11:56:12 INFO - mozscreenshot == 0.1 11:56:12 INFO - mozsystemmonitor == 0.3 11:56:12 INFO - moztest == 0.7 11:56:12 INFO - mozversion == 1.4 11:56:12 INFO - psutil == 3.1.1 11:56:12 INFO - requests == 1.2.3 11:56:12 INFO - wsgiref == 0.1.2 11:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:12 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 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:56:12 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:56:12 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:56:12 INFO - Using env: {'DISPLAY': ':0', 11:56:12 INFO - 'HOME': '/home/cltbld', 11:56:12 INFO - 'LANG': 'en_US.UTF-8', 11:56:12 INFO - 'LANGUAGE': 'en_US:en', 11:56:12 INFO - 'LOGNAME': 'cltbld', 11:56:12 INFO - 'MAIL': '/var/mail/cltbld', 11:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:12 INFO - 'MOZ_NO_REMOTE': '1', 11:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:12 INFO - 'NO_EM_RESTART': '1', 11:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:12 INFO - 'PWD': '/builds/slave/test', 11:56:12 INFO - 'SHELL': '/bin/bash', 11:56:12 INFO - 'SHLVL': '1', 11:56:12 INFO - 'TERM': 'linux', 11:56:12 INFO - 'TMOUT': '86400', 11:56:12 INFO - 'USER': 'cltbld', 11:56:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:12 INFO - '_': '/tools/buildbot/bin/python'} 11:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 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:56:13 INFO - Cleaning up... 11:56:13 INFO - Return code: 0 11:56:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00b74cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', '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:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:56:13 INFO - Using env: {'DISPLAY': ':0', 11:56:13 INFO - 'HOME': '/home/cltbld', 11:56:13 INFO - 'LANG': 'en_US.UTF-8', 11:56:13 INFO - 'LANGUAGE': 'en_US:en', 11:56:13 INFO - 'LOGNAME': 'cltbld', 11:56:13 INFO - 'MAIL': '/var/mail/cltbld', 11:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:13 INFO - 'MOZ_NO_REMOTE': '1', 11:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:13 INFO - 'NO_EM_RESTART': '1', 11:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:13 INFO - 'PWD': '/builds/slave/test', 11:56:13 INFO - 'SHELL': '/bin/bash', 11:56:13 INFO - 'SHLVL': '1', 11:56:13 INFO - 'TERM': 'linux', 11:56:13 INFO - 'TMOUT': '86400', 11:56:13 INFO - 'USER': 'cltbld', 11:56:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:13 INFO - '_': '/tools/buildbot/bin/python'} 11:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:56:13 INFO - Cleaning up... 11:56:13 INFO - Return code: 0 11:56:13 INFO - Running post-action listener: _resource_record_post_action 11:56:13 INFO - Running post-action listener: _start_resource_monitoring 11:56:13 INFO - Starting resource monitoring. 11:56:13 INFO - [mozharness: 2016-11-14 19:56:13.413218Z] Finished create-virtualenv step (success) 11:56:13 INFO - [mozharness: 2016-11-14 19:56:13.413716Z] Running install step. 11:56:13 INFO - Running pre-action listener: _resource_record_pre_action 11:56:13 INFO - Running main action method: install 11:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:13 INFO - Reading from file tmpfile_stdout 11:56:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:56:13 INFO - Reading from file tmpfile_stdout 11:56:13 INFO - Output received: 11:56:13 INFO - Usage: mozinstall [options] installer 11:56:13 INFO - Options: 11:56:13 INFO - -h, --help show this help message and exit 11:56:13 INFO - -d DEST, --destination=DEST 11:56:13 INFO - Directory to install application into. [default: 11:56:13 INFO - "/builds/slave/test"] 11:56:13 INFO - --app=APP Application being installed. [default: firefox] 11:56:13 INFO - mkdir: /builds/slave/test/build/application 11:56:13 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:56:13 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:56:29 INFO - Reading from file tmpfile_stdout 11:56:29 INFO - Output received: 11:56:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:56:29 INFO - Running post-action listener: _resource_record_post_action 11:56:29 INFO - [mozharness: 2016-11-14 19:56:29.620847Z] Finished install step (success) 11:56:29 INFO - [mozharness: 2016-11-14 19:56:29.621139Z] Running run-tests step. 11:56:29 INFO - Running pre-action listener: _resource_record_pre_action 11:56:29 INFO - Running main action method: run_tests 11:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:29 INFO - Python 2.7.3 11:56:29 INFO - Return code: 0 11:56:29 INFO - grabbing minidump binary from tooltool 11:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:29 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 0x2218f60>, '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 0x2219d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x221a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:29 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:56:29 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:56:29 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:56:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:29 INFO - Return code: 0 11:56:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:56:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:56:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:29 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-041', '--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:56:29 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-041 --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:56:29 INFO - Using env: {'DISPLAY': ':0', 11:56:29 INFO - 'HOME': '/home/cltbld', 11:56:29 INFO - 'LANG': 'en_US.UTF-8', 11:56:29 INFO - 'LANGUAGE': 'en_US:en', 11:56:29 INFO - 'LOGNAME': 'cltbld', 11:56:29 INFO - 'MAIL': '/var/mail/cltbld', 11:56:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:29 INFO - 'MOZ_NO_REMOTE': '1', 11:56:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:29 INFO - 'NO_EM_RESTART': '1', 11:56:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:29 INFO - 'PWD': '/builds/slave/test', 11:56:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:29 INFO - 'SHELL': '/bin/bash', 11:56:29 INFO - 'SHLVL': '1', 11:56:29 INFO - 'TERM': 'linux', 11:56:29 INFO - 'TMOUT': '86400', 11:56:29 INFO - 'USER': 'cltbld', 11:56:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562', 11:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:29 INFO - '_': '/tools/buildbot/bin/python'} 11:56:29 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-041', '--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:56:29 INFO - mozversion application_buildid: 20161114081542 11:56:29 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:56:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:56:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:29 INFO - mozversion application_name: Firefox 11:56:29 INFO - mozversion application_remotingname: firefox-dev 11:56:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:56:29 INFO - mozversion application_vendor: Mozilla 11:56:29 INFO - mozversion application_version: 52.0a2 11:56:29 INFO - mozversion platform_buildid: 20161114081542 11:56:29 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:56:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:56:29 INFO - mozversion platform_version: 52.0a2 11:56:29 INFO - using testdate: 1479153389 11:56:29 INFO - actual date: 1479153389 11:56:29 INFO - starting webserver on 'localhost:56228' 11:56:29 INFO - SUITE-START | Running 2 tests 11:56:29 INFO - TEST-START | dromaeo_css 11:56:29 INFO - operating with platform_type : linux_ 11:56:29 INFO - Initialising browser for dromaeo_css test... 11:56:29 INFO - TEST-INFO | started process 22576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJ35P8/profile http://localhost:56228/getInfo.html) 11:56:32 ERROR - PROCESS | 22576 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:56:33 INFO - PROCESS | 22576 | __metrics Screen width/height:1600/1200 11:56:33 INFO - PROCESS | 22576 | colorDepth:24 11:56:33 INFO - PROCESS | 22576 | Browser inner width/height: 1024/697 11:56:33 INFO - PROCESS | 22576 | __metrics 11:56:34 INFO - PROCESS | 22576 | 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:56:34 INFO - PROCESS | 22576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:34 INFO - PROCESS | 22576 | console.error: PushService: 11:56:34 INFO - PROCESS | 22576 | stateChangeProcessEnqueue: Error transitioning state 11:56:34 INFO - PROCESS | 22576 | UnknownError 11:56:35 INFO - TEST-INFO | 22576: exit 0 11:56:35 INFO - Browser initialized. 11:56:35 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:35 INFO - TEST-INFO | started process 22669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeJ35P8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:47 INFO - PROCESS | 22669 | RSS: Main: 144572416 11:56:47 INFO - PROCESS | 22669 | 11:57:39 INFO - PROCESS | 22669 | 1479153459003 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:59:49 INFO - PROCESS | 22669 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56228/tests/dromaeo/cssquery-ext.html) 11:59:50 INFO - PROCESS | 22669 | RSS: Main: 269086720 11:59:50 INFO - PROCESS | 22669 | 12:02:52 INFO - PROCESS | 22669 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-ext.html (next: http://localhost:56228/tests/dromaeo/cssquery-jquery.html) 12:02:53 INFO - PROCESS | 22669 | RSS: Main: 224972800 12:02:53 INFO - PROCESS | 22669 | 12:05:55 INFO - PROCESS | 22669 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56228/tests/dromaeo/cssquery-mootools.html) 12:05:56 INFO - PROCESS | 22669 | RSS: Main: 173408256 12:05:56 INFO - PROCESS | 22669 | 12:08:58 INFO - PROCESS | 22669 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56228/tests/dromaeo/cssquery-prototype.html) 12:08:58 INFO - PROCESS | 22669 | RSS: Main: 225062912 12:08:58 INFO - PROCESS | 22669 | 12:12:01 INFO - PROCESS | 22669 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56228/tests/dromaeo/cssquery-yui.html) 12:12:01 INFO - PROCESS | 22669 | RSS: Main: 176275456 12:12:01 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-yui.html (next: http://localhost:56228/tests/dromaeo/cssquery-dojo.html) 12:15:04 INFO - PROCESS | 22669 | RSS: Main: 270184448 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | __start_tp_report 12:15:04 INFO - PROCESS | 22669 | _x_x_mozilla_page_load 12:15:04 INFO - PROCESS | 22669 | _x_x_mozilla_page_load_details 12:15:04 INFO - PROCESS | 22669 | |i|pagename|runs| 12:15:04 INFO - PROCESS | 22669 | |0;dojo.html;3211.4861622140456;3216.2763378239893;3248.0255923223026;3267.754918381119;3288.375208710345;5566.415526369734;5663.0655941769555;5665.433456654332;5677.148427735837;5685.976524225638;5531.2809334786425;5570.749316280767;5581.274434323543;5603.159526071091;5619.7471113799875;5027.824026159085;5064.442911279756;5088.847334579968;5091.803426194841;5132.589392848582;4987.426445958725;5003.1994880819075;5144.6655967362185;5157.252198431225;5160.406553246387;4981.1283025470575;4996.275540046691;5001.14980453322;5095.184770436731;5097.898042039157;5112.079825631385;5130.563902068328;5170.37955445349;5186.118359878792;5210.843674689765;4824.300476430933;5040;5078.4413714491375;5111.616628752859;5127.820526281562;5400.540954018913;5469.781208751645;5487.396386397493;5503.559715222773;5524.364698059734;5927.496162826165;5931.555133365015;6027.819165425044;6033.909491357633;6035.30593981689;5885.058390657474;6079.422454866781;6093.573449858512;6114.2357205349335;6119.724612392453;5492.80775172867;5493.615446918678;5563.721813909328;5569.081101618269;5574.832755017356;6151.876962460726;6159.23009623797;6168.259808822881;6171.84570385744;6184.721687524072;5841.707914604252;5863.912041319383;5878.706064696748;5882.941170588325;5894.115882617642;5824.184614154022;5859.44335288147;5875.265591801025;5925.081612350093;5926.051831706906;5917.615355001911;5922.378150294157;5923.792667256712;5936.287645482484;5951.642901425928;5909.468147866713;5938.435848594463;5973.761049558056;5974.3726908674835;5992.550558708114;4520.2315606347;4534.070515544306;4543.841320463261;4555.430571178603;4593.655475839326;4025.81883815229;4060.614241647098;4070.9592904070582;4089.8773036808943;4113.670906327547;5606.046972014768;5621.578381621313;5668.376478587352;5671.829845104653;5676.375598684142;5875.853103672443;5908.379620139909;5913.379095195029;5995.610285331527;5998.700064996733;5635.971820140873;5670.121131224667;5690.687012214368;5691.573132015115;5702.8289151325525;5109.3613298337705;5136.897262054813;5139.357580302462;5143.485651434827;5143.819966301162;6153.29237137726;6271.96864015677;6294.748210071546;6303.401176888188;6304.936950630527;6026.789062382795;6040.909386359121;6077.709570594414;6101.237345331833;6137.907931380943;6066.3630318815885;6274.278457977391;6310.274318453253;6313.96843015782;6320.968395157995;5796.362400135898;5811.622244554091;5819.447152520504;5833;5915.438033386821;5953.434423729739;5960.344362120077;5960.927033134078;5970.731317090655;5973.581849270509;5685.943140568706;5828.271466066742;5871.295444546682;5873.50075243592;5884.382139875252;5728.770849165987;5786.161006654096;5825.446582574818;5874.911876321773;5966.850828729316;5854.356020837619;5860.413958604106;5871.1486834409625;5875.41245875409;5878.2064421302575;5966.820995370146;5981.581289309881;5987.131865879336;5992.250968628921;6000.789972350947;5642.802501912578;5694.345150307768;5708.115242137475;5756.366799651951;5766.106253530709 12:15:04 INFO - PROCESS | 22669 | |1;ext.html;572.6192082265294;617.8887800195964;638.208621309576;642.5084810120256;649.0199798304559;33485;43883.78058109709;44450.33324500135;44539.554604453944;44594.554054459484;45532;45774;45902;45906;45990.77004614972;8590.828183436328;8722.12778722129;8734.694285700001;8735.737927862174;8742.519161446118;8385.371097167706;8464.619092140869;8471.745847624581;8474.915250847505;8476.66093356265;8834.160754728291;8853.95573022134;8854.557272136399;8859.424137431046;8860.778480537974;8741.431806932529;8775.736727898173;8821.161989610944;8822.602982865787;8826.86759698605;8490.745277641681;8516.914830851674;8543.57282135897;8547.059823419419;8554.52950087745;42618.78690606558;42730.78634606838;42945.78527107376;43013.35479967803;43114.137717245794;3339.1819004344093;3573.678368946781;3727.478153058547;3877.941830872539;3939.0546268895546;31822.681773182434;31824.84087579547;32023;32099.197520062186;32662.510062349083;4189.706720529533;4401.757903315316;4406.603405693503;4410.319349028883;4442.711223770477;333417.3329133363;334001;337237;337885;338642;63958.36041639617;64573.677131614044;64668.353316467175;64677;64697.67651161714;39652.40521392181;40257;40554.18891622151;41649.79175104105;66791.3320866785;18834.434966951012;18967.33614323492;19028.048597570065;19036.42890713281;19046.523836904187;14048.719025619635;14110.153390796586;14120.152790832582;14151.50469733575;14164.150150990974;19530.804691953184;19931.402057938285;19998.50003749918;20051.097700603506;20063.598728025358;6768.796936091925;6882.655867206619;6894.310893831043;6938.548994315353;6953.33943275388;956.268454632207;962.5379817687549;1046.2048842879467;1050.2648146297622;1053.8155822730992;31839.68160318367;32069.679303207136;32314.83842580772;32353.676463235537;32446.83776581102;976.2190247801731;986.2356673578034;1094.950727217277;1101.4547798839626;1103.5199688135688;15039.924800376148;16901;16945.406910758065;17051.14744262782;17087.487375378758;477008;480013;481019;481337;482254;60104;60784;60939.39060609337;60974.085388719206;60989.08516372258;1239.5413696932012;1334.3528388731459;1335.9732805343838;1392.721455708842;1411.4495346814545;30232.107837053376;34521.82739086288;34585;34864.825675871456;34878.82560587181;55995;56489;56493.43506564882;56534.15198771939;56571;449656;451318;451652;452187;452303;23179;29542.704572953997;30504.694953050184;30761.384772304875;31454.370912581162;45620.315695265264;46441.53558464372;46471.302930456746;49280.75359623179;49596.504034960635;40974;41169.79415103025;44322;44698.25575046421;45430.545694542634;41891;42482.78758606311;42561.574384255764;43408.34887476754;43565.78217108894;42509.57490425056;43183;43391.34912976245;43410;43455.782721086194;35610;36638.084047899014;36709.81645091758;37899.242015160096;38338.42492362561;28754.281142970754;28785.712142878303;28815.279618009718;29037;29131.41737165287 12:15:04 INFO - PROCESS | 22669 | |2;jquery.html;405.6977551723966;417.24686940073195;425.3874420833998;430.2041223736088;430.27283890225516;15448.69102617947;17706.557336066606;17751.37870174544;17814.910925445387;18045.278188872428;18395.632087358244;18636;18683.813161868376;18914.432567022977;19069.427917162473;5160.4323524412475;5263.578913686915;5557.277553917985;5785.479306862381;5786.768529258846;5651.32184137902;5786.421357864222;5790.797322093727;5792.82621521355;5794;5574.331080270374;5675.4608312210485;5699.088145896658;5759.452851979056;5768.625039372428;5608.6073974821775;5635.887282254353;5674.205611214413;5676.517496012844;5680.460356266148;5011.599072074226;5071.771770270347;5140.280360749498;5193.195054766479;5197.298364720752;22740.317790466313;23123.421914452105;23134.53730925389;23346;23443.531129377316;2471.789897858684;2507.285423654268;2711.430599574092;2728.8089833711647;2895.826250424981;13332.800007999887;14672.706545869023;14699.11805291686;14728.852711472962;15247.085174889542;1913.961720765577;1968.6751685971797;1979.3171355882198;2007.7691065527358;2018.9899050504653;62748.37251627471;65686;65810.3418965809;70247.64876175586;83862;10608.893911060944;11105.389203593719;11116.722081947853;11168.274062185932;11243;15541.06753594788;15568.688626227413;15594.29825657848;15635.687286254211;15649.217539122998;8547.316214702809;8557.358198135165;8612.224899759052;8621.956890215508;8666.133386661284;8393.790155246168;8396.992360916729;8427.115152908978;8563.229309362187;8648.913510864937;6620.768273110418;6658.3674550917585;6679.966600167065;6703.631300278434;6760.7295708172105;1933.7582802149732;1945.8929758863399;1967.2524440712439;1968.7908708804557;1976.1897621974922;884.7699598104539;961.4663861556903;1019.4647809899861;1020.1430798129607;1033.9793204135874;19947.11256474259;20186;20226.494337641678;20671.379858604265;20838;1029.7683021320292;1041.7812259425605;1057.0803401041144;1066.1630619963446;1133.8979491845773;10750.247482676294;11624.88375116255;11628.79558548403;11743.88256117445;11773.352465614302;479594;485135;514385;520348;522840;77643.61178194072;78115.60942195253;79215;79239.20760792318;80759.59620201861;951.2770294576172;1005.4570531912832;1069.4652673663168;1093.4696672114178;1099.5491848342301;17358.91320543389;18121.90939045296;18228.908855455637;18312.542186445444;18451.90774046175;39417.81746547608;39913.60086399215;40291.597084028785;40375.3943690839;40716.796416018915;52149.21776173285;52445.7377713109;52682.473175267754;53474.73262633818;53539.46460535501;5783.710814459344;6826.41975432074;7600.2779735925;7634.885476717743;8254.380921431037;10426.426546540013;12525.749485010067;12593.68515787076;12640.30478323701;12761.553345632858;10372.429516376671;10517.737056573647;10542.578296868347;10757.73105672333;10903.83644245321;10854.511546980562;10856.782864342827;11057.61298354586;11184.217104802585;11502.274658801247;11152.944235278772;11167.944160279472;11260.662180134608;11292.887071129184;11579.421028948687;7850.4112191587;7870.212978702084;8064;8158.224968627971;8626.956865215634;11053.61312354096;11117.499712513118;11128.109751219721;11156.995870371706;11352.659420217407 12:15:04 INFO - PROCESS | 22669 | |3;mootools.html;1499.7450433426316;1533.9386424543018;1670.3652612007443;1758.7449819776125;1828.3600739741091;8420.536870472122;9044.095590440953;9045.638174473013;9047.185753282203;9055.547222638867;7640.350570201525;7733.0720313562315;7737.57443340616;8011.559364234965;8789.604467798948;2257.4243567890167;2469.4814089041233;2503.2240005598233;2505.1732928133765;2557.1689201009654;2466.70399552054;2513.1832154549843;2520.773130418262;2521.8360806547607;2522.7729504344607;2496.251124662603;2498.8875500602426;2502.27434044127;2507.4985002999383;2519.382751225943;2465.580851255282;2488.1167185649197;2490.9875450622812;2497.076081849709;2499.23773249158;2398.2445529658103;2479.454520005596;2479.578471659804;2480.0947654106303;2481.3920589455697;8878.11218878107;8984;9010.639574417015;9038.231750301233;9042.367034307601;5471.288732464794;5605.57958153136;5609.495145436889;5612.971935140339;5613.4386561343945;3345.866165353383;3479.8956031319103;3640.6177351378255;3733.869314574004;3745.6441638044344;1318.4462525739214;1331.2944139606025;1362.8160198373291;1378.9586312410643;1394.7001394700087;12446.3154526501;12486.75026499465;12498.25010499373;12499.062570307264;12710.491580336682;4883.877903052381;4942.950570494321;5044.419891712427;5069.087564238399;5122.462141475166;10546.209034322457;10552.419616921143;10570.735731606617;10571.841422378671;10585.206109541816;5595.608307418442;5598.664080155204;5599.636023658449;5602.38373778884;5606.411326810708;4620.399348084795;5055.570276526463;5074.2895994560795;5124.9743751281;5125.513076257749;3774.2640185163627;3824.330742120118;3827.732058755916;3869.7097717671286;3913.9021524462114;1286.7362190750873;1288.072587736828;1300.466808608466;1310.1353106949368;1315.9802602960963;838.6771093129067;934.5187228577153;934.5467448287575;939.4410325856105;963.8554216867526;5981.551383646244;6013.398660134039;6068.514518838482;6107.8473038173515;6142.815715528542;948.9478078705738;963.629002833914;966.2849491376331;1012.2458768217725;1070.3738313086776;4168.416421700964;4369.191699535596;4383.912321753547;4385.232584297735;4426.26966550522;10889.727756805985;11044.723881903017;11229.438528073564;11256.774864502664;11269.21115521922;10293.794124117476;10531.789364212673;11241.100711943025;11259.605913792979;11291;7935.603219838985;8107.270345668918;8108.554029528433;8131.2681858633005;8134.75595732129;6190.41191086846;6249.96875015622;6280.120783090462;6341.619502829845;6402.423781859655;10314.071733544017;10346.37921724699;10353.119984801377;10362.274640775375;10461.529231184768;10263.538140783832;10356.689299321033;10393.896061039293;10555.788884222118;10679.19906007037;7116.964415177891;7732.188120247293;7986.321162701003;8002.319802816825;8019.478733882279;7702.884456733265;7933;8130.146334635015;8139.75580732579;8395.412321137463;7356.374708149867;7386.113666360071;7503.812404689927;7626.237376262329;7710.807229819299;7182.533135346186;7485.401167906445;7529.8117547061765;7592.468527203043;7771.33943614799;7114.6442677866935;7226.710931562889;7247.094113235846;7253.782386528413;7255.419566434778;5202.401723801811;5295.152775555893;5296.311479507794;5324.8136315228785;5501.982133305351;5425.864353391197;5480.616356854982;5514.6139770217305;5623.775048998158;5678.20505129274 12:15:04 INFO - PROCESS | 22669 | |4;prototype.html;339.7265201512781;344.2066037782911;348.28775154808415;351.12394575534046;356.09196548800566;5053.292539044537;5287.68273903566;5342.679439233649;5367.221752845835;5408.918866217005;5142.357205349332;5253.581532986092;5254.868628284295;5304.761285742141;5336.733163341827;4188.623023927846;4207.8007767786185;4217;4220.219259437006;4240.681948853849;4040.5151381834075;4147.336426171813;4223.598758117974;4253.2769429197115;4253.404523366731;4089.284375234322;4096.8975775605695;4126.00975765817;4144.632271350462;4166.916661666764;4085.7344272622186;4088.9386659200136;4092.7544347339253;4120.649744771668;4162.229987452331;3666.9816650916573;3669.7706268400116;3682.2635472905527;3686.5207523022104;3688.3729765939856;5145.897082058338;5147.430033839677;5186.559142472856;5212.374515058217;5231.921521177185;4710.693804902705;4724.362211101526;4747.430308362984;4761.642876784221;4771.807048237941;5371;5511.145772405283;5517.668939863621;5524.944750552523;5532.253145825302;3958.1885713428965;3964.6630036446936;3968.8015599219925;3973.523177218752;3996.440498330236;5688.914666280009;5694.60482181864;5700.914486282709;5703.999999999958;5721.742521586539;4041.535223449282;4066.7356621819486;4072.635667051571;4102.200070986189;4102.2410853992105;4059.512858456945;4120.587941205856;4132.462779838662;4139.296319625671;4156.688248381383;4636.142313671981;4652.511486293958;4654.185517534418;4679.625629949596;4692.483826779052;5502.752376143083;5523.337199536081;5536.695481748542;5555.8888822223325;5566.137248726453;1277.7125146841886;1318.1102755640097;1318.7142536027488;1371.4582739817715;1372.8078069070339;939.8402271613842;952.9374747157009;955.9283053770995;964.5466630683568;973.522973742875;5108.335916330853;5115.539601435814;5121.206213036985;5148;5175.896482070338;5391.78432862689;5398.946010539844;5406.94507603203;5408.45915408456;5464.098423760114;4840.854774356704;5111.207762796773;5130.666506677054;5148.613853960968;5185.351831021122;2839.3043704292168;2870.6985766494217;2871.9282017949718;2876.223419676676;2878.510653188963;5555.972220138873;5564.805231816867;5571.8885622288135;5572.4148964358155;5607.943920560824;5294.861604754996;5417.404085550586;5434.510894019557;5446.945530544723;5510.862228444321;5526.613137080446;5549.556035517229;5551.750171242304;5567.717235933248;5570.275864137636;5279.551238144801;5346.599005074713;5413.593980451561;5427.945720542744;5436.565074794086;5297.629165958346;5308.124159513637;5329.813456529003;5351.678899266057;5355.169948657965;5549.250851135045;5574.358948720949;5588.938101760653;5615.32616086056;5637.8590535236945;3721.720870934745;3883.1457079442475;3888.455616213676;3907.648311651965;3917.5690674025263;5344.973275133755;5380.677159370451;5387.973060134831;5401.837944861661;5448.019356515707;5415.2147938547905;5453.754581043783;5490.725463726718;5547.335799260287;5554.472325129106;5517.200005999028;5535.16972454119;5544.61187716856;5552.666839989613;5559.581582011838;5290.28581141541;5445.40100588927;5486.506214440719;5526.613137080366;5534.363548191848;5576.553875690016;5583.134614134816;5600.299962504687;5612.607117501736;5623.3814280428305;5491.983982963165;5492.835214943558;5498.45015498447;5500.257465242141;5505.9724701376235 12:15:04 INFO - PROCESS | 22669 | |5;yui.html;775.1008829757483;795.4908858330666;800.0359566722101;835.1231207232404;843.3421930893901;14884;15820.604484887883;16200.270987805548;16720.331186752515;16910.577235569115;14833.85166148341;15068.171250581214;16041.839581604181;16219.026858388504;16223.675526489464;823.8228780812124;840.3823189955378;842.1620487614832;842.6713581703141;842.93256539477;717.2003216413688;721.4336745654662;804.3243675312737;825.2325337436182;829.9460535065232;882.4484697064335;885.0618344554761;885.6368888755611;887.3078998381241;889.1641856654724;878.8110556230378;881.4843316659761;881.823635272948;883.8188171424874;884.8761173435724;545.0516101982562;555.6499405374589;624.1386886097157;629.4743888852813;633.2306247908767;14594.854051459455;14597.416103355854;14598.708025839423;14625.122492650475;14657.41370345185;13822.723545529034;14024.859751402457;14030.1581905085;14136.363863626162;14138.787918181235;12811.87188128116;12895.871041289562;12927.67680807978;12958.80561791574;13111.60665180046;4354.281543545343;4417.845375411845;4440.511543730219;4454.510003899569;4532.660050496193;59386.14707431215;61363;62189;62805.371946280866;62945;10830.891691083147;11044.116470682326;11292.604758833402;11333.886661133449;11683.299002059903;19970.800291997184;19994.70007949882;20201.898990505248;20237.49406264855;20259.493512662008;8328.916710832815;8393.370497212734;8434.73879051858;8684.913150868411;8691.304695624334;4557.339185818104;4560.429946256718;4632.698874573142;4734.455537613218;4800.903981920342;3614.2771445710964;3725.1245957200035;3729;3729.2355067211156;3730.9067273318383;675.378651640492;688.3942130924854;690.6960937187621;692.4840993459904;726.6984201556295;735.0481126940625;768.6771555946516;769.8113962079326;771.3828936850497;779.9649015794303;9355.766105847408;9452.243820494345;9495.620175193053;9913.702588922344;9968.501574921225;725.9237780033126;727.6761840980713;742.4505865659481;745.5452174173749;753;4785.760711964388;4863.708177509361;4906.435759887588;4960.156773348467;5020.920502091994;88060.5596972011;90550.54724726334;91137.54431227801;92406.53796730973;94033;83085;83452;84145;86444.56777716072;86768;71768.64115679388;72607.2739272611;73791.63104184445;74966;75625.24374756293;9951.15415189688;9986.60053597848;10016.1987041038;10063.899361006297;10064.691590093535;42607.78696106624;45255.77372113118;45795.77102114468;46613.533864660916;47653;39768;39950.400743988284;50620;63926;64827.35172648402;12543.686407839878;12670.683232919251;12908.677283067998;13010.739785204432;13060.415255250453;14207.64480887986;14436.350364233425;14566.19885906243;14763.704725905636;15211.163386013433;13240.80138797938;13304.401301941241;13416.32918354098;13585.660358491117;13723.725525489634;13232.735345293233;13407.525172231242;13410.664733381744;13436.925045996491;13672.111312764639;13316.667083322995;13600.795988060385;13644.522441714493;13747;14067.788983165465;10443.373397596168;10594.15246780271;10835.620753273597;11301.378424186749;11312.773744525228;9650;11019.078178245278;11085.667429977113;11207.943960280147;11297.322160670057 12:15:04 INFO - PROCESS | 22669 | __end_tp_report 12:15:04 INFO - PROCESS | 22669 | __start_cc_report 12:15:04 INFO - PROCESS | 22669 | _x_x_mozilla_cycle_collect,1236 12:15:04 INFO - PROCESS | 22669 | __end_cc_report 12:15:04 INFO - PROCESS | 22669 | __startTimestamp1479154504626__endTimestamp 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | ------- Summary: start ------- 12:15:04 INFO - PROCESS | 22669 | Number of tests: 6 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | [#0] dojo.html Cycles:165 Average:5557.92 Median:5786.16 stddev:639.77 (11.1%) stddev-sans-first:614.68 12:15:04 INFO - PROCESS | 22669 | Values: 3211.5 3216.3 3248.0 3267.8 3288.4 5566.4 5663.1 5665.4 5677.1 5686.0 5531.3 5570.7 5581.3 5603.2 5619.7 5027.8 5064.4 5088.8 5091.8 5132.6 4987.4 5003.2 5144.7 5157.3 5160.4 4981.1 4996.3 5001.1 5095.2 5097.9 5112.1 5130.6 5170.4 5186.1 5210.8 4824.3 5040.0 5078.4 5111.6 5127.8 5400.5 5469.8 5487.4 5503.6 5524.4 5927.5 5931.6 6027.8 6033.9 6035.3 5885.1 6079.4 6093.6 6114.2 6119.7 5492.8 5493.6 5563.7 5569.1 5574.8 6151.9 6159.2 6168.3 6171.8 6184.7 5841.7 5863.9 5878.7 5882.9 5894.1 5824.2 5859.4 5875.3 5925.1 5926.1 5917.6 5922.4 5923.8 5936.3 5951.6 5909.5 5938.4 5973.8 5974.4 5992.6 4520.2 4534.1 4543.8 4555.4 4593.7 4025.8 4060.6 4071.0 4089.9 4113.7 5606.0 5621.6 5668.4 5671.8 5676.4 5875.9 5908.4 5913.4 5995.6 5998.7 5636.0 5670.1 5690.7 5691.6 5702.8 5109.4 5136.9 5139.4 5143.5 5143.8 6153.3 6272.0 6294.7 6303.4 6304.9 6026.8 6040.9 6077.7 6101.2 6137.9 6066.4 6274.3 6310.3 6314.0 6321.0 5796.4 5811.6 5819.4 5833.0 5915.4 5953.4 5960.3 5960.9 5970.7 5973.6 5685.9 5828.3 5871.3 5873.5 5884.4 5728.8 5786.2 5825.4 5874.9 5966.9 5854.4 5860.4 5871.1 5875.4 5878.2 5966.8 5981.6 5987.1 5992.3 6000.8 5642.8 5694.3 5708.1 5756.4 5766.1 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | [#1] ext.html Cycles:180 Average:59116.95 Median:43409.17 stddev:112925.97 (260.1%) stddev-sans-first:113157.21 12:15:04 INFO - PROCESS | 22669 | Values: 572.6 617.9 638.2 642.5 649.0 33485.0 43883.8 44450.3 44539.6 44594.6 45532.0 45774.0 45902.0 45906.0 45990.8 8590.8 8722.1 8734.7 8735.7 8742.5 8385.4 8464.6 8471.7 8474.9 8476.7 8834.2 8854.0 8854.6 8859.4 8860.8 8741.4 8775.7 8821.2 8822.6 8826.9 8490.7 8516.9 8543.6 8547.1 8554.5 42618.8 42730.8 42945.8 43013.4 43114.1 3339.2 3573.7 3727.5 3877.9 3939.1 31822.7 31824.8 32023.0 32099.2 32662.5 4189.7 4401.8 4406.6 4410.3 4442.7 333417.3 334001.0 337237.0 337885.0 338642.0 63958.4 64573.7 64668.4 64677.0 64697.7 39652.4 40257.0 40554.2 41649.8 66791.3 18834.4 18967.3 19028.0 19036.4 19046.5 14048.7 14110.2 14120.2 14151.5 14164.2 19530.8 19931.4 19998.5 20051.1 20063.6 6768.8 6882.7 6894.3 6938.5 6953.3 956.3 962.5 1046.2 1050.3 1053.8 31839.7 32069.7 32314.8 32353.7 32446.8 976.2 986.2 1095.0 1101.5 1103.5 15039.9 16901.0 16945.4 17051.1 17087.5 477008.0 480013.0 481019.0 481337.0 482254.0 60104.0 60784.0 60939.4 60974.1 60989.1 1239.5 1334.4 1336.0 1392.7 1411.4 30232.1 34521.8 34585.0 34864.8 34878.8 55995.0 56489.0 56493.4 56534.2 56571.0 449656.0 451318.0 451652.0 452187.0 452303.0 23179.0 29542.7 30504.7 30761.4 31454.4 45620.3 46441.5 46471.3 49280.8 49596.5 40974.0 41169.8 44322.0 44698.3 45430.5 41891.0 42482.8 42561.6 43408.3 43565.8 42509.6 43183.0 43391.3 43410.0 43455.8 35610.0 36638.1 36709.8 37899.2 38338.4 28754.3 28785.7 28815.3 29037.0 29131.4 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | [#2] jquery.html Cycles:180 Average:28607.01 Median:23394.77 stddev:82670.88 (353.4%) stddev-sans-first:82875.67 12:15:04 INFO - PROCESS | 22669 | Values: 405.7 417.2 425.4 430.2 430.3 15448.7 17706.6 17751.4 17814.9 18045.3 18395.6 18636.0 18683.8 18914.4 19069.4 5160.4 5263.6 5557.3 5785.5 5786.8 5651.3 5786.4 5790.8 5792.8 5794.0 5574.3 5675.5 5699.1 5759.5 5768.6 5608.6 5635.9 5674.2 5676.5 5680.5 5011.6 5071.8 5140.3 5193.2 5197.3 22740.3 23123.4 23134.5 23346.0 23443.5 2471.8 2507.3 2711.4 2728.8 2895.8 13332.8 14672.7 14699.1 14728.9 15247.1 1914.0 1968.7 1979.3 2007.8 2019.0 62748.4 65686.0 65810.3 70247.6 83862.0 10608.9 11105.4 11116.7 11168.3 11243.0 15541.1 15568.7 15594.3 15635.7 15649.2 8547.3 8557.4 8612.2 8622.0 8666.1 8393.8 8397.0 8427.1 8563.2 8648.9 6620.8 6658.4 6680.0 6703.6 6760.7 1933.8 1945.9 1967.3 1968.8 1976.2 884.8 961.5 1019.5 1020.1 1034.0 19947.1 20186.0 20226.5 20671.4 20838.0 1029.8 1041.8 1057.1 1066.2 1133.9 10750.2 11624.9 11628.8 11743.9 11773.4 479594.0 485135.0 514385.0 520348.0 522840.0 77643.6 78115.6 79215.0 79239.2 80759.6 951.3 1005.5 1069.5 1093.5 1099.5 17358.9 18121.9 18228.9 18312.5 18451.9 39417.8 39913.6 40291.6 40375.4 40716.8 52149.2 52445.7 52682.5 53474.7 53539.5 5783.7 6826.4 7600.3 7634.9 8254.4 10426.4 12525.7 12593.7 12640.3 12761.6 10372.4 10517.7 10542.6 10757.7 10903.8 10854.5 10856.8 11057.6 11184.2 11502.3 11152.9 11167.9 11260.7 11292.9 11579.4 7850.4 7870.2 8064.0 8158.2 8627.0 11053.6 11117.5 11128.1 11157.0 11352.7 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | [#3] mootools.html Cycles:180 Average:5913.45 Median:5050.00 stddev:3275.86 (64.9%) stddev-sans-first:3268.25 12:15:04 INFO - PROCESS | 22669 | Values: 1499.7 1533.9 1670.4 1758.7 1828.4 8420.5 9044.1 9045.6 9047.2 9055.5 7640.4 7733.1 7737.6 8011.6 8789.6 2257.4 2469.5 2503.2 2505.2 2557.2 2466.7 2513.2 2520.8 2521.8 2522.8 2496.3 2498.9 2502.3 2507.5 2519.4 2465.6 2488.1 2491.0 2497.1 2499.2 2398.2 2479.5 2479.6 2480.1 2481.4 8878.1 8984.0 9010.6 9038.2 9042.4 5471.3 5605.6 5609.5 5613.0 5613.4 3345.9 3479.9 3640.6 3733.9 3745.6 1318.4 1331.3 1362.8 1379.0 1394.7 12446.3 12486.8 12498.3 12499.1 12710.5 4883.9 4943.0 5044.4 5069.1 5122.5 10546.2 10552.4 10570.7 10571.8 10585.2 5595.6 5598.7 5599.6 5602.4 5606.4 4620.4 5055.6 5074.3 5125.0 5125.5 3774.3 3824.3 3827.7 3869.7 3913.9 1286.7 1288.1 1300.5 1310.1 1316.0 838.7 934.5 934.5 939.4 963.9 5981.6 6013.4 6068.5 6107.8 6142.8 948.9 963.6 966.3 1012.2 1070.4 4168.4 4369.2 4383.9 4385.2 4426.3 10889.7 11044.7 11229.4 11256.8 11269.2 10293.8 10531.8 11241.1 11259.6 11291.0 7935.6 8107.3 8108.6 8131.3 8134.8 6190.4 6250.0 6280.1 6341.6 6402.4 10314.1 10346.4 10353.1 10362.3 10461.5 10263.5 10356.7 10393.9 10555.8 10679.2 7117.0 7732.2 7986.3 8002.3 8019.5 7702.9 7933.0 8130.1 8139.8 8395.4 7356.4 7386.1 7503.8 7626.2 7710.8 7182.5 7485.4 7529.8 7592.5 7771.3 7114.6 7226.7 7247.1 7253.8 7255.4 5202.4 5295.2 5296.3 5324.8 5502.0 5425.9 5480.6 5514.6 5623.8 5678.2 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | [#4] prototype.html Cycles:180 Average:4588.50 Median:5288.98 stddev:1327.01 (25.1%) stddev-sans-first:1291.85 12:15:04 INFO - PROCESS | 22669 | Values: 339.7 344.2 348.3 351.1 356.1 5053.3 5287.7 5342.7 5367.2 5408.9 5142.4 5253.6 5254.9 5304.8 5336.7 4188.6 4207.8 4217.0 4220.2 4240.7 4040.5 4147.3 4223.6 4253.3 4253.4 4089.3 4096.9 4126.0 4144.6 4166.9 4085.7 4088.9 4092.8 4120.6 4162.2 3667.0 3669.8 3682.3 3686.5 3688.4 5145.9 5147.4 5186.6 5212.4 5231.9 4710.7 4724.4 4747.4 4761.6 4771.8 5371.0 5511.1 5517.7 5524.9 5532.3 3958.2 3964.7 3968.8 3973.5 3996.4 5688.9 5694.6 5700.9 5704.0 5721.7 4041.5 4066.7 4072.6 4102.2 4102.2 4059.5 4120.6 4132.5 4139.3 4156.7 4636.1 4652.5 4654.2 4679.6 4692.5 5502.8 5523.3 5536.7 5555.9 5566.1 1277.7 1318.1 1318.7 1371.5 1372.8 939.8 952.9 955.9 964.5 973.5 5108.3 5115.5 5121.2 5148.0 5175.9 5391.8 5398.9 5406.9 5408.5 5464.1 4840.9 5111.2 5130.7 5148.6 5185.4 2839.3 2870.7 2871.9 2876.2 2878.5 5556.0 5564.8 5571.9 5572.4 5607.9 5294.9 5417.4 5434.5 5446.9 5510.9 5526.6 5549.6 5551.8 5567.7 5570.3 5279.6 5346.6 5413.6 5427.9 5436.6 5297.6 5308.1 5329.8 5351.7 5355.2 5549.3 5574.4 5588.9 5615.3 5637.9 3721.7 3883.1 3888.5 3907.6 3917.6 5345.0 5380.7 5388.0 5401.8 5448.0 5415.2 5453.8 5490.7 5547.3 5554.5 5517.2 5535.2 5544.6 5552.7 5559.6 5290.3 5445.4 5486.5 5526.6 5534.4 5576.6 5583.1 5600.3 5612.6 5623.4 5492.0 5492.8 5498.5 5500.3 5506.0 12:15:04 INFO - PROCESS | 22669 | 12:15:04 INFO - PROCESS | 22669 | [#5] yui.html Cycles:180 Average:18230.55 Median:25673.99 stddev:24118.90 (93.9%) stddev-sans-first:24150.94 12:15:04 INFO - PROCESS | 22669 | Values: 775.1 795.5 800.0 835.1 843.3 14884.0 15820.6 16200.3 16720.3 16910.6 14833.9 15068.2 16041.8 16219.0 16223.7 823.8 840.4 842.2 842.7 842.9 717.2 721.4 804.3 825.2 829.9 882.4 885.1 885.6 887.3 889.2 878.8 881.5 881.8 883.8 884.9 545.1 555.6 624.1 629.5 633.2 14594.9 14597.4 14598.7 14625.1 14657.4 13822.7 14024.9 14030.2 14136.4 14138.8 12811.9 12895.9 12927.7 12958.8 13111.6 4354.3 4417.8 4440.5 4454.5 4532.7 59386.1 61363.0 62189.0 62805.4 62945.0 10830.9 11044.1 11292.6 11333.9 11683.3 19970.8 19994.7 20201.9 20237.5 20259.5 8328.9 8393.4 8434.7 8684.9 8691.3 4557.3 4560.4 4632.7 4734.5 4800.9 3614.3 3725.1 3729.0 3729.2 3730.9 675.4 688.4 690.7 692.5 726.7 735.0 768.7 769.8 771.4 780.0 9355.8 9452.2 9495.6 9913.7 9968.5 725.9 727.7 742.5 745.5 753.0 4785.8 4863.7 4906.4 4960.2 5020.9 88060.6 90550.5 91137.5 92406.5 94033.0 83085.0 83452.0 84145.0 86444.6 86768.0 71768.6 72607.3 73791.6 74966.0 75625.2 9951.2 9986.6 10016.2 10063.9 10064.7 42607.8 45255.8 45795.8 46613.5 47653.0 39768.0 39950.4 50620.0 63926.0 64827.4 12543.7 12670.7 12908.7 13010.7 13060.4 14207.6 14436.4 14566.2 14763.7 15211.2 13240.8 13304.4 13416.3 13585.7 13723.7 13232.7 13407.5 13410.7 13436.9 13672.1 13316.7 13600.8 13644.5 13747.0 14067.8 10443.4 10594.2 10835.6 11301.4 11312.8 9650.0 11019.1 11085.7 11207.9 11297.3 12:15:04 INFO - PROCESS | 22669 | -------- Summary: end -------- 12:15:04 INFO - PROCESS | 22669 | 12:15:05 INFO - TEST-INFO | 22669: exit 0 12:15:05 INFO - TEST-OK | dromaeo_css | took 1115567ms 12:15:05 INFO - TEST-START | kraken 12:15:05 INFO - operating with platform_type : linux_ 12:15:05 INFO - Initialising browser for kraken test... 12:15:05 INFO - TEST-INFO | started process 22986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWQFULG/profile http://localhost:56228/getInfo.html) 12:15:08 ERROR - PROCESS | 22986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 12:15:09 INFO - PROCESS | 22986 | __metrics Screen width/height:1600/1200 12:15:09 INFO - PROCESS | 22986 | colorDepth:24 12:15:09 INFO - PROCESS | 22986 | Browser inner width/height: 1024/697 12:15:09 INFO - PROCESS | 22986 | __metrics 12:15:09 INFO - PROCESS | 22986 | 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:15:09 INFO - PROCESS | 22986 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:10 INFO - PROCESS | 22986 | console.error: PushService: 12:15:10 INFO - PROCESS | 22986 | stateChangeProcessEnqueue: Error transitioning state 12:15:10 INFO - PROCESS | 22986 | UnknownError 12:15:11 INFO - TEST-INFO | 22986: exit 0 12:15:11 INFO - Browser initialized. 12:15:11 INFO - Running cycle 1/1 for kraken test... 12:15:11 INFO - TEST-INFO | started process 23080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWQFULG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:22 INFO - PROCESS | 23080 | RSS: Main: 144637952 12:15:22 INFO - PROCESS | 23080 | 12:15:25 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-beat-detection) 12:15:26 INFO - PROCESS | 23080 | RSS: Main: 185729024 12:15:26 INFO - PROCESS | 23080 | 12:15:28 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-dft) 12:15:29 INFO - PROCESS | 23080 | RSS: Main: 175624192 12:15:29 INFO - PROCESS | 23080 | 12:15:32 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-fft) 12:15:32 INFO - PROCESS | 23080 | RSS: Main: 267026432 12:15:32 INFO - PROCESS | 23080 | 12:15:34 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-oscillator) 12:15:35 INFO - PROCESS | 23080 | RSS: Main: 173064192 12:15:35 INFO - PROCESS | 23080 | 12:15:37 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:38 INFO - PROCESS | 23080 | RSS: Main: 175558656 12:15:38 INFO - PROCESS | 23080 | 12:15:41 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:41 INFO - PROCESS | 23080 | RSS: Main: 214347776 12:15:41 INFO - PROCESS | 23080 | 12:15:45 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:45 INFO - PROCESS | 23080 | RSS: Main: 213037056 12:15:45 INFO - PROCESS | 23080 | 12:15:48 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56228/tests/kraken/driver.html?testName=json-parse-financial) 12:15:48 INFO - PROCESS | 23080 | RSS: Main: 211628032 12:15:48 INFO - PROCESS | 23080 | 12:15:50 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:50 INFO - PROCESS | 23080 | RSS: Main: 174063616 12:15:50 INFO - PROCESS | 23080 | 12:15:52 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:53 INFO - PROCESS | 23080 | RSS: Main: 181288960 12:15:53 INFO - PROCESS | 23080 | 12:15:55 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:55 INFO - PROCESS | 23080 | RSS: Main: 190406656 12:15:55 INFO - PROCESS | 23080 | 12:15:58 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:59 INFO - PROCESS | 23080 | RSS: Main: 199421952 12:15:59 INFO - PROCESS | 23080 | 12:16:01 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:16:02 INFO - PROCESS | 23080 | RSS: Main: 195448832 12:16:02 INFO - PROCESS | 23080 | 12:16:03 INFO - PROCESS | 23080 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56228/tests/kraken/driver.html?testName=ai-astar) 12:16:04 INFO - PROCESS | 23080 | RSS: Main: 246558720 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | __start_tp_report 12:16:04 INFO - PROCESS | 23080 | _x_x_mozilla_page_load 12:16:04 INFO - PROCESS | 23080 | _x_x_mozilla_page_load_details 12:16:04 INFO - PROCESS | 23080 | |i|pagename|runs| 12:16:04 INFO - PROCESS | 23080 | |0;ai-astar;109;111;112;110;116;112;111;111;112;112 12:16:04 INFO - PROCESS | 23080 | |1;audio-beat-detection;156;121;121;155;125;124;119;122;153;127 12:16:04 INFO - PROCESS | 23080 | |2;audio-dft;161;161;162;160;162;160;160;159;160;160 12:16:04 INFO - PROCESS | 23080 | |3;audio-fft;74;75;75;115;77;75;75;75;97;75 12:16:04 INFO - PROCESS | 23080 | |4;audio-oscillator;81;82;114;81;81;81;115;82;81;120 12:16:04 INFO - PROCESS | 23080 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 12:16:04 INFO - PROCESS | 23080 | |6;imaging-darkroom;147;146;146;148;146;146;146;147;145;145 12:16:04 INFO - PROCESS | 23080 | |7;imaging-desaturate;85;85;84;84;84;85;84;84;84;85 12:16:04 INFO - PROCESS | 23080 | |8;json-parse-financial;52;50;50;51;50;57;52;50;49;49 12:16:04 INFO - PROCESS | 23080 | |9;json-stringify-tinderbox;58;59;57;57;59;59;57;58;58;59 12:16:04 INFO - PROCESS | 23080 | |10;stanford-crypto-aes;76;74;73;75;74;73;83;77;74;74 12:16:04 INFO - PROCESS | 23080 | |11;stanford-crypto-ccm;124;132;125;127;126;125;125;120;169;136 12:16:04 INFO - PROCESS | 23080 | |12;stanford-crypto-pbkdf2;159;158;156;157;158;153;155;153;152;153 12:16:04 INFO - PROCESS | 23080 | |13;stanford-crypto-sha256-iterative;62;61;62;62;63;62;64;61;60;61 12:16:04 INFO - PROCESS | 23080 | __end_tp_report 12:16:04 INFO - PROCESS | 23080 | __start_cc_report 12:16:04 INFO - PROCESS | 23080 | _x_x_mozilla_cycle_collect,1601 12:16:04 INFO - PROCESS | 23080 | __end_cc_report 12:16:04 INFO - PROCESS | 23080 | __startTimestamp1479154564249__endTimestamp 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | ------- Summary: start ------- 12:16:04 INFO - PROCESS | 23080 | Number of tests: 14 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.84 (1.6%) stddev-sans-first:1.69 12:16:04 INFO - PROCESS | 23080 | Values: 109.0 111.0 112.0 110.0 116.0 112.0 111.0 111.0 112.0 112.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:126.00 stddev:15.61 (12.4%) stddev-sans-first:14.01 12:16:04 INFO - PROCESS | 23080 | Values: 156.0 121.0 121.0 155.0 125.0 124.0 119.0 122.0 153.0 127.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 12:16:04 INFO - PROCESS | 23080 | Values: 161.0 161.0 162.0 160.0 162.0 160.0 160.0 159.0 160.0 160.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:13.71 (18.3%) stddev-sans-first:14.29 12:16:04 INFO - PROCESS | 23080 | Values: 74.0 75.0 75.0 115.0 77.0 75.0 75.0 75.0 97.0 75.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:81.00 stddev:17.00 (21.0%) stddev-sans-first:17.58 12:16:04 INFO - PROCESS | 23080 | Values: 81.0 82.0 114.0 81.0 81.0 81.0 115.0 82.0 81.0 120.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:16:04 INFO - PROCESS | 23080 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 12:16:04 INFO - PROCESS | 23080 | Values: 147.0 146.0 146.0 148.0 146.0 146.0 146.0 147.0 145.0 145.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 12:16:04 INFO - PROCESS | 23080 | Values: 85.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:50.50 stddev:2.36 (4.7%) stddev-sans-first:2.47 12:16:04 INFO - PROCESS | 23080 | Values: 52.0 50.0 50.0 51.0 50.0 57.0 52.0 50.0 49.0 49.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.50 stddev:0.88 (1.5%) stddev-sans-first:0.93 12:16:04 INFO - PROCESS | 23080 | Values: 58.0 59.0 57.0 57.0 59.0 59.0 57.0 58.0 58.0 59.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:2.98 (4.0%) stddev-sans-first:3.15 12:16:04 INFO - PROCESS | 23080 | Values: 76.0 74.0 73.0 75.0 74.0 73.0 83.0 77.0 74.0 74.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:126.50 stddev:14.10 (11.1%) stddev-sans-first:14.73 12:16:04 INFO - PROCESS | 23080 | Values: 124.0 132.0 125.0 127.0 126.0 125.0 125.0 120.0 169.0 136.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.50 stddev:2.55 (1.6%) stddev-sans-first:2.35 12:16:04 INFO - PROCESS | 23080 | Values: 159.0 158.0 156.0 157.0 158.0 153.0 155.0 153.0 152.0 153.0 12:16:04 INFO - PROCESS | 23080 | 12:16:04 INFO - PROCESS | 23080 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 12:16:04 INFO - PROCESS | 23080 | Values: 62.0 61.0 62.0 62.0 63.0 62.0 64.0 61.0 60.0 61.0 12:16:04 INFO - PROCESS | 23080 | -------- Summary: end -------- 12:16:04 INFO - PROCESS | 23080 | 12:16:05 INFO - TEST-INFO | 23080: exit 0 12:16:05 INFO - TEST-OK | kraken | took 59820ms 12:16:05 INFO - SUITE-END | took 1175s 12:16:05 INFO - Completed test suite (00:19:35) 12:16:05 INFO - javascript benchmark 12:16:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.4861622140456, 3216.2763378239893, 3248.0255923223026, 3267.754918381119, 3288.375208710345, 5566.415526369734, 5663.0655941769555, 5665.433456654332, 5677.148427735837, 5685.976524225638, 5531.2809334786425, 5570.749316280767, 5581.274434323543, 5603.159526071091, 5619.7471113799875, 5027.824026159085, 5064.442911279756, 5088.847334579968, 5091.803426194841, 5132.589392848582, 4987.426445958725, 5003.1994880819075, 5144.6655967362185, 5157.252198431225, 5160.406553246387, 4981.1283025470575, 4996.275540046691, 5001.14980453322, 5095.184770436731, 5097.898042039157, 5112.079825631385, 5130.563902068328, 5170.37955445349, 5186.118359878792, 5210.843674689765, 4824.300476430933, 5040.0, 5078.4413714491375, 5111.616628752859, 5127.820526281562, 5400.540954018913, 5469.781208751645, 5487.396386397493, 5503.559715222773, 5524.364698059734, 5927.496162826165, 5931.555133365015, 6027.819165425044, 6033.909491357633, 6035.30593981689, 5885.058390657474, 6079.422454866781, 6093.573449858512, 6114.2357205349335, 6119.724612392453, 5492.80775172867, 5493.615446918678, 5563.721813909328, 5569.081101618269, 5574.832755017356, 6151.876962460726, 6159.23009623797, 6168.259808822881, 6171.84570385744, 6184.721687524072, 5841.707914604252, 5863.912041319383, 5878.706064696748, 5882.941170588325, 5894.115882617642, 5824.184614154022, 5859.44335288147, 5875.265591801025, 5925.081612350093, 5926.051831706906, 5917.615355001911, 5922.378150294157, 5923.792667256712, 5936.287645482484, 5951.642901425928, 5909.468147866713, 5938.435848594463, 5973.761049558056, 5974.3726908674835, 5992.550558708114, 4520.2315606347, 4534.070515544306, 4543.841320463261, 4555.430571178603, 4593.655475839326, 4025.81883815229, 4060.614241647098, 4070.9592904070582, 4089.8773036808943, 4113.670906327547, 5606.046972014768, 5621.578381621313, 5668.376478587352, 5671.829845104653, 5676.375598684142, 5875.853103672443, 5908.379620139909, 5913.379095195029, 5995.610285331527, 5998.700064996733, 5635.971820140873, 5670.121131224667, 5690.687012214368, 5691.573132015115, 5702.8289151325525, 5109.3613298337705, 5136.897262054813, 5139.357580302462, 5143.485651434827, 5143.819966301162, 6153.29237137726, 6271.96864015677, 6294.748210071546, 6303.401176888188, 6304.936950630527, 6026.789062382795, 6040.909386359121, 6077.709570594414, 6101.237345331833, 6137.907931380943, 6066.3630318815885, 6274.278457977391, 6310.274318453253, 6313.96843015782, 6320.968395157995, 5796.362400135898, 5811.622244554091, 5819.447152520504, 5833.0, 5915.438033386821, 5953.434423729739, 5960.344362120077, 5960.927033134078, 5970.731317090655, 5973.581849270509, 5685.943140568706, 5828.271466066742, 5871.295444546682, 5873.50075243592, 5884.382139875252, 5728.770849165987, 5786.161006654096, 5825.446582574818, 5874.911876321773, 5966.850828729316, 5854.356020837619, 5860.413958604106, 5871.1486834409625, 5875.41245875409, 5878.2064421302575, 5966.820995370146, 5981.581289309881, 5987.131865879336, 5992.250968628921, 6000.789972350947, 5642.802501912578, 5694.345150307768, 5708.115242137475, 5756.366799651951, 5766.106253530709], "value": 5514.3522345338715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.6192082265294, 617.8887800195964, 638.208621309576, 642.5084810120256, 649.0199798304559, 33485.0, 43883.78058109709, 44450.33324500135, 44539.554604453944, 44594.554054459484, 45532.0, 45774.0, 45902.0, 45906.0, 45990.77004614972, 8590.828183436328, 8722.12778722129, 8734.694285700001, 8735.737927862174, 8742.519161446118, 8385.371097167706, 8464.619092140869, 8471.745847624581, 8474.915250847505, 8476.66093356265, 8834.160754728291, 8853.95573022134, 8854.557272136399, 8859.424137431046, 8860.778480537974, 8741.431806932529, 8775.736727898173, 8821.161989610944, 8822.602982865787, 8826.86759698605, 8490.745277641681, 8516.914830851674, 8543.57282135897, 8547.059823419419, 8554.52950087745, 42618.78690606558, 42730.78634606838, 42945.78527107376, 43013.35479967803, 43114.137717245794, 3339.1819004344093, 3573.678368946781, 3727.478153058547, 3877.941830872539, 3939.0546268895546, 31822.681773182434, 31824.84087579547, 32023.0, 32099.197520062186, 32662.510062349083, 4189.706720529533, 4401.757903315316, 4406.603405693503, 4410.319349028883, 4442.711223770477, 333417.3329133363, 334001.0, 337237.0, 337885.0, 338642.0, 63958.36041639617, 64573.677131614044, 64668.353316467175, 64677.0, 64697.67651161714, 39652.40521392181, 40257.0, 40554.18891622151, 41649.79175104105, 66791.3320866785, 18834.434966951012, 18967.33614323492, 19028.048597570065, 19036.42890713281, 19046.523836904187, 14048.719025619635, 14110.153390796586, 14120.152790832582, 14151.50469733575, 14164.150150990974, 19530.804691953184, 19931.402057938285, 19998.50003749918, 20051.097700603506, 20063.598728025358, 6768.796936091925, 6882.655867206619, 6894.310893831043, 6938.548994315353, 6953.33943275388, 956.268454632207, 962.5379817687549, 1046.2048842879467, 1050.2648146297622, 1053.8155822730992, 31839.68160318367, 32069.679303207136, 32314.83842580772, 32353.676463235537, 32446.83776581102, 976.2190247801731, 986.2356673578034, 1094.950727217277, 1101.4547798839626, 1103.5199688135688, 15039.924800376148, 16901.0, 16945.406910758065, 17051.14744262782, 17087.487375378758, 477008.0, 480013.0, 481019.0, 481337.0, 482254.0, 60104.0, 60784.0, 60939.39060609337, 60974.085388719206, 60989.08516372258, 1239.5413696932012, 1334.3528388731459, 1335.9732805343838, 1392.721455708842, 1411.4495346814545, 30232.107837053376, 34521.82739086288, 34585.0, 34864.825675871456, 34878.82560587181, 55995.0, 56489.0, 56493.43506564882, 56534.15198771939, 56571.0, 449656.0, 451318.0, 451652.0, 452187.0, 452303.0, 23179.0, 29542.704572953997, 30504.694953050184, 30761.384772304875, 31454.370912581162, 45620.315695265264, 46441.53558464372, 46471.302930456746, 49280.75359623179, 49596.504034960635, 40974.0, 41169.79415103025, 44322.0, 44698.25575046421, 45430.545694542634, 41891.0, 42482.78758606311, 42561.574384255764, 43408.34887476754, 43565.78217108894, 42509.57490425056, 43183.0, 43391.34912976245, 43410.0, 43455.782721086194, 35610.0, 36638.084047899014, 36709.81645091758, 37899.242015160096, 38338.42492362561, 28754.281142970754, 28785.712142878303, 28815.279618009718, 29037.0, 29131.41737165287], "value": 20260.249051587867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6977551723966, 417.24686940073195, 425.3874420833998, 430.2041223736088, 430.27283890225516, 15448.69102617947, 17706.557336066606, 17751.37870174544, 17814.910925445387, 18045.278188872428, 18395.632087358244, 18636.0, 18683.813161868376, 18914.432567022977, 19069.427917162473, 5160.4323524412475, 5263.578913686915, 5557.277553917985, 5785.479306862381, 5786.768529258846, 5651.32184137902, 5786.421357864222, 5790.797322093727, 5792.82621521355, 5794.0, 5574.331080270374, 5675.4608312210485, 5699.088145896658, 5759.452851979056, 5768.625039372428, 5608.6073974821775, 5635.887282254353, 5674.205611214413, 5676.517496012844, 5680.460356266148, 5011.599072074226, 5071.771770270347, 5140.280360749498, 5193.195054766479, 5197.298364720752, 22740.317790466313, 23123.421914452105, 23134.53730925389, 23346.0, 23443.531129377316, 2471.789897858684, 2507.285423654268, 2711.430599574092, 2728.8089833711647, 2895.826250424981, 13332.800007999887, 14672.706545869023, 14699.11805291686, 14728.852711472962, 15247.085174889542, 1913.961720765577, 1968.6751685971797, 1979.3171355882198, 2007.7691065527358, 2018.9899050504653, 62748.37251627471, 65686.0, 65810.3418965809, 70247.64876175586, 83862.0, 10608.893911060944, 11105.389203593719, 11116.722081947853, 11168.274062185932, 11243.0, 15541.06753594788, 15568.688626227413, 15594.29825657848, 15635.687286254211, 15649.217539122998, 8547.316214702809, 8557.358198135165, 8612.224899759052, 8621.956890215508, 8666.133386661284, 8393.790155246168, 8396.992360916729, 8427.115152908978, 8563.229309362187, 8648.913510864937, 6620.768273110418, 6658.3674550917585, 6679.966600167065, 6703.631300278434, 6760.7295708172105, 1933.7582802149732, 1945.8929758863399, 1967.2524440712439, 1968.7908708804557, 1976.1897621974922, 884.7699598104539, 961.4663861556903, 1019.4647809899861, 1020.1430798129607, 1033.9793204135874, 19947.11256474259, 20186.0, 20226.494337641678, 20671.379858604265, 20838.0, 1029.7683021320292, 1041.7812259425605, 1057.0803401041144, 1066.1630619963446, 1133.8979491845773, 10750.247482676294, 11624.88375116255, 11628.79558548403, 11743.88256117445, 11773.352465614302, 479594.0, 485135.0, 514385.0, 520348.0, 522840.0, 77643.61178194072, 78115.60942195253, 79215.0, 79239.20760792318, 80759.59620201861, 951.2770294576172, 1005.4570531912832, 1069.4652673663168, 1093.4696672114178, 1099.5491848342301, 17358.91320543389, 18121.90939045296, 18228.908855455637, 18312.542186445444, 18451.90774046175, 39417.81746547608, 39913.60086399215, 40291.597084028785, 40375.3943690839, 40716.796416018915, 52149.21776173285, 52445.7377713109, 52682.473175267754, 53474.73262633818, 53539.46460535501, 5783.710814459344, 6826.41975432074, 7600.2779735925, 7634.885476717743, 8254.380921431037, 10426.426546540013, 12525.749485010067, 12593.68515787076, 12640.30478323701, 12761.553345632858, 10372.429516376671, 10517.737056573647, 10542.578296868347, 10757.73105672333, 10903.83644245321, 10854.511546980562, 10856.782864342827, 11057.61298354586, 11184.217104802585, 11502.274658801247, 11152.944235278772, 11167.944160279472, 11260.662180134608, 11292.887071129184, 11579.421028948687, 7850.4112191587, 7870.212978702084, 8064.0, 8158.224968627971, 8626.956865215634, 11053.61312354096, 11117.499712513118, 11128.109751219721, 11156.995870371706, 11352.659420217407], "value": 9253.134632159446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.7450433426316, 1533.9386424543018, 1670.3652612007443, 1758.7449819776125, 1828.3600739741091, 8420.536870472122, 9044.095590440953, 9045.638174473013, 9047.185753282203, 9055.547222638867, 7640.350570201525, 7733.0720313562315, 7737.57443340616, 8011.559364234965, 8789.604467798948, 2257.4243567890167, 2469.4814089041233, 2503.2240005598233, 2505.1732928133765, 2557.1689201009654, 2466.70399552054, 2513.1832154549843, 2520.773130418262, 2521.8360806547607, 2522.7729504344607, 2496.251124662603, 2498.8875500602426, 2502.27434044127, 2507.4985002999383, 2519.382751225943, 2465.580851255282, 2488.1167185649197, 2490.9875450622812, 2497.076081849709, 2499.23773249158, 2398.2445529658103, 2479.454520005596, 2479.578471659804, 2480.0947654106303, 2481.3920589455697, 8878.11218878107, 8984.0, 9010.639574417015, 9038.231750301233, 9042.367034307601, 5471.288732464794, 5605.57958153136, 5609.495145436889, 5612.971935140339, 5613.4386561343945, 3345.866165353383, 3479.8956031319103, 3640.6177351378255, 3733.869314574004, 3745.6441638044344, 1318.4462525739214, 1331.2944139606025, 1362.8160198373291, 1378.9586312410643, 1394.7001394700087, 12446.3154526501, 12486.75026499465, 12498.25010499373, 12499.062570307264, 12710.491580336682, 4883.877903052381, 4942.950570494321, 5044.419891712427, 5069.087564238399, 5122.462141475166, 10546.209034322457, 10552.419616921143, 10570.735731606617, 10571.841422378671, 10585.206109541816, 5595.608307418442, 5598.664080155204, 5599.636023658449, 5602.38373778884, 5606.411326810708, 4620.399348084795, 5055.570276526463, 5074.2895994560795, 5124.9743751281, 5125.513076257749, 3774.2640185163627, 3824.330742120118, 3827.732058755916, 3869.7097717671286, 3913.9021524462114, 1286.7362190750873, 1288.072587736828, 1300.466808608466, 1310.1353106949368, 1315.9802602960963, 838.6771093129067, 934.5187228577153, 934.5467448287575, 939.4410325856105, 963.8554216867526, 5981.551383646244, 6013.398660134039, 6068.514518838482, 6107.8473038173515, 6142.815715528542, 948.9478078705738, 963.629002833914, 966.2849491376331, 1012.2458768217725, 1070.3738313086776, 4168.416421700964, 4369.191699535596, 4383.912321753547, 4385.232584297735, 4426.26966550522, 10889.727756805985, 11044.723881903017, 11229.438528073564, 11256.774864502664, 11269.21115521922, 10293.794124117476, 10531.789364212673, 11241.100711943025, 11259.605913792979, 11291.0, 7935.603219838985, 8107.270345668918, 8108.554029528433, 8131.2681858633005, 8134.75595732129, 6190.41191086846, 6249.96875015622, 6280.120783090462, 6341.619502829845, 6402.423781859655, 10314.071733544017, 10346.37921724699, 10353.119984801377, 10362.274640775375, 10461.529231184768, 10263.538140783832, 10356.689299321033, 10393.896061039293, 10555.788884222118, 10679.19906007037, 7116.964415177891, 7732.188120247293, 7986.321162701003, 8002.319802816825, 8019.478733882279, 7702.884456733265, 7933.0, 8130.146334635015, 8139.75580732579, 8395.412321137463, 7356.374708149867, 7386.113666360071, 7503.812404689927, 7626.237376262329, 7710.807229819299, 7182.533135346186, 7485.401167906445, 7529.8117547061765, 7592.468527203043, 7771.33943614799, 7114.6442677866935, 7226.710931562889, 7247.094113235846, 7253.782386528413, 7255.419566434778, 5202.401723801811, 5295.152775555893, 5296.311479507794, 5324.8136315228785, 5501.982133305351, 5425.864353391197, 5480.616356854982, 5514.6139770217305, 5623.775048998158, 5678.20505129274], "value": 4789.891971860892, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.7265201512781, 344.2066037782911, 348.28775154808415, 351.12394575534046, 356.09196548800566, 5053.292539044537, 5287.68273903566, 5342.679439233649, 5367.221752845835, 5408.918866217005, 5142.357205349332, 5253.581532986092, 5254.868628284295, 5304.761285742141, 5336.733163341827, 4188.623023927846, 4207.8007767786185, 4217.0, 4220.219259437006, 4240.681948853849, 4040.5151381834075, 4147.336426171813, 4223.598758117974, 4253.2769429197115, 4253.404523366731, 4089.284375234322, 4096.8975775605695, 4126.00975765817, 4144.632271350462, 4166.916661666764, 4085.7344272622186, 4088.9386659200136, 4092.7544347339253, 4120.649744771668, 4162.229987452331, 3666.9816650916573, 3669.7706268400116, 3682.2635472905527, 3686.5207523022104, 3688.3729765939856, 5145.897082058338, 5147.430033839677, 5186.559142472856, 5212.374515058217, 5231.921521177185, 4710.693804902705, 4724.362211101526, 4747.430308362984, 4761.642876784221, 4771.807048237941, 5371.0, 5511.145772405283, 5517.668939863621, 5524.944750552523, 5532.253145825302, 3958.1885713428965, 3964.6630036446936, 3968.8015599219925, 3973.523177218752, 3996.440498330236, 5688.914666280009, 5694.60482181864, 5700.914486282709, 5703.999999999958, 5721.742521586539, 4041.535223449282, 4066.7356621819486, 4072.635667051571, 4102.200070986189, 4102.2410853992105, 4059.512858456945, 4120.587941205856, 4132.462779838662, 4139.296319625671, 4156.688248381383, 4636.142313671981, 4652.511486293958, 4654.185517534418, 4679.625629949596, 4692.483826779052, 5502.752376143083, 5523.337199536081, 5536.695481748542, 5555.8888822223325, 5566.137248726453, 1277.7125146841886, 1318.1102755640097, 1318.7142536027488, 1371.4582739817715, 1372.8078069070339, 939.8402271613842, 952.9374747157009, 955.9283053770995, 964.5466630683568, 973.522973742875, 5108.335916330853, 5115.539601435814, 5121.206213036985, 5148.0, 5175.896482070338, 5391.78432862689, 5398.946010539844, 5406.94507603203, 5408.45915408456, 5464.098423760114, 4840.854774356704, 5111.207762796773, 5130.666506677054, 5148.613853960968, 5185.351831021122, 2839.3043704292168, 2870.6985766494217, 2871.9282017949718, 2876.223419676676, 2878.510653188963, 5555.972220138873, 5564.805231816867, 5571.8885622288135, 5572.4148964358155, 5607.943920560824, 5294.861604754996, 5417.404085550586, 5434.510894019557, 5446.945530544723, 5510.862228444321, 5526.613137080446, 5549.556035517229, 5551.750171242304, 5567.717235933248, 5570.275864137636, 5279.551238144801, 5346.599005074713, 5413.593980451561, 5427.945720542744, 5436.565074794086, 5297.629165958346, 5308.124159513637, 5329.813456529003, 5351.678899266057, 5355.169948657965, 5549.250851135045, 5574.358948720949, 5588.938101760653, 5615.32616086056, 5637.8590535236945, 3721.720870934745, 3883.1457079442475, 3888.455616213676, 3907.648311651965, 3917.5690674025263, 5344.973275133755, 5380.677159370451, 5387.973060134831, 5401.837944861661, 5448.019356515707, 5415.2147938547905, 5453.754581043783, 5490.725463726718, 5547.335799260287, 5554.472325129106, 5517.200005999028, 5535.16972454119, 5544.61187716856, 5552.666839989613, 5559.581582011838, 5290.28581141541, 5445.40100588927, 5486.506214440719, 5526.613137080366, 5534.363548191848, 5576.553875690016, 5583.134614134816, 5600.299962504687, 5612.607117501736, 5623.3814280428305, 5491.983982963165, 5492.835214943558, 5498.45015498447, 5500.257465242141, 5505.9724701376235], "value": 4169.195620547393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.1008829757483, 795.4908858330666, 800.0359566722101, 835.1231207232404, 843.3421930893901, 14884.0, 15820.604484887883, 16200.270987805548, 16720.331186752515, 16910.577235569115, 14833.85166148341, 15068.171250581214, 16041.839581604181, 16219.026858388504, 16223.675526489464, 823.8228780812124, 840.3823189955378, 842.1620487614832, 842.6713581703141, 842.93256539477, 717.2003216413688, 721.4336745654662, 804.3243675312737, 825.2325337436182, 829.9460535065232, 882.4484697064335, 885.0618344554761, 885.6368888755611, 887.3078998381241, 889.1641856654724, 878.8110556230378, 881.4843316659761, 881.823635272948, 883.8188171424874, 884.8761173435724, 545.0516101982562, 555.6499405374589, 624.1386886097157, 629.4743888852813, 633.2306247908767, 14594.854051459455, 14597.416103355854, 14598.708025839423, 14625.122492650475, 14657.41370345185, 13822.723545529034, 14024.859751402457, 14030.1581905085, 14136.363863626162, 14138.787918181235, 12811.87188128116, 12895.871041289562, 12927.67680807978, 12958.80561791574, 13111.60665180046, 4354.281543545343, 4417.845375411845, 4440.511543730219, 4454.510003899569, 4532.660050496193, 59386.14707431215, 61363.0, 62189.0, 62805.371946280866, 62945.0, 10830.891691083147, 11044.116470682326, 11292.604758833402, 11333.886661133449, 11683.299002059903, 19970.800291997184, 19994.70007949882, 20201.898990505248, 20237.49406264855, 20259.493512662008, 8328.916710832815, 8393.370497212734, 8434.73879051858, 8684.913150868411, 8691.304695624334, 4557.339185818104, 4560.429946256718, 4632.698874573142, 4734.455537613218, 4800.903981920342, 3614.2771445710964, 3725.1245957200035, 3729.0, 3729.2355067211156, 3730.9067273318383, 675.378651640492, 688.3942130924854, 690.6960937187621, 692.4840993459904, 726.6984201556295, 735.0481126940625, 768.6771555946516, 769.8113962079326, 771.3828936850497, 779.9649015794303, 9355.766105847408, 9452.243820494345, 9495.620175193053, 9913.702588922344, 9968.501574921225, 725.9237780033126, 727.6761840980713, 742.4505865659481, 745.5452174173749, 753.0, 4785.760711964388, 4863.708177509361, 4906.435759887588, 4960.156773348467, 5020.920502091994, 88060.5596972011, 90550.54724726334, 91137.54431227801, 92406.53796730973, 94033.0, 83085.0, 83452.0, 84145.0, 86444.56777716072, 86768.0, 71768.64115679388, 72607.2739272611, 73791.63104184445, 74966.0, 75625.24374756293, 9951.15415189688, 9986.60053597848, 10016.1987041038, 10063.899361006297, 10064.691590093535, 42607.78696106624, 45255.77372113118, 45795.77102114468, 46613.533864660916, 47653.0, 39768.0, 39950.400743988284, 50620.0, 63926.0, 64827.35172648402, 12543.686407839878, 12670.683232919251, 12908.677283067998, 13010.739785204432, 13060.415255250453, 14207.64480887986, 14436.350364233425, 14566.19885906243, 14763.704725905636, 15211.163386013433, 13240.80138797938, 13304.401301941241, 13416.32918354098, 13585.660358491117, 13723.725525489634, 13232.735345293233, 13407.525172231242, 13410.664733381744, 13436.925045996491, 13672.111312764639, 13316.667083322995, 13600.795988060385, 13644.522441714493, 13747.0, 14067.788983165465, 10443.373397596168, 10594.15246780271, 10835.620753273597, 11301.378424186749, 11312.773744525228, 9650.0, 11019.078178245278, 11085.667429977113, 11207.943960280147, 11297.322160670057], "value": 7413.701103056333, "unit": "score"}], "name": "dromaeo_css", "value": 7313.875792192398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 110.0, 116.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 121.0, 155.0, 125.0, 124.0, 119.0, 122.0, 153.0, 127.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 160.0, 160.0, 159.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 115.0, 77.0, 75.0, 75.0, 75.0, 97.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 114.0, 81.0, 81.0, 81.0, 115.0, 82.0, 81.0, 120.0], "value": 91.8, "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, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 51.0, 50.0, 57.0, 52.0, 50.0, 49.0, 49.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 57.0, 59.0, 59.0, 57.0, 58.0, 58.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 75.0, 74.0, 73.0, 83.0, 77.0, 74.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 125.0, 127.0, 126.0, 125.0, 125.0, 120.0, 169.0, 136.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 156.0, 157.0, 158.0, 153.0, 155.0, 153.0, 152.0, 153.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 64.0, 61.0, 60.0, 61.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1457.5, "alertThreshold": 2.0}]} 12:16:05 INFO - Return code: 0 12:16:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:16:05 ERROR - # TBPL SUCCESS # 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - [mozharness: 2016-11-14 20:16:05.569297Z] Finished run-tests step (success) 12:16:05 INFO - Running post-run listener: _resource_record_post_run 12:16:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355856384; Read time: 8; Write time: 278548 12:16:05 INFO - TinderboxPrint: CPU usage
13.0% 12:16:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:16:05 INFO - TinderboxPrint: I/O write bytes / time
355,856,384 / 278,548 12:16:05 INFO - TinderboxPrint: CPU idle
8,277.5 (87.0%) 12:16:05 INFO - TinderboxPrint: CPU user
1,191.7 (12.5%) 12:16:05 INFO - TinderboxPrint: Swap in / out
0 / 0 12:16:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109432832; Read time: 0; Write time: 115248 12:16:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 245927936; Read time: 0; Write time: 163240 12:16:06 INFO - Running post-run listener: _upload_blobber_files 12:16:06 INFO - Blob upload gear active. 12:16:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:16:06 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:16:06 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:16:06 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:16:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:09 INFO - (blobuploader) - INFO - Done attempting. 12:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:10 INFO - (blobuploader) - INFO - Done attempting. 12:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:11 INFO - (blobuploader) - INFO - Done attempting. 12:16:11 INFO - (blobuploader) - INFO - Iteration through files over. 12:16:11 INFO - Return code: 0 12:16:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:16:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:16:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21c0a103181aa4de1dde2f25475f7fa94405e54637b8a71bb3a6ac7541d2da74a38634a9b250db42e650d6e93ff71b73d57135ab59ef0322a1106af380e4fd8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50fe7eadd29a53695cd4abf957922f6c89925ba7fd7c4f8ac77ed7f0db14035f5d6bd6639a4fe69724f349aa2a2d94af757c3ebc279ff6cb320c472879971fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8d46db1d878fd62e04ab1d8fc121466852832f21e7bab5b464f7f2df081471b514c9c8808bb07365d2dcca2ff0c47ec2e8768144da4a85efe357e87b4decf6"} 12:16:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:16:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:16:11 INFO - Contents: 12:16:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21c0a103181aa4de1dde2f25475f7fa94405e54637b8a71bb3a6ac7541d2da74a38634a9b250db42e650d6e93ff71b73d57135ab59ef0322a1106af380e4fd8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50fe7eadd29a53695cd4abf957922f6c89925ba7fd7c4f8ac77ed7f0db14035f5d6bd6639a4fe69724f349aa2a2d94af757c3ebc279ff6cb320c472879971fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8d46db1d878fd62e04ab1d8fc121466852832f21e7bab5b464f7f2df081471b514c9c8808bb07365d2dcca2ff0c47ec2e8768144da4a85efe357e87b4decf6"} 12:16:11 INFO - Running post-run listener: copy_logs_to_upload_dir 12:16:11 INFO - Copying logs to upload dir... 12:16:11 INFO - mkdir: /builds/slave/test/build/upload/logs 12:16:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.785489 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-14 12:16:11.692975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:16:11.697199) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562 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/21c0a103181aa4de1dde2f25475f7fa94405e54637b8a71bb3a6ac7541d2da74a38634a9b250db42e650d6e93ff71b73d57135ab59ef0322a1106af380e4fd8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50fe7eadd29a53695cd4abf957922f6c89925ba7fd7c4f8ac77ed7f0db14035f5d6bd6639a4fe69724f349aa2a2d94af757c3ebc279ff6cb320c472879971fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8d46db1d878fd62e04ab1d8fc121466852832f21e7bab5b464f7f2df081471b514c9c8808bb07365d2dcca2ff0c47ec2e8768144da4a85efe357e87b4decf6"} 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.011671 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/21c0a103181aa4de1dde2f25475f7fa94405e54637b8a71bb3a6ac7541d2da74a38634a9b250db42e650d6e93ff71b73d57135ab59ef0322a1106af380e4fd8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50fe7eadd29a53695cd4abf957922f6c89925ba7fd7c4f8ac77ed7f0db14035f5d6bd6639a4fe69724f349aa2a2d94af757c3ebc279ff6cb320c472879971fa5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8d46db1d878fd62e04ab1d8fc121466852832f21e7bab5b464f7f2df081471b514c9c8808bb07365d2dcca2ff0c47ec2e8768144da4a85efe357e87b4decf6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:16:11.725054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:16:11.725458) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479153335.54820-1862099562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:16:11.808978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:16:11.809337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:16:11.809937) ========= ========= Total master_lag: 0.17 =========