builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1487881108.74 results: success (0) buildid: 20170223103422 builduid: e72edaab5e914261aba9f214665ab98c revision: 02a085cba71fb767d17d3e3e33f252da066f5d41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.744816) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.745650) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.745958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.762721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.763008) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-23 12:18:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.4M=0s 2017-02-23 12:18:29 (89.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.859412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.859752) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018988 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:28.909252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 12:18:28.909656) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 02a085cba71fb767d17d3e3e33f252da066f5d41 --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-beta --rev 02a085cba71fb767d17d3e3e33f252da066f5d41 --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=e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-23 12:18:30,042 truncating revision to first 12 chars 2017-02-23 12:18:30,042 Setting DEBUG logging. 2017-02-23 12:18:30,042 attempt 1/10 2017-02-23 12:18:30,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/02a085cba71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 12:18:30,783 unpacking tar archive at: mozilla-beta-02a085cba71f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.004313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 12:18:29.927447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:29.927787) ========= script_repo_revision: 02a085cba71fb767d17d3e3e33f252da066f5d41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:29.928227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:29.928524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 12:18:29.937829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-23 12:18:29.938143) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:18:31 INFO - MultiFileLogger online at 20170223 12:18:31 in /builds/slave/test 12:18:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:18:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:31 INFO - {'append_to_log': False, 12:18:31 INFO - 'base_work_dir': '/builds/slave/test', 12:18:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:18:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:31 INFO - 'branch': 'Mozilla-Beta', 12:18:31 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:31 INFO - 'config_files': ('talos/linux_config.py',), 12:18:31 INFO - 'default_actions': ('clobber', 12:18:31 INFO - 'read-buildbot-config', 12:18:31 INFO - 'download-and-extract', 12:18:31 INFO - 'populate-webroot', 12:18:31 INFO - 'create-virtualenv', 12:18:31 INFO - 'install', 12:18:31 INFO - 'run-tests'), 12:18:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:31 INFO - 'download_minidump_stackwalk': True, 12:18:31 INFO - 'download_symbols': 'ondemand', 12:18:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:31 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:31 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:31 INFO - 'installer_path': 'installer.exe', 12:18:31 INFO - 'log_level': 'info', 12:18:31 INFO - 'log_name': 'talos', 12:18:31 INFO - 'log_to_console': True, 12:18:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:18:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:18:31 INFO - 'opt_config_files': (), 12:18:31 INFO - 'pip_index': False, 12:18:31 INFO - 'sps_profile': False, 12:18:31 INFO - 'sps_profile_interval': 0, 12:18:31 INFO - 'suite': 'dromaeojs', 12:18:31 INFO - 'system_bits': '32', 12:18:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:31 INFO - 'title': 'talos-linux64-ix-006', 12:18:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:31 INFO - 'use_talos_json': True, 12:18:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:31 INFO - 'work_dir': 'build'} 12:18:31 INFO - [mozharness: 2017-02-23 20:18:31.164497Z] Running clobber step. 12:18:31 INFO - Running pre-action listener: _resource_record_pre_action 12:18:31 INFO - Running main action method: clobber 12:18:31 INFO - rmtree: /builds/slave/test/build 12:18:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:32 INFO - Running post-action listener: _resource_record_post_action 12:18:32 INFO - [mozharness: 2017-02-23 20:18:32.077107Z] Finished clobber step (success) 12:18:32 INFO - [mozharness: 2017-02-23 20:18:32.077206Z] Running read-buildbot-config step. 12:18:32 INFO - Running pre-action listener: _resource_record_pre_action 12:18:32 INFO - Running main action method: read_buildbot_config 12:18:32 INFO - Using buildbot properties: 12:18:32 INFO - { 12:18:32 INFO - "project": "", 12:18:32 INFO - "product": "firefox", 12:18:32 INFO - "script_repo_revision": "production", 12:18:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:18:32 INFO - "repository": "", 12:18:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:18:32 INFO - "buildid": "20170223103422", 12:18:32 INFO - "pgo_build": "True", 12:18:32 INFO - "basedir": "/builds/slave/test", 12:18:32 INFO - "buildnumber": 150, 12:18:32 INFO - "slavename": "talos-linux64-ix-006", 12:18:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:18:32 INFO - "platform": "ubuntu64_hw", 12:18:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:18:32 INFO - "branch": "mozilla-beta", 12:18:32 INFO - "repo_path": "releases/mozilla-beta", 12:18:32 INFO - "revision": "02a085cba71fb767d17d3e3e33f252da066f5d41", 12:18:32 INFO - "stage_platform": "linux64-pgo", 12:18:32 INFO - "builduid": "e72edaab5e914261aba9f214665ab98c", 12:18:32 INFO - "slavebuilddir": "test" 12:18:32 INFO - } 12:18:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 12:18:32 INFO - Running post-action listener: _resource_record_post_action 12:18:32 INFO - [mozharness: 2017-02-23 20:18:32.079614Z] Finished read-buildbot-config step (success) 12:18:32 INFO - [mozharness: 2017-02-23 20:18:32.079702Z] Running download-and-extract step. 12:18:32 INFO - Running pre-action listener: _resource_record_pre_action 12:18:32 INFO - Running main action method: download_and_extract 12:18:32 INFO - mkdir: /builds/slave/test/build/tests 12:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:32 INFO - trying https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:18:32 INFO - Downloading https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:18:32 INFO - Downloaded 1327 bytes. 12:18:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:18:32 INFO - Using the following test package requirements: 12:18:32 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:18:32 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:18:32 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 12:18:32 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'jsshell-linux-x86_64.zip'], 12:18:32 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:18:32 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:18:32 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 12:18:32 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 12:18:32 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:18:32 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:32 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:18:32 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:18:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:18:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:18:32 INFO - Fetch https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:18:33 INFO - Http code: 200 12:18:33 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 12:18:33 INFO - x-amz-cf-id: VWt5GPNAuMJqX0Iu_ARjNdXjA82jkut2L8KhWpDhW6-3gN4MNLQqgg== 12:18:33 INFO - x-amz-version-id: ppxK3y3m8Sn4QvezaqLa01MgOsE99ld7 12:18:33 INFO - Expected file size: 21963625 12:18:33 INFO - Obtained file size: 21963625 12:18:37 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:18:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:18:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:18:37 INFO - Fetch https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:18:38 INFO - Http code: 200 12:18:38 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 12:18:38 INFO - x-amz-cf-id: wAUQr1YvVL6ZAben_ePQaKLSRSJfv69usb2LnWeViVH5KLjUHd1ApA== 12:18:38 INFO - x-amz-version-id: ppxK3y3m8Sn4QvezaqLa01MgOsE99ld7 12:18:38 INFO - Expected file size: 21963625 12:18:38 INFO - Obtained file size: 21963625 12:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 12:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 12:18:44 INFO - Http code: 200 12:18:44 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 12:18:44 INFO - x-amz-cf-id: sybbLH1BYs0vUdJiCIhW9qdXfsyi-IuCYHS4rN-m5RL5gsZSDasc4Q== 12:18:44 INFO - x-amz-version-id: kcDkucxBVH_spBNkqlNVEXzPsLZJd1c9 12:18:44 INFO - Expected file size: 14403005 12:18:44 INFO - Obtained file size: 14403005 12:18:44 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')]} 12:18:44 INFO - trying https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:18:46 INFO - Downloaded 57737193 bytes. 12:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:46 INFO - mkdir: /builds/slave/test/properties 12:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:46 INFO - Contents: 12:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:47 INFO - Running post-action listener: _resource_record_post_action 12:18:47 INFO - Running post-action listener: set_extra_try_arguments 12:18:47 INFO - [mozharness: 2017-02-23 20:18:47.679117Z] Finished download-and-extract step (success) 12:18:47 INFO - [mozharness: 2017-02-23 20:18:47.679344Z] Running populate-webroot step. 12:18:47 INFO - Running pre-action listener: _resource_record_pre_action 12:18:47 INFO - Running main action method: populate_webroot 12:18:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:47 INFO - '--tppagecycles', 12:18:47 INFO - '7'], 12:18:47 INFO - 'tests': ['tsvgm']}}, 12:18:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['damp', 'tps']}, 12:18:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'tests': ['damp', 'tps']}, 12:18:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['dromaeo_dom']}, 12:18:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['basic_compositor_video']}, 12:18:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:18:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tsvgx', 12:18:47 INFO - 'tsvgr_opacity', 12:18:47 INFO - 'tart', 12:18:47 INFO - 'tscrollx', 12:18:47 INFO - 'cart']}, 12:18:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:47 INFO - 'tsvgr_opacity', 12:18:47 INFO - 'tart', 12:18:47 INFO - 'tscrollx', 12:18:47 INFO - 'cart']}, 12:18:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tp5o']}, 12:18:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'tests': ['tp5o']}, 12:18:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s', 12:18:47 INFO - '--xperf_path', 12:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:47 INFO - 'tests': ['tp5n']}, 12:18:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--xperf_path', 12:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:47 INFO - 'tests': ['tp5n']}}, 12:18:47 INFO - 'talos.zip': {'path': '', 12:18:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:47 INFO - Running post-action listener: _resource_record_post_action 12:18:47 INFO - [mozharness: 2017-02-23 20:18:47.695536Z] Finished populate-webroot step (success) 12:18:47 INFO - [mozharness: 2017-02-23 20:18:47.695624Z] Running create-virtualenv step. 12:18:47 INFO - Running pre-action listener: _resource_record_pre_action 12:18:47 INFO - Running main action method: create_virtualenv 12:18:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:47 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 12:18:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:47 INFO - Using real prefix '/usr' 12:18:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:50 INFO - Installing pip.................done. 12:18:50 INFO - Return code: 0 12:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:18:50 INFO - Reading from file tmpfile_stdout 12:18:50 INFO - Output received: 12:18:50 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) 12:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18:50 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')]} 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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')]} 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:18:50 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 12:18:50 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 12:18:50 INFO - Using env: {'DISPLAY': ':0', 12:18:50 INFO - 'HOME': '/home/cltbld', 12:18:50 INFO - 'LANG': 'en_US.UTF-8', 12:18:50 INFO - 'LANGUAGE': 'en_US:en', 12:18:50 INFO - 'LOGNAME': 'cltbld', 12:18:50 INFO - 'MAIL': '/var/mail/cltbld', 12:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:50 INFO - 'MOZ_NO_REMOTE': '1', 12:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:50 INFO - 'NO_EM_RESTART': '1', 12:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:50 INFO - 'PWD': '/builds/slave/test', 12:18:50 INFO - 'SHELL': '/bin/bash', 12:18:50 INFO - 'SHLVL': '1', 12:18:50 INFO - 'TERM': 'linux', 12:18:50 INFO - 'TMOUT': '86400', 12:18:50 INFO - 'USER': 'cltbld', 12:18:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:50 INFO - '_': '/tools/buildbot/bin/python'} 12:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:50 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 12:18:50 INFO - Cleaning up... 12:18:50 INFO - Return code: 0 12:18:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:18:50 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')]} 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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')]} 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:18:50 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 12:18:50 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 12:18:50 INFO - Using env: {'DISPLAY': ':0', 12:18:50 INFO - 'HOME': '/home/cltbld', 12:18:50 INFO - 'LANG': 'en_US.UTF-8', 12:18:50 INFO - 'LANGUAGE': 'en_US:en', 12:18:50 INFO - 'LOGNAME': 'cltbld', 12:18:50 INFO - 'MAIL': '/var/mail/cltbld', 12:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:50 INFO - 'MOZ_NO_REMOTE': '1', 12:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:50 INFO - 'NO_EM_RESTART': '1', 12:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:50 INFO - 'PWD': '/builds/slave/test', 12:18:50 INFO - 'SHELL': '/bin/bash', 12:18:50 INFO - 'SHLVL': '1', 12:18:50 INFO - 'TERM': 'linux', 12:18:50 INFO - 'TMOUT': '86400', 12:18:50 INFO - 'USER': 'cltbld', 12:18:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:50 INFO - '_': '/tools/buildbot/bin/python'} 12:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:50 INFO - Downloading/unpacking psutil>=3.1.1 12:18:50 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 12:18:50 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 12:18:50 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 12:18:50 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 12:18:50 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 12:18:50 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 12:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:53 INFO - Installing collected packages: psutil 12:18:53 INFO - Running setup.py install for psutil 12:18:53 INFO - building 'psutil._psutil_linux' extension 12:18:53 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 12:18:53 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 12:18:53 INFO - building 'psutil._psutil_posix' extension 12:18:53 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 12:18:53 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 12:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:53 INFO - Successfully installed psutil 12:18:53 INFO - Cleaning up... 12:18:53 INFO - Return code: 0 12:18:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:18: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 mozsystemmonitor==0.3 12:18:53 INFO - Using env: {'DISPLAY': ':0', 12:18:53 INFO - 'HOME': '/home/cltbld', 12:18:53 INFO - 'LANG': 'en_US.UTF-8', 12:18:53 INFO - 'LANGUAGE': 'en_US:en', 12:18:53 INFO - 'LOGNAME': 'cltbld', 12:18:53 INFO - 'MAIL': '/var/mail/cltbld', 12:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:53 INFO - 'MOZ_NO_REMOTE': '1', 12:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:53 INFO - 'NO_EM_RESTART': '1', 12:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:53 INFO - 'PWD': '/builds/slave/test', 12:18:53 INFO - 'SHELL': '/bin/bash', 12:18:53 INFO - 'SHLVL': '1', 12:18:53 INFO - 'TERM': 'linux', 12:18:53 INFO - 'TMOUT': '86400', 12:18:53 INFO - 'USER': 'cltbld', 12:18:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:53 INFO - '_': '/tools/buildbot/bin/python'} 12:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 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 12:18:53 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 12:18:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:18:55 INFO - Installing collected packages: mozsystemmonitor 12:18:55 INFO - Running setup.py install for mozsystemmonitor 12:18:56 INFO - Successfully installed mozsystemmonitor 12:18:56 INFO - Cleaning up... 12:18:56 INFO - Return code: 0 12:18:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:18:56 INFO - Using env: {'DISPLAY': ':0', 12:18:56 INFO - 'HOME': '/home/cltbld', 12:18:56 INFO - 'LANG': 'en_US.UTF-8', 12:18:56 INFO - 'LANGUAGE': 'en_US:en', 12:18:56 INFO - 'LOGNAME': 'cltbld', 12:18:56 INFO - 'MAIL': '/var/mail/cltbld', 12:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:56 INFO - 'MOZ_NO_REMOTE': '1', 12:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:56 INFO - 'NO_EM_RESTART': '1', 12:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:56 INFO - 'PWD': '/builds/slave/test', 12:18:56 INFO - 'SHELL': '/bin/bash', 12:18:56 INFO - 'SHLVL': '1', 12:18:56 INFO - 'TERM': 'linux', 12:18:56 INFO - 'TMOUT': '86400', 12:18:56 INFO - 'USER': 'cltbld', 12:18:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:56 INFO - '_': '/tools/buildbot/bin/python'} 12:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:56 INFO - Downloading/unpacking jsonschema==2.5.1 12:18:56 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 12:18:56 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 12:18:56 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 12:18:56 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 12:18:56 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 12:18:56 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 12:18:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:58 INFO - warning: no files found matching '*.txt' 12:18:58 INFO - no previously-included directories found matching 'build' 12:18:58 INFO - no previously-included directories found matching 'dist' 12:18:58 INFO - no previously-included directories found matching '.git*' 12:18:58 INFO - Installing collected packages: jsonschema, functools32 12:18:58 INFO - Running setup.py install for functools32 12:18:58 INFO - warning: no files found matching '*.txt' 12:18:58 INFO - no previously-included directories found matching 'build' 12:18:58 INFO - no previously-included directories found matching 'dist' 12:18:58 INFO - no previously-included directories found matching '.git*' 12:18:58 INFO - Successfully installed jsonschema functools32 12:18:58 INFO - Cleaning up... 12:18:58 INFO - Return code: 0 12:18:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:18:58 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')]} 12:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:58 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')]} 12:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:58 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 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:18:58 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 12:18:58 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 12:18:58 INFO - Using env: {'DISPLAY': ':0', 12:18:58 INFO - 'HOME': '/home/cltbld', 12:18:58 INFO - 'LANG': 'en_US.UTF-8', 12:18:58 INFO - 'LANGUAGE': 'en_US:en', 12:18:58 INFO - 'LOGNAME': 'cltbld', 12:18:58 INFO - 'MAIL': '/var/mail/cltbld', 12:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:58 INFO - 'MOZ_NO_REMOTE': '1', 12:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:58 INFO - 'NO_EM_RESTART': '1', 12:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:58 INFO - 'PWD': '/builds/slave/test', 12:18:58 INFO - 'SHELL': '/bin/bash', 12:18:58 INFO - 'SHLVL': '1', 12:18:58 INFO - 'TERM': 'linux', 12:18:58 INFO - 'TMOUT': '86400', 12:18:58 INFO - 'USER': 'cltbld', 12:18:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:58 INFO - '_': '/tools/buildbot/bin/python'} 12:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:18:59 INFO - Cleaning up... 12:18:59 INFO - Return code: 0 12:18:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:18:59 INFO - Using env: {'DISPLAY': ':0', 12:18:59 INFO - 'HOME': '/home/cltbld', 12:18:59 INFO - 'LANG': 'en_US.UTF-8', 12:18:59 INFO - 'LANGUAGE': 'en_US:en', 12:18:59 INFO - 'LOGNAME': 'cltbld', 12:18:59 INFO - 'MAIL': '/var/mail/cltbld', 12:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:59 INFO - 'MOZ_NO_REMOTE': '1', 12:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:59 INFO - 'NO_EM_RESTART': '1', 12:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:59 INFO - 'PWD': '/builds/slave/test', 12:18:59 INFO - 'SHELL': '/bin/bash', 12:18:59 INFO - 'SHLVL': '1', 12:18:59 INFO - 'TERM': 'linux', 12:18:59 INFO - 'TMOUT': '86400', 12:18:59 INFO - 'USER': 'cltbld', 12:18:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:59 INFO - '_': '/tools/buildbot/bin/python'} 12:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:19:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:02 INFO - Downloading docopt-0.6.1.tar.gz 12:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:02 INFO - Running setup.py install for blobuploader 12:19:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:02 INFO - Running setup.py install for requests 12:19:02 INFO - Running setup.py install for docopt 12:19:02 INFO - Successfully installed blobuploader requests docopt 12:19:02 INFO - Cleaning up... 12:19:02 INFO - Return code: 0 12:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:02 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 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:19:02 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 12:19:02 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 12:19:02 INFO - Using env: {'DISPLAY': ':0', 12:19:02 INFO - 'HOME': '/home/cltbld', 12:19:02 INFO - 'LANG': 'en_US.UTF-8', 12:19:02 INFO - 'LANGUAGE': 'en_US:en', 12:19:02 INFO - 'LOGNAME': 'cltbld', 12:19:02 INFO - 'MAIL': '/var/mail/cltbld', 12:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:02 INFO - 'MOZ_NO_REMOTE': '1', 12:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:02 INFO - 'NO_EM_RESTART': '1', 12:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:02 INFO - 'PWD': '/builds/slave/test', 12:19:02 INFO - 'SHELL': '/bin/bash', 12:19:02 INFO - 'SHLVL': '1', 12:19:02 INFO - 'TERM': 'linux', 12:19:02 INFO - 'TMOUT': '86400', 12:19:02 INFO - 'USER': 'cltbld', 12:19:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:02 INFO - '_': '/tools/buildbot/bin/python'} 12:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:03 INFO - Running setup.py (path:/tmp/pip-SerQnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:03 INFO - Running setup.py (path:/tmp/pip-IoF2Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:03 INFO - Running setup.py (path:/tmp/pip-TasEzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:03 INFO - Running setup.py (path:/tmp/pip-P4U0Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:03 INFO - Running setup.py (path:/tmp/pip-OOSj4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:03 INFO - Running setup.py (path:/tmp/pip-cLDJNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:03 INFO - Running setup.py (path:/tmp/pip-M4EY2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:03 INFO - Running setup.py (path:/tmp/pip-0G2lo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:03 INFO - Running setup.py (path:/tmp/pip-Oihoco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:03 INFO - Running setup.py (path:/tmp/pip-qUirBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:03 INFO - Running setup.py (path:/tmp/pip-nhDy14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:04 INFO - Running setup.py (path:/tmp/pip-bDvsS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:04 INFO - Running setup.py (path:/tmp/pip-MVCQct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:04 INFO - Running setup.py (path:/tmp/pip-_Y2VkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:04 INFO - Running setup.py (path:/tmp/pip-nm7PsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:04 INFO - Running setup.py (path:/tmp/pip-MJHPLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:04 INFO - Running setup.py (path:/tmp/pip-IwOhC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:04 INFO - Running setup.py install for manifestparser 12:19:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozcrash 12:19:04 INFO - Running setup.py install for mozdebug 12:19:04 INFO - Running setup.py install for mozdevice 12:19:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozfile 12:19:04 INFO - Running setup.py install for mozhttpd 12:19:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozinfo 12:19:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozInstall 12:19:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozleak 12:19:05 INFO - Running setup.py install for mozlog 12:19:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for moznetwork 12:19:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozprocess 12:19:05 INFO - Running setup.py install for mozprofile 12:19:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozrunner 12:19:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozscreenshot 12:19:06 INFO - Running setup.py install for moztest 12:19:06 INFO - Running setup.py install for mozversion 12:19:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:06 INFO - Cleaning up... 12:19:06 INFO - Return code: 0 12:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:06 INFO - Using env: {'DISPLAY': ':0', 12:19:06 INFO - 'HOME': '/home/cltbld', 12:19:06 INFO - 'LANG': 'en_US.UTF-8', 12:19:06 INFO - 'LANGUAGE': 'en_US:en', 12:19:06 INFO - 'LOGNAME': 'cltbld', 12:19:06 INFO - 'MAIL': '/var/mail/cltbld', 12:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:06 INFO - 'MOZ_NO_REMOTE': '1', 12:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:06 INFO - 'NO_EM_RESTART': '1', 12:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:06 INFO - 'PWD': '/builds/slave/test', 12:19:06 INFO - 'SHELL': '/bin/bash', 12:19:06 INFO - 'SHLVL': '1', 12:19:06 INFO - 'TERM': 'linux', 12:19:06 INFO - 'TMOUT': '86400', 12:19:06 INFO - 'USER': 'cltbld', 12:19:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:06 INFO - '_': '/tools/buildbot/bin/python'} 12:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:06 INFO - Running setup.py (path:/tmp/pip-_4BF1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:06 INFO - Running setup.py (path:/tmp/pip-b9IDQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:06 INFO - Running setup.py (path:/tmp/pip-Y3tfcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:06 INFO - Running setup.py (path:/tmp/pip-tGsZ1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:06 INFO - Running setup.py (path:/tmp/pip-a2tLAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:06 INFO - Running setup.py (path:/tmp/pip-LNc20u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:06 INFO - Running setup.py (path:/tmp/pip-Ee31q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:07 INFO - Running setup.py (path:/tmp/pip-4VApJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:07 INFO - Running setup.py (path:/tmp/pip-wY1RST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:07 INFO - Running setup.py (path:/tmp/pip-Q57rMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:07 INFO - Running setup.py (path:/tmp/pip-dcHh4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:07 INFO - Running setup.py (path:/tmp/pip-_HpfvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:07 INFO - Running setup.py (path:/tmp/pip-DJCWTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:07 INFO - Running setup.py (path:/tmp/pip-56qPQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:07 INFO - Running setup.py (path:/tmp/pip-jMR20T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:07 INFO - Running setup.py (path:/tmp/pip-DL4tO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:07 INFO - Running setup.py (path:/tmp/pip-8KIOTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:07 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)) 12:19:07 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)) 12:19:07 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)) 12:19:07 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)) 12:19:07 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)) 12:19:07 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)) 12:19:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:07 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 12:19:07 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 12:19:07 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 12:19:07 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 12:19:07 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 12:19:07 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 12:19:09 INFO - Downloading blessings-1.6.tar.gz 12:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:09 INFO - Installing collected packages: blessings 12:19:09 INFO - Running setup.py install for blessings 12:19:10 INFO - Successfully installed blessings 12:19:10 INFO - Cleaning up... 12:19:10 INFO - Return code: 0 12:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:10 INFO - Reading from file tmpfile_stdout 12:19:10 INFO - Current package versions: 12:19:10 INFO - argparse == 1.2.1 12:19:10 INFO - blessings == 1.6 12:19:10 INFO - blobuploader == 1.2.4 12:19:10 INFO - docopt == 0.6.1 12:19:10 INFO - functools32 == 3.2.3-2 12:19:10 INFO - jsonschema == 2.5.1 12:19:10 INFO - manifestparser == 1.1 12:19:10 INFO - mozInstall == 1.12 12:19:10 INFO - mozcrash == 1.0 12:19:10 INFO - mozdebug == 0.1 12:19:10 INFO - mozdevice == 0.48 12:19:10 INFO - mozfile == 1.2 12:19:10 INFO - mozhttpd == 0.7 12:19:10 INFO - mozinfo == 0.9 12:19:10 INFO - mozleak == 0.1 12:19:10 INFO - mozlog == 3.4 12:19:10 INFO - moznetwork == 0.27 12:19:10 INFO - mozprocess == 0.23 12:19:10 INFO - mozprofile == 0.28 12:19:10 INFO - mozrunner == 6.13 12:19:10 INFO - mozscreenshot == 0.1 12:19:10 INFO - mozsystemmonitor == 0.3 12:19:10 INFO - moztest == 0.8 12:19:10 INFO - mozversion == 1.4 12:19:10 INFO - psutil == 3.1.1 12:19:10 INFO - requests == 1.2.3 12:19:10 INFO - wsgiref == 0.1.2 12:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:10 INFO - Using env: {'DISPLAY': ':0', 12:19:10 INFO - 'HOME': '/home/cltbld', 12:19:10 INFO - 'LANG': 'en_US.UTF-8', 12:19:10 INFO - 'LANGUAGE': 'en_US:en', 12:19:10 INFO - 'LOGNAME': 'cltbld', 12:19:10 INFO - 'MAIL': '/var/mail/cltbld', 12:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:10 INFO - 'MOZ_NO_REMOTE': '1', 12:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:10 INFO - 'NO_EM_RESTART': '1', 12:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:10 INFO - 'PWD': '/builds/slave/test', 12:19:10 INFO - 'SHELL': '/bin/bash', 12:19:10 INFO - 'SHLVL': '1', 12:19:10 INFO - 'TERM': 'linux', 12:19:10 INFO - 'TMOUT': '86400', 12:19:10 INFO - 'USER': 'cltbld', 12:19:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:10 INFO - '_': '/tools/buildbot/bin/python'} 12:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:19:10 INFO - Cleaning up... 12:19:10 INFO - Return code: 0 12:19:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad91f0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', '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 12:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:19:10 INFO - Using env: {'DISPLAY': ':0', 12:19:10 INFO - 'HOME': '/home/cltbld', 12:19:10 INFO - 'LANG': 'en_US.UTF-8', 12:19:10 INFO - 'LANGUAGE': 'en_US:en', 12:19:10 INFO - 'LOGNAME': 'cltbld', 12:19:10 INFO - 'MAIL': '/var/mail/cltbld', 12:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:10 INFO - 'MOZ_NO_REMOTE': '1', 12:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:10 INFO - 'NO_EM_RESTART': '1', 12:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:10 INFO - 'PWD': '/builds/slave/test', 12:19:10 INFO - 'SHELL': '/bin/bash', 12:19:10 INFO - 'SHLVL': '1', 12:19:10 INFO - 'TERM': 'linux', 12:19:10 INFO - 'TMOUT': '86400', 12:19:10 INFO - 'USER': 'cltbld', 12:19:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:10 INFO - '_': '/tools/buildbot/bin/python'} 12:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:10 INFO - Cleaning up... 12:19:10 INFO - Return code: 0 12:19:10 INFO - Running post-action listener: _resource_record_post_action 12:19:10 INFO - Running post-action listener: _start_resource_monitoring 12:19:10 INFO - Starting resource monitoring. 12:19:10 INFO - [mozharness: 2017-02-23 20:19:10.822871Z] Finished create-virtualenv step (success) 12:19:10 INFO - [mozharness: 2017-02-23 20:19:10.823368Z] Running install step. 12:19:10 INFO - Running pre-action listener: _resource_record_pre_action 12:19:10 INFO - Running main action method: install 12:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:11 INFO - Reading from file tmpfile_stdout 12:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:11 INFO - Reading from file tmpfile_stdout 12:19:11 INFO - Output received: 12:19:11 INFO - Usage: mozinstall [options] installer 12:19:11 INFO - Options: 12:19:11 INFO - -h, --help show this help message and exit 12:19:11 INFO - -d DEST, --destination=DEST 12:19:11 INFO - Directory to install application into. [default: 12:19:11 INFO - "/builds/slave/test"] 12:19:11 INFO - --app=APP Application being installed. [default: firefox] 12:19:11 INFO - mkdir: /builds/slave/test/build/application 12:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:19:24 INFO - Reading from file tmpfile_stdout 12:19:24 INFO - Output received: 12:19:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:19:24 INFO - Running post-action listener: _resource_record_post_action 12:19:24 INFO - [mozharness: 2017-02-23 20:19:24.765451Z] Finished install step (success) 12:19:24 INFO - [mozharness: 2017-02-23 20:19:24.765692Z] Running run-tests step. 12:19:24 INFO - Running pre-action listener: _resource_record_pre_action 12:19:24 INFO - Running main action method: run_tests 12:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:24 INFO - Python 2.7.3 12:19:24 INFO - Return code: 0 12:19:24 INFO - grabbing minidump binary from tooltool 12:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:24 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 0x2a66f60>, '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 0x2a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a681d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:24 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 12:19:24 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 12:19:24 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 12:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:24 INFO - Return code: 0 12:19:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 12:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 12:19:24 INFO - Using env: {'DISPLAY': ':0', 12:19:24 INFO - 'HOME': '/home/cltbld', 12:19:24 INFO - 'LANG': 'en_US.UTF-8', 12:19:24 INFO - 'LANGUAGE': 'en_US:en', 12:19:24 INFO - 'LOGNAME': 'cltbld', 12:19:24 INFO - 'MAIL': '/var/mail/cltbld', 12:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:24 INFO - 'MOZ_NO_REMOTE': '1', 12:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:24 INFO - 'NO_EM_RESTART': '1', 12:19:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:24 INFO - 'PWD': '/builds/slave/test', 12:19:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:24 INFO - 'SHELL': '/bin/bash', 12:19:24 INFO - 'SHLVL': '1', 12:19:24 INFO - 'TERM': 'linux', 12:19:24 INFO - 'TMOUT': '86400', 12:19:24 INFO - 'USER': 'cltbld', 12:19:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130', 12:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:24 INFO - '_': '/tools/buildbot/bin/python'} 12:19:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 12:19:25 INFO - mozversion application_buildid: 20170223103422 12:19:25 INFO - mozversion application_changeset: 02a085cba71fb767d17d3e3e33f252da066f5d41 12:19:25 INFO - mozversion application_display_name: Firefox 12:19:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:25 INFO - mozversion application_name: Firefox 12:19:25 INFO - mozversion application_remotingname: firefox 12:19:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:19:25 INFO - mozversion application_vendor: Mozilla 12:19:25 INFO - mozversion application_version: 52.0 12:19:25 INFO - mozversion platform_buildid: 20170223103422 12:19:25 INFO - mozversion platform_changeset: 02a085cba71fb767d17d3e3e33f252da066f5d41 12:19:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:19:25 INFO - mozversion platform_version: 52.0 12:19:25 INFO - using testdate: 1487881165 12:19:25 INFO - actual date: 1487881165 12:19:25 INFO - starting webserver on 'localhost:52018' 12:19:25 INFO - SUITE-START | Running 2 tests 12:19:25 INFO - TEST-START | dromaeo_css 12:19:25 INFO - operating with platform_type : linux_ 12:19:25 INFO - Initialising browser for dromaeo_css test... 12:19:25 INFO - TEST-INFO | started process 7023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZE5tG/profile http://localhost:52018/getInfo.html) 12:19:28 INFO - PROCESS | 7023 | __metrics Screen width/height:1600/1200 12:19:28 INFO - PROCESS | 7023 | colorDepth:24 12:19:28 INFO - PROCESS | 7023 | Browser inner width/height: 1024/697 12:19:28 INFO - PROCESS | 7023 | __metrics 12:19:29 INFO - PROCESS | 7023 | 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:19:29 INFO - PROCESS | 7023 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:19:30 INFO - TEST-INFO | 7023: exit 0 12:19:30 INFO - Browser initialized. 12:19:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:30 INFO - TEST-INFO | started process 7117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCZE5tG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:42 INFO - PROCESS | 7117 | RSS: Main: 141979648 12:19:42 INFO - PROCESS | 7117 | 12:22:43 INFO - PROCESS | 7117 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52018/tests/dromaeo/cssquery-ext.html) 12:22:44 INFO - PROCESS | 7117 | RSS: Main: 249044992 12:22:44 INFO - PROCESS | 7117 | 12:25:47 INFO - PROCESS | 7117 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-ext.html (next: http://localhost:52018/tests/dromaeo/cssquery-jquery.html) 12:25:47 INFO - PROCESS | 7117 | RSS: Main: 247537664 12:25:47 INFO - PROCESS | 7117 | 12:28:49 INFO - PROCESS | 7117 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52018/tests/dromaeo/cssquery-mootools.html) 12:28:50 INFO - PROCESS | 7117 | RSS: Main: 212590592 12:28:50 INFO - PROCESS | 7117 | 12:31:52 INFO - PROCESS | 7117 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52018/tests/dromaeo/cssquery-prototype.html) 12:31:53 INFO - PROCESS | 7117 | RSS: Main: 178999296 12:31:53 INFO - PROCESS | 7117 | 12:34:55 INFO - PROCESS | 7117 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52018/tests/dromaeo/cssquery-yui.html) 12:34:56 INFO - PROCESS | 7117 | RSS: Main: 180948992 12:34:56 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-yui.html (next: http://localhost:52018/tests/dromaeo/cssquery-dojo.html) 12:37:58 INFO - PROCESS | 7117 | RSS: Main: 253415424 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | __start_tp_report 12:37:58 INFO - PROCESS | 7117 | _x_x_mozilla_page_load 12:37:58 INFO - PROCESS | 7117 | _x_x_mozilla_page_load_details 12:37:58 INFO - PROCESS | 7117 | |i|pagename|runs| 12:37:58 INFO - PROCESS | 7117 | |0;dojo.html;3140.5446210299506;3169.9524507132396;3175.1109689287;3199.456092464281;3206.9518957215646;5556.638818476797;5605.439456054392;5620.381758006616;5638.718064096799;5651.152327150924;5574.554035677146;5624.690642014688;5630.324361076677;5640.351359593637;5646.096624540074;5068.214426763849;5096.210087436453;5137.255098010786;5161.071007218699;5176.611754118456;5061.519155680223;5135.12702840518;5188;5193.324867767185;5194.065068287707;4973;5004.674696144739;5047;5091;5130.127878260686;5141.640085194038;5147.4080480744815;5202.76587553561;5206.453322401169;5220.504052115043;4969.304297398367;4988.775505102279;5090.567301779353;5111.923321150186;5156.845294641167;5434.456554344573;5452.2094296327205;5455.318085239345;5524.58565607577;5567.137093750475;5869.7652093916195;5902.852428689317;5934.792282270143;5944.673042982634;5950.2264705587995;5872.442117998783;5953.315368732565;5969.044952807573;5980.760769569212;5983.790567330166;5610.382857885629;5658.292713410824;5659.717014149276;5661.66030038199;5698.886022279531;6212.534059945522;6215.96892015537;6227;6240.687965601702;6244.625322480666;5740.913886291625;5795.043817770105;5955.37468565803;5969.522438204933;5971.4327138921735;5941.31674857397;5962.850928726816;5974.701264936736;6028.909566356509;6063.151158837766;6006.309274433496;6008.729607167688;6016.42843929826;6031.517478601789;6062.302835173923;5880.500157486662;5965.910511342333;6010.609310394811;6025.6685882276015;6030.668313242726;4566.13243483737;4576.725396476222;4579.6794224403975;4594.1271158479785;4637.7449240291435;4062.5734297898885;4086.8160932758096;4093.5906409358827;4105.158442519277;4124.257633625916;5635.633683810539;5651.717414129277;5653.745581448845;5658.0381335173115;5682.261306030272;5795.797147099831;5864.325602555676;5881.147233651182;5915.467607915222;5926.496247818984;5650.039493286151;5655.604107712421;5659.377468478464;5661.122526008476;5676.2337084493065;5122.615803814654;5125.15434953236;5141.640085194001;5143.639945203875;5176.818811341585;5999.820005399845;6118.893302669041;6140.662263575547;6142.539309551891;6172.783952561639;6010.81967540957;6017.638941663514;6035.698215089315;6038.245219347582;6064.636121832704;6164;6233.096201050913;6235.314115447388;6238.656873871981;6256.092866534236;5625.662460252398;5651.378348381592;5769.74036168365;5916.911246331222;5918.970405147947;5891.558133140117;5984.222051133324;5984.311804142405;5999.49004334619;6006.33930267679;5804.303483581828;5842.503387212135;5851.444112809447;5855.59010869235;5855.882882342415;5670.376258611632;5812.982728022664;5826.621269617462;5828.0966450200285;5832.62087964281;5713.028785106459;5719.942800571941;5746.569007324384;5811.82564523065;5838;5873.676947767914;5876.676782776988;5876.941230587639;5879.588428810113;5885.08781138907;5639.830805075854;5688.232088668143;5712.971435142797;5717.5425965921795;5757.8560535986935 12:37:58 INFO - PROCESS | 7117 | |1;ext.html;559.991600125998;594.4679511836905;607.6384551192042;612.7089632424598;632.9556232216845;33970;34548.65451345486;36223.81888090562;46926.765366173124;48360.758196209055;45769.771151144196;45854.77072614641;46071;46195;46202.537974620245;8887.866681999774;9027.819443611157;9031.503267320295;9033.23217526511;9034;8393.202645748675;8598.87101693475;8836.381453298272;10543.63097291595;10826.350418974847;10868.239223254375;10933.398663073527;10941.56233750649;10945.781084378308;10948.124150068015;10767.569297228101;10817.675469735921;10828.458577071115;10837.945810270978;10838.078763305128;10688.038076573146;10752.516136773864;10753.247272690915;10754.892451075468;10763.892361076367;42233.577664223274;42417.57582424198;42493.57506424927;42537.14925701469;42580.361294580296;3588.5825099085714;3744.8882275693754;3807.3146833569945;3816.9312592474153;3822.847086116552;31169;31828.522572161437;31831.840840795878;32476.512852307234;32557.51163732546;4425.314076318144;4550.522195169526;4566.474855391639;4566.771661416949;4692.085043416535;335468;336513;337126;337900;338639;58038.419615804145;58132.709336453045;58133.70933145307;58390;58554.70722646359;38559.80720096381;39392.80303598464;39514.80242598826;41088.38367424491;41406.79296603498;17967.37114201023;18024;18074.457766267034;18075.909620451814;18091.36680216186;13057.869421305666;13406.061575689608;13461.25963072021;13464.528741494196;13466.461341546425;17525.824741752418;18780.967046812555;19100.522486937938;19432.028398580016;19604.607907841764;7135.357817796424;7269.273072692794;7325.450591205681;7334.799560131939;7440.627968601549;988.3575675810637;1074.9462526873624;1107.070061148639;1119.9440027998567;1129.3957732613012;32797.67202327994;32865.50701739476;33034.83482582572;33038;33402.49896251558;1114.5486078138367;1135.2790977729037;1135.5741596901162;1194.946227419768;1204.4519743516678;16250.51248462548;17253.913730431268;17338.566535836704;17418.56453588645;17430.738538921927;463094;475210;475399;475966;476299;60286.698566506886;60939.39060609426;60974.695126524086;60997.695011525546;61079.69460152671;1314.3691028306275;1392.7980442835935;1423.3241505968713;1462.2104063805425;1464.809574755275;31692.841535793097;33926.32147357088;34051.14872128118;34140;34265.29346072714;51245.23132152946;51894.22158667548;52083;52104;52213.21680174724;381311;381969;384945;385107;386826;37126.25747484981;37683.196745828;44342.556574433846;44502;45124.77437612791;41760;47331.763341183076;47367;47792.522074778804;47895.76052119717;40450.39324410077;41075.58924410718;41356;41531;42880.14239715251;41362;41382.586174137876;41849.79075104605;42190;42835.7858210707;40993;41436.1712765749;41704.37443438412;41908.58091419169;41910.580894190665;35160.29679406449;36612.450813238356;36806.63193368032;37321.626783731816;37669.62330376771;28055.719442806127;28340.574891376233;28499.28751781222;28508;28520 12:37:58 INFO - PROCESS | 7117 | |2;jquery.html;411.8352658936425;414.07867494824;432.9935050974236;437.87520556641346;437.9934300985486;18213.544661383472;18897.433077007696;19577.902110489445;19722.802771972278;19880.204791808348;19392.806071939278;19478.513037174078;19662.70505942412;19912.303069392576;20074;5698.917205730908;5965.284165900098;5969.283685957669;5975.850603734898;5976.641401515902;4371.14762621289;4495.617872480843;4497.190505708971;5874.206982057411;5951.672658003829;6529.836754081139;6554.541182117254;6558.672066396685;6569.934300657004;6640.535162538624;6469.171987857226;6536;6554.754596626625;6598.47212223021;6648.7672931447405;5913.497352725023;5918.526517878602;5921.526277897801;5922.763089476416;5926.1110833374905;15230.695386092328;15965.281562329606;22377.77622223773;23214.41963950898;23342.949567269512;2315.30540837748;2504.261242933339;2879.3953269813364;3026.651935027456;3108.533719942004;10816.891831081668;10906;10910.23628346016;11167.106631469464;11357.716057098556;1952.453313072342;2010.1657812008;2021.070307658479;2068.141721185706;2068.98965505173;64287;64666.67666661637;72733.63633181801;77273.22726772772;83623;11399.544018239178;11492.770144597062;11588;11626.128040396836;11779.469923853276;16537.503874883772;16564.503064908073;16574.08842513673;16581.170941452878;16584.50246492607;8468.788280292918;8679.305655547541;8712.825743485095;8923.241524470362;8924.910750892537;8193.344532437392;8308.941647202575;8315.334773218128;8509.10654381281;8572.099929507312;5070.873228169252;5073.822416215415;5091.5672167865405;5120.743962801845;5194.584433245332;2054.219396629301;2075.98962005192;2111.4088055344528;2121.7241758571286;2146.162996431393;850.8553545897213;917.3807679816098;940.290080988849;964.2767924056957;1024.0834453164375;18120.365787197385;18858.339958101675;19835.10742016613;19986.500337491678;20295.188192472135;953.3469573342283;986.2356673578034;1009.1129587670955;1009.9747506312254;1052.1004541117388;10539.262251642465;11032.117430605533;11077.279976801483;11115.333080015063;11262.267952583055;348046;350024;452034;459153;462921;83133;93635.53182234181;95782.52108739411;97499;97778.511107444;1035.1873779083382;1053.6680945502296;1072.4048153275007;1094.8029354716227;1098.8791232964368;17670.734938976184;18065.187066581773;18072.72890906611;18152.45542633723;18469.630607388044;28760.712392875805;33061.66938330586;40640.39039414352;40792;41326.586734132274;51399.48600513947;52128;53183.46816531785;59813.401865980784;60586;8930.374873759034;9036.638534458549;9118.270538356783;9183.403078799856;9399.953000234955;13127.343632818513;13621.591352259447;13757.724845502833;13793.517226897011;13810.171389716648;11509.194356394972;11680.649580512598;11838.763224735285;11984.40077996114;12124;7331.973523706792;11658.88341116578;11844;12029.097817663534;12215.877841221474;11573.363465009505;11853.288802671867;11988.880111198776;12200.389980501117;12288.447019884305;7927.365810735012;8127.415154044905;8281.95859020701;8803.515806630698;9211.355205135844;9282.350235483722;11585.7103572408;11689.298642081163;12148.514059437524;12181.269123852597 12:37:58 INFO - PROCESS | 7117 | |3;mootools.html;1363.5295822941082;1482.9258537073144;1506.4200282891086;1664.3509031477727;1799.370220422852;7844.764657060283;8371.539565323912;8672.392932494728;8680.826383472328;8886.822263554724;8645.567721613925;8705.782355441117;8711.30309575234;8722.956385218082;8734.257588105003;2423.5274121546304;2445.4864478459544;2447.547203767309;2448.6449464827588;2453.5338285725743;2404.441075053195;2477.541654793869;2478.045952308365;2480.1443501991876;2480.6775119234476;2443.816713746476;2448.3511869354634;2450.987745061281;2457.987710061447;2458.0782206672498;2352.9058837646476;2375;2406.0135344508753;2420.7700268474555;2421.140495124223;2290.7709229077127;2306.3888069661552;2306.9653955190684;2307.4462129088897;2314.2131675230503;8551.871721924175;8641.827163456759;8682.565871706389;8735;8735.650573977033;5347.438518955492;5555.055640541118;5560.7219639017885;5571.888562228733;5572.498475137217;3454.4818277258614;3466.9479957800654;3520.612732599412;3528.2414280929465;3790.90522736931;1174.4714878304712;1178.7406770510474;1183.7336599265182;1217.9208351457128;2251.7860803223666;11715.472803723767;12133.211341262879;12135.575254866126;12155.270683759003;12178.330191839445;4756.405449318835;4975.726335051607;5138.794448222104;5140.820071297487;5163.044836705221;9807.362521436084;9846.113849753414;9895.60417583303;9900.950495247622;9906.653267135616;5598.496135347838;5598.636088654224;5607.607467477237;5613.831585052455;5619.044762390404;5048.343715316985;5051.87370315745;5103.795848166106;5107.080725469377;5154.664946778447;3782.791946442972;3837.6162383761957;3908.413737939332;3926.803659816998;3967.2263908537557;1161.4715304536417;1179.823026546025;1182.4974385885964;1190.2917763930448;1192.5885569478517;831.5260301628014;955.5031383680447;958.5638534466801;959.6881013670585;961.3030552849128;5804.767809287581;5823.155642431823;5867.237259156283;5959.493443057302;6154.630722156685;451.4943263544785;453.9024109816339;461.45548253061037;470.11148928525114;475.1044281529273;4096.815643296059;4222.59885310895;4227.408162857202;4227.450431443954;4242.596953289432;10514.106300964351;10778.892211077946;10846.132309415229;10869.728256793644;10910.727231819268;10751.731206719895;10762.623308184176;10781.784364312827;10785.245032847626;10804.837927431096;7887.092984306763;8043.276105150565;8056.556889371141;8095.583272927214;8231.588420578948;5523.8895222096135;5570.220169176399;5875.882482350244;6056.57603967718;6060.969455312168;9597.47213903242;9819.410835349901;9856.457894815854;9874.901250987397;9888.653897113567;9258.120478554527;9485.525723713925;9725.951370243103;9931.205503559842;10044.045815647794;7919.406044546567;8005.159458257032;8192.385571082312;8213.055498617736;8432.620532075949;8273.214044665747;8545.658173672984;8549.743507694779;8629.266512346521;8637.654493820428;7532.7740167795055;7624.771256862303;7644.464887457824;7790.376769858284;7812.687492500237;7434.3309102181065;7474.140473845578;7515.436342274242;7531.284527969834;7689.730859419893;7002.824929376807;7140.178879428932;7141.178764441948;7168.498205125591;7170.820729481805;4864.92702609454;4867.780949857194;4929.433115191799;5191.997289918879;5264.210368444764;5149.459306772885;5300.3904550975585;5308.867278317918;5370.946290537201;5494.752736126804 12:37:58 INFO - PROCESS | 7117 | |4;prototype.html;333.3932243317164;338.0618782877516;339.070945609031;350.75622442402533;352.4361022364217;5314.920276195855;5320.361556613202;5336.252924590561;5342.652727572715;5380.838574842761;5298.788048478056;5305.495977882105;5342.278792363029;5363.8122665706705;5371.919421208675;3635.6731691717323;3937.960620393795;4048.210598933209;4078.9184216315803;4088.5911408859024;4090.6318431341174;4118.608732170439;4120.114175452277;4129.504459464868;4136.214119317335;4082.9183416331657;4100.015996160915;4108.794560271989;4114.033202197481;4136.751794892301;4121.340585506305;4124.979375103136;4133.359329303963;4137.110521237918;4159.750414975081;3604.0629436346476;3672.081979505124;3685.594584595692;3699.4820725098507;3703.3889408247605;5089.134847076006;5092.8217512387255;5104.897902041976;5108.909109988478;5120.1039818031695;4679.836205732817;4695.88260293492;4701.247800351927;4723.921474551221;4739.170645137087;5251.894962100775;5420.186971954199;5454.34547854256;5461.69960652164;5478.835634930959;4000.6399424051683;4010.3130902295534;4016.879493615196;4017.979910100431;4045.6763458923215;5450.618456708032;5640.576956728261;5712.371639119693;5732;5744.741486633112;4142.730722503027;4245.27830268855;4252.702310838212;4263.445752052214;4270.444842170498;4310.762908040025;4340.153670034376;4343.131373725268;4346.326319420495;4355.760433176142;4531.637469002472;4791.425028996473;4860.635452341088;4878.902421951541;4881.219004959189;5554.861128471821;5558.194061861008;5558.471945165203;5560.471755183251;5567.8886422272135;1422.11118051218;1430.106183635228;1431.3630434456775;1441.0489077209202;1447.8190226221723;964.5129209749032;992.8808542974889;994.3785134291068;1003.3628645809963;1025.3489034463169;5138.150265904272;5160.406553246425;5161.329027226511;5176.689398636018;5189.7405129743365;5424.891502169935;5449.782008719607;5468.835934921959;5523.502884740312;5540.952476138188;5068.746562671851;5187.780871495195;5192.766325515361;5220.869478262998;5228.353068783321;2843.928901777472;2852.3297025199063;2859.7569206617673;2906.0264811288457;2915.475214461375;5631.71841407928;5634.408387119375;5655.349634791969;5660.433956604389;5694.345150307685;5238.449962753933;5508.366537848118;5513.338399392099;5514.365847927459;5568;5589.462897703164;5600.635958662755;5629.943700563023;5643.053146664394;5658.094704847287;5246.868828279324;5383.973080134574;5413.269208656939;5424.396289780849;5494.36814766307;5399.865003374947;5403.648762830403;5407.324084489439;5415.458454154711;5420.701861397503;5650.576206784425;5685.374608793112;5796.971015144897;5808.6224395414165;5810.389909059488;4066.4916885389325;4171.144915292419;4197.559256278047;4199.538050814469;4207.747535147901;5551.389347171888;5670.659760414388;5696.943030569641;5714.828555143353;5717.571182161271;5465.836024919259;5468.56251499887;5473.2063850742215;5488.862778430571;5493.560515158698;5434.619576629598;5438.428964958623;5456.809011684572;5464.644798088111;5477.972610136924;5179.663321884065;5375.569954403716;5398.568114550905;5400.191900211947;5415.6479828811;5471.589630777628;5474.069408200536;5489.972550137224;5498.972505137609;5500.42245564226;5379.381371142213;5398.406175320633;5414.458554144711;5419.160030195326;5425.159100339453 12:37:58 INFO - PROCESS | 7117 | |5;yui.html;767.3669222891115;785.2540086917427;811.2009670474581;848.3086284677987;869.8695195720637;13473.191608503472;13630.386632601532;13646.2494562799;13666.863331366696;14345.852331813456;12368.319742414164;13692.863071369284;13789.724205515884;13809.447622095104;13811.37848796804;829.0797215091244;857.2970164465141;857.9142085791433;859.0250066174905;859.3812455032398;849.5072857742495;852.1776485691306;852.9616167272457;853.6201390381283;853.9701110461135;873.829603227371;879.1252703559967;880.1682410122437;880.1946219209448;880.8106257154742;862.3704695572204;867.2454964181171;872.7861673889875;874.2743522875998;874.2743522875998;641.3105911145491;643.7296335539085;644.0853987337991;644.2623196440097;644.2880616918285;12008.099392545506;12042.337671428068;12050.879491205063;12126.6362009139;13340.199588024652;12329.260244385365;12828.35858207086;12837.358132093357;12854.293013884233;12958.676033099153;10692.893071069346;10697.572097116106;10781.730456738565;10801.729956751144;11055.170862185289;3678.926421471582;3696.5748938872107;3740.551133863954;3771.2268984858038;3800.8669696560764;60161;61376.69311653458;61568;61676.69161654208;62775.37224627787;9375.390599611004;9568.665096721721;9765.16996055329;10467.214958878114;10753.78492430147;19417.902910485358;19655.901720491307;19669.704954425695;19691.01544922748;19701.60596788056;8001.839963200703;8026.959865200637;8229.79425514367;8289.461185022954;8305.859620115816;4580.267157254823;4655.092257009918;4721.95278047222;4752.738599377068;4765.73788441639;3196.4566023776015;3289.292802047571;3289.3750187464307;3291.835408229579;3291.8683252670103;602.8703828676768;610.9725062372204;629.9779507717208;678.6878036103448;687.7833482453011;600.3996003996004;649.912261844645;659.0674196012684;719.9928000720031;756.6784116750359;8872.467651940904;8990.370674052885;9199.954000229956;9324.813503729887;9475.147236748588;592.7688201601379;604.6070054464545;727.4725823777719;747.4020783373279;751;4719.764011799396;4733.692309999839;4779.163646361872;4828.7102773833685;4831.347768051339;60483.69758151181;78726.81909771358;88148;88314.55842720745;89056;75498.24501754912;76593;77859.61070194613;78369.21630783733;80477;46254.537454625024;46657.76671116623;55485.72257138688;68287.65856170787;68381.31618683749;8804.251638610789;9110.225630821455;9242.907570924204;9244.676436324697;9398.859017114612;47297.29054064261;47680.28479572879;48245.27632085592;48421.273680895516;49004.2649360267;58953.41046589479;60071;64130.67934660297;64939;65105.67447162734;10481;10696.358218506915;10818.02637762605;10923.617673381394;11020.944895275472;11629.59296424621;11659.86516139917;11755.88993465636;11770.49375844826;11852.940735296614;12330;12403.193792403465;12423.875761242272;12482.500699971899;12629.684257893627;11887.405629718307;12043.337616431181;12069.215500992408;12321.630351089481;12474.75050499003;11502.712432189262;11737.88262117368;11808.350540720343;12024.75950480968;12109.455074521844;9997.600095996078;10262.58949642006;10349.74125646865;10654.680359589225;11202;10253.487325633838;10426.165906727596;10440.269181157246;10563.630272940718;10582.312149710244 12:37:58 INFO - PROCESS | 7117 | __end_tp_report 12:37:58 INFO - PROCESS | 7117 | __start_cc_report 12:37:58 INFO - PROCESS | 7117 | _x_x_mozilla_cycle_collect,1082 12:37:58 INFO - PROCESS | 7117 | __end_cc_report 12:37:58 INFO - PROCESS | 7117 | __startTimestamp1487882278796__endTimestamp 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | ------- Summary: start ------- 12:37:58 INFO - PROCESS | 7117 | Number of tests: 6 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | [#0] dojo.html Cycles:165 Average:5553.21 Median:5717.54 stddev:630.94 (11.0%) stddev-sans-first:603.82 12:37:58 INFO - PROCESS | 7117 | Values: 3140.5 3170.0 3175.1 3199.5 3207.0 5556.6 5605.4 5620.4 5638.7 5651.2 5574.6 5624.7 5630.3 5640.4 5646.1 5068.2 5096.2 5137.3 5161.1 5176.6 5061.5 5135.1 5188.0 5193.3 5194.1 4973.0 5004.7 5047.0 5091.0 5130.1 5141.6 5147.4 5202.8 5206.5 5220.5 4969.3 4988.8 5090.6 5111.9 5156.8 5434.5 5452.2 5455.3 5524.6 5567.1 5869.8 5902.9 5934.8 5944.7 5950.2 5872.4 5953.3 5969.0 5980.8 5983.8 5610.4 5658.3 5659.7 5661.7 5698.9 6212.5 6216.0 6227.0 6240.7 6244.6 5740.9 5795.0 5955.4 5969.5 5971.4 5941.3 5962.9 5974.7 6028.9 6063.2 6006.3 6008.7 6016.4 6031.5 6062.3 5880.5 5965.9 6010.6 6025.7 6030.7 4566.1 4576.7 4579.7 4594.1 4637.7 4062.6 4086.8 4093.6 4105.2 4124.3 5635.6 5651.7 5653.7 5658.0 5682.3 5795.8 5864.3 5881.1 5915.5 5926.5 5650.0 5655.6 5659.4 5661.1 5676.2 5122.6 5125.2 5141.6 5143.6 5176.8 5999.8 6118.9 6140.7 6142.5 6172.8 6010.8 6017.6 6035.7 6038.2 6064.6 6164.0 6233.1 6235.3 6238.7 6256.1 5625.7 5651.4 5769.7 5916.9 5919.0 5891.6 5984.2 5984.3 5999.5 6006.3 5804.3 5842.5 5851.4 5855.6 5855.9 5670.4 5813.0 5826.6 5828.1 5832.6 5713.0 5719.9 5746.6 5811.8 5838.0 5873.7 5876.7 5876.9 5879.6 5885.1 5639.8 5688.2 5713.0 5717.5 5757.9 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | [#1] ext.html Cycles:180 Average:56915.48 Median:192892.97 stddev:105928.92 (54.9%) stddev-sans-first:106141.57 12:37:58 INFO - PROCESS | 7117 | Values: 560.0 594.5 607.6 612.7 633.0 33970.0 34548.7 36223.8 46926.8 48360.8 45769.8 45854.8 46071.0 46195.0 46202.5 8887.9 9027.8 9031.5 9033.2 9034.0 8393.2 8598.9 8836.4 10543.6 10826.4 10868.2 10933.4 10941.6 10945.8 10948.1 10767.6 10817.7 10828.5 10837.9 10838.1 10688.0 10752.5 10753.2 10754.9 10763.9 42233.6 42417.6 42493.6 42537.1 42580.4 3588.6 3744.9 3807.3 3816.9 3822.8 31169.0 31828.5 31831.8 32476.5 32557.5 4425.3 4550.5 4566.5 4566.8 4692.1 335468.0 336513.0 337126.0 337900.0 338639.0 58038.4 58132.7 58133.7 58390.0 58554.7 38559.8 39392.8 39514.8 41088.4 41406.8 17967.4 18024.0 18074.5 18075.9 18091.4 13057.9 13406.1 13461.3 13464.5 13466.5 17525.8 18781.0 19100.5 19432.0 19604.6 7135.4 7269.3 7325.5 7334.8 7440.6 988.4 1074.9 1107.1 1119.9 1129.4 32797.7 32865.5 33034.8 33038.0 33402.5 1114.5 1135.3 1135.6 1194.9 1204.5 16250.5 17253.9 17338.6 17418.6 17430.7 463094.0 475210.0 475399.0 475966.0 476299.0 60286.7 60939.4 60974.7 60997.7 61079.7 1314.4 1392.8 1423.3 1462.2 1464.8 31692.8 33926.3 34051.1 34140.0 34265.3 51245.2 51894.2 52083.0 52104.0 52213.2 381311.0 381969.0 384945.0 385107.0 386826.0 37126.3 37683.2 44342.6 44502.0 45124.8 41760.0 47331.8 47367.0 47792.5 47895.8 40450.4 41075.6 41356.0 41531.0 42880.1 41362.0 41382.6 41849.8 42190.0 42835.8 40993.0 41436.2 41704.4 41908.6 41910.6 35160.3 36612.5 36806.6 37321.6 37669.6 28055.7 28340.6 28499.3 28508.0 28520.0 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | [#2] jquery.html Cycles:180 Average:26653.68 Median:2953.02 stddev:69194.14 (2343.2%) stddev-sans-first:69360.19 12:37:58 INFO - PROCESS | 7117 | Values: 411.8 414.1 433.0 437.9 438.0 18213.5 18897.4 19577.9 19722.8 19880.2 19392.8 19478.5 19662.7 19912.3 20074.0 5698.9 5965.3 5969.3 5975.9 5976.6 4371.1 4495.6 4497.2 5874.2 5951.7 6529.8 6554.5 6558.7 6569.9 6640.5 6469.2 6536.0 6554.8 6598.5 6648.8 5913.5 5918.5 5921.5 5922.8 5926.1 15230.7 15965.3 22377.8 23214.4 23342.9 2315.3 2504.3 2879.4 3026.7 3108.5 10816.9 10906.0 10910.2 11167.1 11357.7 1952.5 2010.2 2021.1 2068.1 2069.0 64287.0 64666.7 72733.6 77273.2 83623.0 11399.5 11492.8 11588.0 11626.1 11779.5 16537.5 16564.5 16574.1 16581.2 16584.5 8468.8 8679.3 8712.8 8923.2 8924.9 8193.3 8308.9 8315.3 8509.1 8572.1 5070.9 5073.8 5091.6 5120.7 5194.6 2054.2 2076.0 2111.4 2121.7 2146.2 850.9 917.4 940.3 964.3 1024.1 18120.4 18858.3 19835.1 19986.5 20295.2 953.3 986.2 1009.1 1010.0 1052.1 10539.3 11032.1 11077.3 11115.3 11262.3 348046.0 350024.0 452034.0 459153.0 462921.0 83133.0 93635.5 95782.5 97499.0 97778.5 1035.2 1053.7 1072.4 1094.8 1098.9 17670.7 18065.2 18072.7 18152.5 18469.6 28760.7 33061.7 40640.4 40792.0 41326.6 51399.5 52128.0 53183.5 59813.4 60586.0 8930.4 9036.6 9118.3 9183.4 9400.0 13127.3 13621.6 13757.7 13793.5 13810.2 11509.2 11680.6 11838.8 11984.4 12124.0 7332.0 11658.9 11844.0 12029.1 12215.9 11573.4 11853.3 11988.9 12200.4 12288.4 7927.4 8127.4 8282.0 8803.5 9211.4 9282.4 11585.7 11689.3 12148.5 12181.3 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | [#3] mootools.html Cycles:180 Average:5792.26 Median:5228.10 stddev:3211.17 (61.4%) stddev-sans-first:3202.93 12:37:58 INFO - PROCESS | 7117 | Values: 1363.5 1482.9 1506.4 1664.4 1799.4 7844.8 8371.5 8672.4 8680.8 8886.8 8645.6 8705.8 8711.3 8723.0 8734.3 2423.5 2445.5 2447.5 2448.6 2453.5 2404.4 2477.5 2478.0 2480.1 2480.7 2443.8 2448.4 2451.0 2458.0 2458.1 2352.9 2375.0 2406.0 2420.8 2421.1 2290.8 2306.4 2307.0 2307.4 2314.2 8551.9 8641.8 8682.6 8735.0 8735.7 5347.4 5555.1 5560.7 5571.9 5572.5 3454.5 3466.9 3520.6 3528.2 3790.9 1174.5 1178.7 1183.7 1217.9 2251.8 11715.5 12133.2 12135.6 12155.3 12178.3 4756.4 4975.7 5138.8 5140.8 5163.0 9807.4 9846.1 9895.6 9901.0 9906.7 5598.5 5598.6 5607.6 5613.8 5619.0 5048.3 5051.9 5103.8 5107.1 5154.7 3782.8 3837.6 3908.4 3926.8 3967.2 1161.5 1179.8 1182.5 1190.3 1192.6 831.5 955.5 958.6 959.7 961.3 5804.8 5823.2 5867.2 5959.5 6154.6 451.5 453.9 461.5 470.1 475.1 4096.8 4222.6 4227.4 4227.5 4242.6 10514.1 10778.9 10846.1 10869.7 10910.7 10751.7 10762.6 10781.8 10785.2 10804.8 7887.1 8043.3 8056.6 8095.6 8231.6 5523.9 5570.2 5875.9 6056.6 6061.0 9597.5 9819.4 9856.5 9874.9 9888.7 9258.1 9485.5 9726.0 9931.2 10044.0 7919.4 8005.2 8192.4 8213.1 8432.6 8273.2 8545.7 8549.7 8629.3 8637.7 7532.8 7624.8 7644.5 7790.4 7812.7 7434.3 7474.1 7515.4 7531.3 7689.7 7002.8 7140.2 7141.2 7168.5 7170.8 4864.9 4867.8 4929.4 5192.0 5264.2 5149.5 5300.4 5308.9 5370.9 5494.8 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | [#4] prototype.html Cycles:180 Average:4619.06 Median:5275.34 stddev:1322.32 (25.1%) stddev-sans-first:1286.31 12:37:58 INFO - PROCESS | 7117 | Values: 333.4 338.1 339.1 350.8 352.4 5314.9 5320.4 5336.3 5342.7 5380.8 5298.8 5305.5 5342.3 5363.8 5371.9 3635.7 3938.0 4048.2 4078.9 4088.6 4090.6 4118.6 4120.1 4129.5 4136.2 4082.9 4100.0 4108.8 4114.0 4136.8 4121.3 4125.0 4133.4 4137.1 4159.8 3604.1 3672.1 3685.6 3699.5 3703.4 5089.1 5092.8 5104.9 5108.9 5120.1 4679.8 4695.9 4701.2 4723.9 4739.2 5251.9 5420.2 5454.3 5461.7 5478.8 4000.6 4010.3 4016.9 4018.0 4045.7 5450.6 5640.6 5712.4 5732.0 5744.7 4142.7 4245.3 4252.7 4263.4 4270.4 4310.8 4340.2 4343.1 4346.3 4355.8 4531.6 4791.4 4860.6 4878.9 4881.2 5554.9 5558.2 5558.5 5560.5 5567.9 1422.1 1430.1 1431.4 1441.0 1447.8 964.5 992.9 994.4 1003.4 1025.3 5138.2 5160.4 5161.3 5176.7 5189.7 5424.9 5449.8 5468.8 5523.5 5541.0 5068.7 5187.8 5192.8 5220.9 5228.4 2843.9 2852.3 2859.8 2906.0 2915.5 5631.7 5634.4 5655.3 5660.4 5694.3 5238.4 5508.4 5513.3 5514.4 5568.0 5589.5 5600.6 5629.9 5643.1 5658.1 5246.9 5384.0 5413.3 5424.4 5494.4 5399.9 5403.6 5407.3 5415.5 5420.7 5650.6 5685.4 5797.0 5808.6 5810.4 4066.5 4171.1 4197.6 4199.5 4207.7 5551.4 5670.7 5696.9 5714.8 5717.6 5465.8 5468.6 5473.2 5488.9 5493.6 5434.6 5438.4 5456.8 5464.6 5478.0 5179.7 5375.6 5398.6 5400.2 5415.6 5471.6 5474.1 5490.0 5499.0 5500.4 5379.4 5398.4 5414.5 5419.2 5425.2 12:37:58 INFO - PROCESS | 7117 | 12:37:58 INFO - PROCESS | 7117 | [#5] yui.html Cycles:180 Average:16960.10 Median:26626.31 stddev:22583.94 (84.8%) stddev-sans-first:22614.56 12:37:58 INFO - PROCESS | 7117 | Values: 767.4 785.3 811.2 848.3 869.9 13473.2 13630.4 13646.2 13666.9 14345.9 12368.3 13692.9 13789.7 13809.4 13811.4 829.1 857.3 857.9 859.0 859.4 849.5 852.2 853.0 853.6 854.0 873.8 879.1 880.2 880.2 880.8 862.4 867.2 872.8 874.3 874.3 641.3 643.7 644.1 644.3 644.3 12008.1 12042.3 12050.9 12126.6 13340.2 12329.3 12828.4 12837.4 12854.3 12958.7 10692.9 10697.6 10781.7 10801.7 11055.2 3678.9 3696.6 3740.6 3771.2 3800.9 60161.0 61376.7 61568.0 61676.7 62775.4 9375.4 9568.7 9765.2 10467.2 10753.8 19417.9 19655.9 19669.7 19691.0 19701.6 8001.8 8027.0 8229.8 8289.5 8305.9 4580.3 4655.1 4722.0 4752.7 4765.7 3196.5 3289.3 3289.4 3291.8 3291.9 602.9 611.0 630.0 678.7 687.8 600.4 649.9 659.1 720.0 756.7 8872.5 8990.4 9200.0 9324.8 9475.1 592.8 604.6 727.5 747.4 751.0 4719.8 4733.7 4779.2 4828.7 4831.3 60483.7 78726.8 88148.0 88314.6 89056.0 75498.2 76593.0 77859.6 78369.2 80477.0 46254.5 46657.8 55485.7 68287.7 68381.3 8804.3 9110.2 9242.9 9244.7 9398.9 47297.3 47680.3 48245.3 48421.3 49004.3 58953.4 60071.0 64130.7 64939.0 65105.7 10481.0 10696.4 10818.0 10923.6 11020.9 11629.6 11659.9 11755.9 11770.5 11852.9 12330.0 12403.2 12423.9 12482.5 12629.7 11887.4 12043.3 12069.2 12321.6 12474.8 11502.7 11737.9 11808.4 12024.8 12109.5 9997.6 10262.6 10349.7 10654.7 11202.0 10253.5 10426.2 10440.3 10563.6 10582.3 12:37:58 INFO - PROCESS | 7117 | -------- Summary: end -------- 12:37:58 INFO - PROCESS | 7117 | 12:37:59 INFO - TEST-INFO | 7117: exit 0 12:37:59 INFO - TEST-OK | dromaeo_css | took 1114560ms 12:37:59 INFO - TEST-START | kraken 12:37:59 INFO - operating with platform_type : linux_ 12:37:59 INFO - Initialising browser for kraken test... 12:37:59 INFO - TEST-INFO | started process 7423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcAlJFn/profile http://localhost:52018/getInfo.html) 12:38:03 INFO - PROCESS | 7423 | __metrics Screen width/height:1600/1200 12:38:03 INFO - PROCESS | 7423 | colorDepth:24 12:38:03 INFO - PROCESS | 7423 | Browser inner width/height: 1024/697 12:38:03 INFO - PROCESS | 7423 | __metrics 12:38:04 INFO - PROCESS | 7423 | 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:38:04 INFO - PROCESS | 7423 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:05 INFO - TEST-INFO | 7423: exit 0 12:38:05 INFO - Browser initialized. 12:38:05 INFO - Running cycle 1/1 for kraken test... 12:38:05 INFO - TEST-INFO | started process 7515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcAlJFn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:16 INFO - PROCESS | 7515 | RSS: Main: 141721600 12:38:16 INFO - PROCESS | 7515 | 12:38:19 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:20 INFO - PROCESS | 7515 | RSS: Main: 183496704 12:38:20 INFO - PROCESS | 7515 | 12:38:22 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-dft) 12:38:23 INFO - PROCESS | 7515 | RSS: Main: 173248512 12:38:23 INFO - PROCESS | 7515 | 12:38:26 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-fft) 12:38:26 INFO - PROCESS | 7515 | RSS: Main: 264597504 12:38:26 INFO - PROCESS | 7515 | 12:38:28 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-oscillator) 12:38:29 INFO - PROCESS | 7515 | RSS: Main: 171528192 12:38:29 INFO - PROCESS | 7515 | 12:38:31 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:32 INFO - PROCESS | 7515 | RSS: Main: 173387776 12:38:32 INFO - PROCESS | 7515 | 12:38:34 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52018/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:35 INFO - PROCESS | 7515 | RSS: Main: 210677760 12:38:35 INFO - PROCESS | 7515 | 12:38:38 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52018/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:39 INFO - PROCESS | 7515 | RSS: Main: 211480576 12:38:39 INFO - PROCESS | 7515 | 12:38:42 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52018/tests/kraken/driver.html?testName=json-parse-financial) 12:38:42 INFO - PROCESS | 7515 | RSS: Main: 210063360 12:38:42 INFO - PROCESS | 7515 | 12:38:44 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:44 INFO - PROCESS | 7515 | RSS: Main: 172015616 12:38:44 INFO - PROCESS | 7515 | 12:38:46 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:47 INFO - PROCESS | 7515 | RSS: Main: 179408896 12:38:47 INFO - PROCESS | 7515 | 12:38:48 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:38:49 INFO - PROCESS | 7515 | RSS: Main: 188616704 12:38:49 INFO - PROCESS | 7515 | 12:38:52 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:52 INFO - PROCESS | 7515 | RSS: Main: 196984832 12:38:52 INFO - PROCESS | 7515 | 12:38:55 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:56 INFO - PROCESS | 7515 | RSS: Main: 193150976 12:38:56 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52018/tests/kraken/driver.html?testName=ai-astar) 12:38:57 INFO - PROCESS | 7515 | RSS: Main: 244989952 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | __start_tp_report 12:38:57 INFO - PROCESS | 7515 | _x_x_mozilla_page_load 12:38:57 INFO - PROCESS | 7515 | _x_x_mozilla_page_load_details 12:38:57 INFO - PROCESS | 7515 | |i|pagename|runs| 12:38:57 INFO - PROCESS | 7515 | |0;ai-astar;103;114;113;111;113;112;114;112;113;112 12:38:57 INFO - PROCESS | 7515 | |1;audio-beat-detection;140;124;117;165;122;117;117;118;151;117 12:38:57 INFO - PROCESS | 7515 | |2;audio-dft;160;161;159;160;162;161;160;161;159;161 12:38:57 INFO - PROCESS | 7515 | |3;audio-fft;74;75;77;108;76;76;74;77;99;75 12:38:57 INFO - PROCESS | 7515 | |4;audio-oscillator;81;81;114;82;82;81;100;82;82;113 12:38:57 INFO - PROCESS | 7515 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;116;117;117 12:38:57 INFO - PROCESS | 7515 | |6;imaging-darkroom;147;145;146;146;146;146;145;145;145;145 12:38:57 INFO - PROCESS | 7515 | |7;imaging-desaturate;84;84;85;85;84;84;85;84;84;84 12:38:57 INFO - PROCESS | 7515 | |8;json-parse-financial;52;51;51;52;51;51;52;52;51;51 12:38:57 INFO - PROCESS | 7515 | |9;json-stringify-tinderbox;60;60;59;60;59;60;59;60;60;60 12:38:57 INFO - PROCESS | 7515 | |10;stanford-crypto-aes;78;81;75;75;75;75;75;80;74;75 12:38:57 INFO - PROCESS | 7515 | |11;stanford-crypto-ccm;132;129;132;122;123;123;120;122;173;122 12:38:57 INFO - PROCESS | 7515 | |12;stanford-crypto-pbkdf2;159;159;157;156;158;158;162;157;157;157 12:38:57 INFO - PROCESS | 7515 | |13;stanford-crypto-sha256-iterative;63;65;62;64;62;64;63;61;62;61 12:38:57 INFO - PROCESS | 7515 | __end_tp_report 12:38:57 INFO - PROCESS | 7515 | __start_cc_report 12:38:57 INFO - PROCESS | 7515 | _x_x_mozilla_cycle_collect,1633 12:38:57 INFO - PROCESS | 7515 | __end_cc_report 12:38:57 INFO - PROCESS | 7515 | __startTimestamp1487882337968__endTimestamp 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | ------- Summary: start ------- 12:38:57 INFO - PROCESS | 7515 | Number of tests: 14 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:1.00 12:38:57 INFO - PROCESS | 7515 | Values: 103.0 114.0 113.0 111.0 113.0 112.0 114.0 112.0 113.0 112.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:123.00 stddev:17.23 (14.0%) stddev-sans-first:17.79 12:38:57 INFO - PROCESS | 7515 | Values: 140.0 124.0 117.0 165.0 122.0 117.0 117.0 118.0 151.0 117.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 12:38:57 INFO - PROCESS | 7515 | Values: 160.0 161.0 159.0 160.0 162.0 161.0 160.0 161.0 159.0 161.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.04 (15.8%) stddev-sans-first:12.49 12:38:57 INFO - PROCESS | 7515 | Values: 74.0 75.0 77.0 108.0 76.0 76.0 74.0 77.0 99.0 75.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:81.50 stddev:13.76 (16.9%) stddev-sans-first:14.22 12:38:57 INFO - PROCESS | 7515 | Values: 81.0 81.0 114.0 82.0 82.0 81.0 100.0 82.0 82.0 113.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:38:57 INFO - PROCESS | 7515 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 12:38:57 INFO - PROCESS | 7515 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 12:38:57 INFO - PROCESS | 7515 | Values: 84.0 84.0 85.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 12:38:57 INFO - PROCESS | 7515 | Values: 52.0 51.0 51.0 52.0 51.0 51.0 52.0 52.0 51.0 51.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 12:38:57 INFO - PROCESS | 7515 | Values: 60.0 60.0 59.0 60.0 59.0 60.0 59.0 60.0 60.0 60.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.00 stddev:2.45 (3.3%) stddev-sans-first:2.52 12:38:57 INFO - PROCESS | 7515 | Values: 78.0 81.0 75.0 75.0 75.0 75.0 75.0 80.0 74.0 75.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:126.00 stddev:15.80 (12.5%) stddev-sans-first:16.74 12:38:57 INFO - PROCESS | 7515 | Values: 132.0 129.0 132.0 122.0 123.0 123.0 120.0 122.0 173.0 122.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:1.70 (1.1%) stddev-sans-first:1.76 12:38:57 INFO - PROCESS | 7515 | Values: 159.0 159.0 157.0 156.0 158.0 158.0 162.0 157.0 157.0 157.0 12:38:57 INFO - PROCESS | 7515 | 12:38:57 INFO - PROCESS | 7515 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 12:38:57 INFO - PROCESS | 7515 | Values: 63.0 65.0 62.0 64.0 62.0 64.0 63.0 61.0 62.0 61.0 12:38:57 INFO - PROCESS | 7515 | -------- Summary: end -------- 12:38:57 INFO - PROCESS | 7515 | 12:38:58 INFO - TEST-INFO | 7515: exit 0 12:38:59 INFO - TEST-OK | kraken | took 59396ms 12:38:59 INFO - SUITE-END | took 1173s 12:38:59 INFO - Completed test suite (00:19:34) 12:38:59 INFO - javascript benchmark 12:38:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.5446210299506, 3169.9524507132396, 3175.1109689287, 3199.456092464281, 3206.9518957215646, 5556.638818476797, 5605.439456054392, 5620.381758006616, 5638.718064096799, 5651.152327150924, 5574.554035677146, 5624.690642014688, 5630.324361076677, 5640.351359593637, 5646.096624540074, 5068.214426763849, 5096.210087436453, 5137.255098010786, 5161.071007218699, 5176.611754118456, 5061.519155680223, 5135.12702840518, 5188.0, 5193.324867767185, 5194.065068287707, 4973.0, 5004.674696144739, 5047.0, 5091.0, 5130.127878260686, 5141.640085194038, 5147.4080480744815, 5202.76587553561, 5206.453322401169, 5220.504052115043, 4969.304297398367, 4988.775505102279, 5090.567301779353, 5111.923321150186, 5156.845294641167, 5434.456554344573, 5452.2094296327205, 5455.318085239345, 5524.58565607577, 5567.137093750475, 5869.7652093916195, 5902.852428689317, 5934.792282270143, 5944.673042982634, 5950.2264705587995, 5872.442117998783, 5953.315368732565, 5969.044952807573, 5980.760769569212, 5983.790567330166, 5610.382857885629, 5658.292713410824, 5659.717014149276, 5661.66030038199, 5698.886022279531, 6212.534059945522, 6215.96892015537, 6227.0, 6240.687965601702, 6244.625322480666, 5740.913886291625, 5795.043817770105, 5955.37468565803, 5969.522438204933, 5971.4327138921735, 5941.31674857397, 5962.850928726816, 5974.701264936736, 6028.909566356509, 6063.151158837766, 6006.309274433496, 6008.729607167688, 6016.42843929826, 6031.517478601789, 6062.302835173923, 5880.500157486662, 5965.910511342333, 6010.609310394811, 6025.6685882276015, 6030.668313242726, 4566.13243483737, 4576.725396476222, 4579.6794224403975, 4594.1271158479785, 4637.7449240291435, 4062.5734297898885, 4086.8160932758096, 4093.5906409358827, 4105.158442519277, 4124.257633625916, 5635.633683810539, 5651.717414129277, 5653.745581448845, 5658.0381335173115, 5682.261306030272, 5795.797147099831, 5864.325602555676, 5881.147233651182, 5915.467607915222, 5926.496247818984, 5650.039493286151, 5655.604107712421, 5659.377468478464, 5661.122526008476, 5676.2337084493065, 5122.615803814654, 5125.15434953236, 5141.640085194001, 5143.639945203875, 5176.818811341585, 5999.820005399845, 6118.893302669041, 6140.662263575547, 6142.539309551891, 6172.783952561639, 6010.81967540957, 6017.638941663514, 6035.698215089315, 6038.245219347582, 6064.636121832704, 6164.0, 6233.096201050913, 6235.314115447388, 6238.656873871981, 6256.092866534236, 5625.662460252398, 5651.378348381592, 5769.74036168365, 5916.911246331222, 5918.970405147947, 5891.558133140117, 5984.222051133324, 5984.311804142405, 5999.49004334619, 6006.33930267679, 5804.303483581828, 5842.503387212135, 5851.444112809447, 5855.59010869235, 5855.882882342415, 5670.376258611632, 5812.982728022664, 5826.621269617462, 5828.0966450200285, 5832.62087964281, 5713.028785106459, 5719.942800571941, 5746.569007324384, 5811.82564523065, 5838.0, 5873.676947767914, 5876.676782776988, 5876.941230587639, 5879.588428810113, 5885.08781138907, 5639.830805075854, 5688.232088668143, 5712.971435142797, 5717.5425965921795, 5757.8560535986935], "value": 5510.097835986771, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.991600125998, 594.4679511836905, 607.6384551192042, 612.7089632424598, 632.9556232216845, 33970.0, 34548.65451345486, 36223.81888090562, 46926.765366173124, 48360.758196209055, 45769.771151144196, 45854.77072614641, 46071.0, 46195.0, 46202.537974620245, 8887.866681999774, 9027.819443611157, 9031.503267320295, 9033.23217526511, 9034.0, 8393.202645748675, 8598.87101693475, 8836.381453298272, 10543.63097291595, 10826.350418974847, 10868.239223254375, 10933.398663073527, 10941.56233750649, 10945.781084378308, 10948.124150068015, 10767.569297228101, 10817.675469735921, 10828.458577071115, 10837.945810270978, 10838.078763305128, 10688.038076573146, 10752.516136773864, 10753.247272690915, 10754.892451075468, 10763.892361076367, 42233.577664223274, 42417.57582424198, 42493.57506424927, 42537.14925701469, 42580.361294580296, 3588.5825099085714, 3744.8882275693754, 3807.3146833569945, 3816.9312592474153, 3822.847086116552, 31169.0, 31828.522572161437, 31831.840840795878, 32476.512852307234, 32557.51163732546, 4425.314076318144, 4550.522195169526, 4566.474855391639, 4566.771661416949, 4692.085043416535, 335468.0, 336513.0, 337126.0, 337900.0, 338639.0, 58038.419615804145, 58132.709336453045, 58133.70933145307, 58390.0, 58554.70722646359, 38559.80720096381, 39392.80303598464, 39514.80242598826, 41088.38367424491, 41406.79296603498, 17967.37114201023, 18024.0, 18074.457766267034, 18075.909620451814, 18091.36680216186, 13057.869421305666, 13406.061575689608, 13461.25963072021, 13464.528741494196, 13466.461341546425, 17525.824741752418, 18780.967046812555, 19100.522486937938, 19432.028398580016, 19604.607907841764, 7135.357817796424, 7269.273072692794, 7325.450591205681, 7334.799560131939, 7440.627968601549, 988.3575675810637, 1074.9462526873624, 1107.070061148639, 1119.9440027998567, 1129.3957732613012, 32797.67202327994, 32865.50701739476, 33034.83482582572, 33038.0, 33402.49896251558, 1114.5486078138367, 1135.2790977729037, 1135.5741596901162, 1194.946227419768, 1204.4519743516678, 16250.51248462548, 17253.913730431268, 17338.566535836704, 17418.56453588645, 17430.738538921927, 463094.0, 475210.0, 475399.0, 475966.0, 476299.0, 60286.698566506886, 60939.39060609426, 60974.695126524086, 60997.695011525546, 61079.69460152671, 1314.3691028306275, 1392.7980442835935, 1423.3241505968713, 1462.2104063805425, 1464.809574755275, 31692.841535793097, 33926.32147357088, 34051.14872128118, 34140.0, 34265.29346072714, 51245.23132152946, 51894.22158667548, 52083.0, 52104.0, 52213.21680174724, 381311.0, 381969.0, 384945.0, 385107.0, 386826.0, 37126.25747484981, 37683.196745828, 44342.556574433846, 44502.0, 45124.77437612791, 41760.0, 47331.763341183076, 47367.0, 47792.522074778804, 47895.76052119717, 40450.39324410077, 41075.58924410718, 41356.0, 41531.0, 42880.14239715251, 41362.0, 41382.586174137876, 41849.79075104605, 42190.0, 42835.7858210707, 40993.0, 41436.1712765749, 41704.37443438412, 41908.58091419169, 41910.580894190665, 35160.29679406449, 36612.450813238356, 36806.63193368032, 37321.626783731816, 37669.62330376771, 28055.719442806127, 28340.574891376233, 28499.28751781222, 28508.0, 28520.0], "value": 20619.128129966564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.8352658936425, 414.07867494824, 432.9935050974236, 437.87520556641346, 437.9934300985486, 18213.544661383472, 18897.433077007696, 19577.902110489445, 19722.802771972278, 19880.204791808348, 19392.806071939278, 19478.513037174078, 19662.70505942412, 19912.303069392576, 20074.0, 5698.917205730908, 5965.284165900098, 5969.283685957669, 5975.850603734898, 5976.641401515902, 4371.14762621289, 4495.617872480843, 4497.190505708971, 5874.206982057411, 5951.672658003829, 6529.836754081139, 6554.541182117254, 6558.672066396685, 6569.934300657004, 6640.535162538624, 6469.171987857226, 6536.0, 6554.754596626625, 6598.47212223021, 6648.7672931447405, 5913.497352725023, 5918.526517878602, 5921.526277897801, 5922.763089476416, 5926.1110833374905, 15230.695386092328, 15965.281562329606, 22377.77622223773, 23214.41963950898, 23342.949567269512, 2315.30540837748, 2504.261242933339, 2879.3953269813364, 3026.651935027456, 3108.533719942004, 10816.891831081668, 10906.0, 10910.23628346016, 11167.106631469464, 11357.716057098556, 1952.453313072342, 2010.1657812008, 2021.070307658479, 2068.141721185706, 2068.98965505173, 64287.0, 64666.67666661637, 72733.63633181801, 77273.22726772772, 83623.0, 11399.544018239178, 11492.770144597062, 11588.0, 11626.128040396836, 11779.469923853276, 16537.503874883772, 16564.503064908073, 16574.08842513673, 16581.170941452878, 16584.50246492607, 8468.788280292918, 8679.305655547541, 8712.825743485095, 8923.241524470362, 8924.910750892537, 8193.344532437392, 8308.941647202575, 8315.334773218128, 8509.10654381281, 8572.099929507312, 5070.873228169252, 5073.822416215415, 5091.5672167865405, 5120.743962801845, 5194.584433245332, 2054.219396629301, 2075.98962005192, 2111.4088055344528, 2121.7241758571286, 2146.162996431393, 850.8553545897213, 917.3807679816098, 940.290080988849, 964.2767924056957, 1024.0834453164375, 18120.365787197385, 18858.339958101675, 19835.10742016613, 19986.500337491678, 20295.188192472135, 953.3469573342283, 986.2356673578034, 1009.1129587670955, 1009.9747506312254, 1052.1004541117388, 10539.262251642465, 11032.117430605533, 11077.279976801483, 11115.333080015063, 11262.267952583055, 348046.0, 350024.0, 452034.0, 459153.0, 462921.0, 83133.0, 93635.53182234181, 95782.52108739411, 97499.0, 97778.511107444, 1035.1873779083382, 1053.6680945502296, 1072.4048153275007, 1094.8029354716227, 1098.8791232964368, 17670.734938976184, 18065.187066581773, 18072.72890906611, 18152.45542633723, 18469.630607388044, 28760.712392875805, 33061.66938330586, 40640.39039414352, 40792.0, 41326.586734132274, 51399.48600513947, 52128.0, 53183.46816531785, 59813.401865980784, 60586.0, 8930.374873759034, 9036.638534458549, 9118.270538356783, 9183.403078799856, 9399.953000234955, 13127.343632818513, 13621.591352259447, 13757.724845502833, 13793.517226897011, 13810.171389716648, 11509.194356394972, 11680.649580512598, 11838.763224735285, 11984.40077996114, 12124.0, 7331.973523706792, 11658.88341116578, 11844.0, 12029.097817663534, 12215.877841221474, 11573.363465009505, 11853.288802671867, 11988.880111198776, 12200.389980501117, 12288.447019884305, 7927.365810735012, 8127.415154044905, 8281.95859020701, 8803.515806630698, 9211.355205135844, 9282.350235483722, 11585.7103572408, 11689.298642081163, 12148.514059437524, 12181.269123852597], "value": 9372.842111278698, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.5295822941082, 1482.9258537073144, 1506.4200282891086, 1664.3509031477727, 1799.370220422852, 7844.764657060283, 8371.539565323912, 8672.392932494728, 8680.826383472328, 8886.822263554724, 8645.567721613925, 8705.782355441117, 8711.30309575234, 8722.956385218082, 8734.257588105003, 2423.5274121546304, 2445.4864478459544, 2447.547203767309, 2448.6449464827588, 2453.5338285725743, 2404.441075053195, 2477.541654793869, 2478.045952308365, 2480.1443501991876, 2480.6775119234476, 2443.816713746476, 2448.3511869354634, 2450.987745061281, 2457.987710061447, 2458.0782206672498, 2352.9058837646476, 2375.0, 2406.0135344508753, 2420.7700268474555, 2421.140495124223, 2290.7709229077127, 2306.3888069661552, 2306.9653955190684, 2307.4462129088897, 2314.2131675230503, 8551.871721924175, 8641.827163456759, 8682.565871706389, 8735.0, 8735.650573977033, 5347.438518955492, 5555.055640541118, 5560.7219639017885, 5571.888562228733, 5572.498475137217, 3454.4818277258614, 3466.9479957800654, 3520.612732599412, 3528.2414280929465, 3790.90522736931, 1174.4714878304712, 1178.7406770510474, 1183.7336599265182, 1217.9208351457128, 2251.7860803223666, 11715.472803723767, 12133.211341262879, 12135.575254866126, 12155.270683759003, 12178.330191839445, 4756.405449318835, 4975.726335051607, 5138.794448222104, 5140.820071297487, 5163.044836705221, 9807.362521436084, 9846.113849753414, 9895.60417583303, 9900.950495247622, 9906.653267135616, 5598.496135347838, 5598.636088654224, 5607.607467477237, 5613.831585052455, 5619.044762390404, 5048.343715316985, 5051.87370315745, 5103.795848166106, 5107.080725469377, 5154.664946778447, 3782.791946442972, 3837.6162383761957, 3908.413737939332, 3926.803659816998, 3967.2263908537557, 1161.4715304536417, 1179.823026546025, 1182.4974385885964, 1190.2917763930448, 1192.5885569478517, 831.5260301628014, 955.5031383680447, 958.5638534466801, 959.6881013670585, 961.3030552849128, 5804.767809287581, 5823.155642431823, 5867.237259156283, 5959.493443057302, 6154.630722156685, 451.4943263544785, 453.9024109816339, 461.45548253061037, 470.11148928525114, 475.1044281529273, 4096.815643296059, 4222.59885310895, 4227.408162857202, 4227.450431443954, 4242.596953289432, 10514.106300964351, 10778.892211077946, 10846.132309415229, 10869.728256793644, 10910.727231819268, 10751.731206719895, 10762.623308184176, 10781.784364312827, 10785.245032847626, 10804.837927431096, 7887.092984306763, 8043.276105150565, 8056.556889371141, 8095.583272927214, 8231.588420578948, 5523.8895222096135, 5570.220169176399, 5875.882482350244, 6056.57603967718, 6060.969455312168, 9597.47213903242, 9819.410835349901, 9856.457894815854, 9874.901250987397, 9888.653897113567, 9258.120478554527, 9485.525723713925, 9725.951370243103, 9931.205503559842, 10044.045815647794, 7919.406044546567, 8005.159458257032, 8192.385571082312, 8213.055498617736, 8432.620532075949, 8273.214044665747, 8545.658173672984, 8549.743507694779, 8629.266512346521, 8637.654493820428, 7532.7740167795055, 7624.771256862303, 7644.464887457824, 7790.376769858284, 7812.687492500237, 7434.3309102181065, 7474.140473845578, 7515.436342274242, 7531.284527969834, 7689.730859419893, 7002.824929376807, 7140.178879428932, 7141.178764441948, 7168.498205125591, 7170.820729481805, 4864.92702609454, 4867.780949857194, 4929.433115191799, 5191.997289918879, 5264.210368444764, 5149.459306772885, 5300.3904550975585, 5308.867278317918, 5370.946290537201, 5494.752736126804], "value": 4605.447252608336, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3932243317164, 338.0618782877516, 339.070945609031, 350.75622442402533, 352.4361022364217, 5314.920276195855, 5320.361556613202, 5336.252924590561, 5342.652727572715, 5380.838574842761, 5298.788048478056, 5305.495977882105, 5342.278792363029, 5363.8122665706705, 5371.919421208675, 3635.6731691717323, 3937.960620393795, 4048.210598933209, 4078.9184216315803, 4088.5911408859024, 4090.6318431341174, 4118.608732170439, 4120.114175452277, 4129.504459464868, 4136.214119317335, 4082.9183416331657, 4100.015996160915, 4108.794560271989, 4114.033202197481, 4136.751794892301, 4121.340585506305, 4124.979375103136, 4133.359329303963, 4137.110521237918, 4159.750414975081, 3604.0629436346476, 3672.081979505124, 3685.594584595692, 3699.4820725098507, 3703.3889408247605, 5089.134847076006, 5092.8217512387255, 5104.897902041976, 5108.909109988478, 5120.1039818031695, 4679.836205732817, 4695.88260293492, 4701.247800351927, 4723.921474551221, 4739.170645137087, 5251.894962100775, 5420.186971954199, 5454.34547854256, 5461.69960652164, 5478.835634930959, 4000.6399424051683, 4010.3130902295534, 4016.879493615196, 4017.979910100431, 4045.6763458923215, 5450.618456708032, 5640.576956728261, 5712.371639119693, 5732.0, 5744.741486633112, 4142.730722503027, 4245.27830268855, 4252.702310838212, 4263.445752052214, 4270.444842170498, 4310.762908040025, 4340.153670034376, 4343.131373725268, 4346.326319420495, 4355.760433176142, 4531.637469002472, 4791.425028996473, 4860.635452341088, 4878.902421951541, 4881.219004959189, 5554.861128471821, 5558.194061861008, 5558.471945165203, 5560.471755183251, 5567.8886422272135, 1422.11118051218, 1430.106183635228, 1431.3630434456775, 1441.0489077209202, 1447.8190226221723, 964.5129209749032, 992.8808542974889, 994.3785134291068, 1003.3628645809963, 1025.3489034463169, 5138.150265904272, 5160.406553246425, 5161.329027226511, 5176.689398636018, 5189.7405129743365, 5424.891502169935, 5449.782008719607, 5468.835934921959, 5523.502884740312, 5540.952476138188, 5068.746562671851, 5187.780871495195, 5192.766325515361, 5220.869478262998, 5228.353068783321, 2843.928901777472, 2852.3297025199063, 2859.7569206617673, 2906.0264811288457, 2915.475214461375, 5631.71841407928, 5634.408387119375, 5655.349634791969, 5660.433956604389, 5694.345150307685, 5238.449962753933, 5508.366537848118, 5513.338399392099, 5514.365847927459, 5568.0, 5589.462897703164, 5600.635958662755, 5629.943700563023, 5643.053146664394, 5658.094704847287, 5246.868828279324, 5383.973080134574, 5413.269208656939, 5424.396289780849, 5494.36814766307, 5399.865003374947, 5403.648762830403, 5407.324084489439, 5415.458454154711, 5420.701861397503, 5650.576206784425, 5685.374608793112, 5796.971015144897, 5808.6224395414165, 5810.389909059488, 4066.4916885389325, 4171.144915292419, 4197.559256278047, 4199.538050814469, 4207.747535147901, 5551.389347171888, 5670.659760414388, 5696.943030569641, 5714.828555143353, 5717.571182161271, 5465.836024919259, 5468.56251499887, 5473.2063850742215, 5488.862778430571, 5493.560515158698, 5434.619576629598, 5438.428964958623, 5456.809011684572, 5464.644798088111, 5477.972610136924, 5179.663321884065, 5375.569954403716, 5398.568114550905, 5400.191900211947, 5415.6479828811, 5471.589630777628, 5474.069408200536, 5489.972550137224, 5498.972505137609, 5500.42245564226, 5379.381371142213, 5398.406175320633, 5414.458554144711, 5419.160030195326, 5425.159100339453], "value": 4204.4811448765895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.3669222891115, 785.2540086917427, 811.2009670474581, 848.3086284677987, 869.8695195720637, 13473.191608503472, 13630.386632601532, 13646.2494562799, 13666.863331366696, 14345.852331813456, 12368.319742414164, 13692.863071369284, 13789.724205515884, 13809.447622095104, 13811.37848796804, 829.0797215091244, 857.2970164465141, 857.9142085791433, 859.0250066174905, 859.3812455032398, 849.5072857742495, 852.1776485691306, 852.9616167272457, 853.6201390381283, 853.9701110461135, 873.829603227371, 879.1252703559967, 880.1682410122437, 880.1946219209448, 880.8106257154742, 862.3704695572204, 867.2454964181171, 872.7861673889875, 874.2743522875998, 874.2743522875998, 641.3105911145491, 643.7296335539085, 644.0853987337991, 644.2623196440097, 644.2880616918285, 12008.099392545506, 12042.337671428068, 12050.879491205063, 12126.6362009139, 13340.199588024652, 12329.260244385365, 12828.35858207086, 12837.358132093357, 12854.293013884233, 12958.676033099153, 10692.893071069346, 10697.572097116106, 10781.730456738565, 10801.729956751144, 11055.170862185289, 3678.926421471582, 3696.5748938872107, 3740.551133863954, 3771.2268984858038, 3800.8669696560764, 60161.0, 61376.69311653458, 61568.0, 61676.69161654208, 62775.37224627787, 9375.390599611004, 9568.665096721721, 9765.16996055329, 10467.214958878114, 10753.78492430147, 19417.902910485358, 19655.901720491307, 19669.704954425695, 19691.01544922748, 19701.60596788056, 8001.839963200703, 8026.959865200637, 8229.79425514367, 8289.461185022954, 8305.859620115816, 4580.267157254823, 4655.092257009918, 4721.95278047222, 4752.738599377068, 4765.73788441639, 3196.4566023776015, 3289.292802047571, 3289.3750187464307, 3291.835408229579, 3291.8683252670103, 602.8703828676768, 610.9725062372204, 629.9779507717208, 678.6878036103448, 687.7833482453011, 600.3996003996004, 649.912261844645, 659.0674196012684, 719.9928000720031, 756.6784116750359, 8872.467651940904, 8990.370674052885, 9199.954000229956, 9324.813503729887, 9475.147236748588, 592.7688201601379, 604.6070054464545, 727.4725823777719, 747.4020783373279, 751.0, 4719.764011799396, 4733.692309999839, 4779.163646361872, 4828.7102773833685, 4831.347768051339, 60483.69758151181, 78726.81909771358, 88148.0, 88314.55842720745, 89056.0, 75498.24501754912, 76593.0, 77859.61070194613, 78369.21630783733, 80477.0, 46254.537454625024, 46657.76671116623, 55485.72257138688, 68287.65856170787, 68381.31618683749, 8804.251638610789, 9110.225630821455, 9242.907570924204, 9244.676436324697, 9398.859017114612, 47297.29054064261, 47680.28479572879, 48245.27632085592, 48421.273680895516, 49004.2649360267, 58953.41046589479, 60071.0, 64130.67934660297, 64939.0, 65105.67447162734, 10481.0, 10696.358218506915, 10818.02637762605, 10923.617673381394, 11020.944895275472, 11629.59296424621, 11659.86516139917, 11755.88993465636, 11770.49375844826, 11852.940735296614, 12330.0, 12403.193792403465, 12423.875761242272, 12482.500699971899, 12629.684257893627, 11887.405629718307, 12043.337616431181, 12069.215500992408, 12321.630351089481, 12474.75050499003, 11502.712432189262, 11737.88262117368, 11808.350540720343, 12024.75950480968, 12109.455074521844, 9997.600095996078, 10262.58949642006, 10349.74125646865, 10654.680359589225, 11202.0, 10253.487325633838, 10426.165906727596, 10440.269181157246, 10563.630272940718, 10582.312149710244], "value": 6913.008214202807, "unit": "score"}], "name": "dromaeo_css", "value": 7227.693315460668, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 111.0, 113.0, 112.0, 114.0, 112.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 124.0, 117.0, 165.0, 122.0, 117.0, 117.0, 118.0, 151.0, 117.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 162.0, 161.0, 160.0, 161.0, 159.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 108.0, 76.0, 76.0, 74.0, 77.0, 99.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 82.0, 82.0, 81.0, 100.0, 82.0, 82.0, 113.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 51.0, 51.0, 52.0, 52.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 75.0, 75.0, 75.0, 75.0, 75.0, 80.0, 74.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 132.0, 122.0, 123.0, 123.0, 120.0, 122.0, 173.0, 122.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 157.0, 156.0, 158.0, 158.0, 162.0, 157.0, 157.0, 157.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 64.0, 62.0, 64.0, 63.0, 61.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1456.3, "alertThreshold": 2.0}]} 12:38:59 INFO - Return code: 0 12:38:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:38:59 INFO - # TBPL SUCCESS # 12:38:59 INFO - Running post-action listener: _resource_record_post_action 12:38:59 INFO - [mozharness: 2017-02-23 20:38:59.306372Z] Finished run-tests step (success) 12:38:59 INFO - Running post-run listener: _resource_record_post_run 12:38:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 321921024; Read time: 96; Write time: 180200 12:38:59 INFO - TinderboxPrint: CPU usage
13.0% 12:38:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 96 12:38:59 INFO - TinderboxPrint: I/O write bytes / time
321,921,024 / 180,200 12:38:59 INFO - TinderboxPrint: CPU idle
8,253.0 (87.0%) 12:38:59 INFO - TinderboxPrint: CPU user
1,190.5 (12.6%) 12:38:59 INFO - TinderboxPrint: Swap in / out
0 / 0 12:38:59 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 101044224; Read time: 84; Write time: 72964 12:38:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220876800; Read time: 12; Write time: 107236 12:38:59 INFO - Running post-run listener: _upload_blobber_files 12:38:59 INFO - Blob upload gear active. 12:38:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:59 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:38:59 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:38:59 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:39:00 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:03 INFO - (blobuploader) - INFO - Done attempting. 12:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:04 INFO - (blobuploader) - INFO - Done attempting. 12:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:05 INFO - (blobuploader) - INFO - Done attempting. 12:39:05 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:05 INFO - Return code: 0 12:39:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c1ac2d1cd9fe3b51d5aa223addbd9090eb07d8bf6ba9dfe430cd94baf864db4c270c61abbd5477ff9722a8eceb7b0574923815401542fd4ed7e618420c2c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/636318cefd63c33e5f539df832500e86c13b495ec7f6ed8e84a0c69ce63e35f28fe3278e760f5c70bf788cdfe5aeebe311938eb88f40f91919ad8adef4d2e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac3928b605c692e6100f6116375457ba3d5c912a712d622bede16228629af412ea331e71641f4f695fcc12f223eed4a8053251f82fd36891e622b5c965d3356"} 12:39:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:05 INFO - Contents: 12:39:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c1ac2d1cd9fe3b51d5aa223addbd9090eb07d8bf6ba9dfe430cd94baf864db4c270c61abbd5477ff9722a8eceb7b0574923815401542fd4ed7e618420c2c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/636318cefd63c33e5f539df832500e86c13b495ec7f6ed8e84a0c69ce63e35f28fe3278e760f5c70bf788cdfe5aeebe311938eb88f40f91919ad8adef4d2e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac3928b605c692e6100f6116375457ba3d5c912a712d622bede16228629af412ea331e71641f4f695fcc12f223eed4a8053251f82fd36891e622b5c965d3356"} 12:39:05 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:05 INFO - Copying logs to upload dir... 12:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.286147 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-23 12:39:04.240668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 12:39:04.244380) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130 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-Beta/sha512/5c1ac2d1cd9fe3b51d5aa223addbd9090eb07d8bf6ba9dfe430cd94baf864db4c270c61abbd5477ff9722a8eceb7b0574923815401542fd4ed7e618420c2c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/636318cefd63c33e5f539df832500e86c13b495ec7f6ed8e84a0c69ce63e35f28fe3278e760f5c70bf788cdfe5aeebe311938eb88f40f91919ad8adef4d2e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac3928b605c692e6100f6116375457ba3d5c912a712d622bede16228629af412ea331e71641f4f695fcc12f223eed4a8053251f82fd36891e622b5c965d3356"} build_url:https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/HE0nsM3GS_6nWqC_YsxXpw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c1ac2d1cd9fe3b51d5aa223addbd9090eb07d8bf6ba9dfe430cd94baf864db4c270c61abbd5477ff9722a8eceb7b0574923815401542fd4ed7e618420c2c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/636318cefd63c33e5f539df832500e86c13b495ec7f6ed8e84a0c69ce63e35f28fe3278e760f5c70bf788cdfe5aeebe311938eb88f40f91919ad8adef4d2e600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac3928b605c692e6100f6116375457ba3d5c912a712d622bede16228629af412ea331e71641f4f695fcc12f223eed4a8053251f82fd36891e622b5c965d3356"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 12:39:04.270860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:39:04.271172) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1487880946.191845-1299591130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:39:04.356073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 12:39:04.358381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 12:39:04.358669) ========= ========= Total master_lag: 0.17 =========