builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1476710264.52 results: success (0) buildid: 20161017033008 builduid: 5eb17a58d3d447358ad7092f15f945ce revision: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.517059) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.517520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.517823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.534063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.534453) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 06:17:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-17 06:17:45 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.672158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.672785) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016904 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.729447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:44.729890) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 06:17:45,540 truncating revision to first 12 chars 2016-10-17 06:17:45,540 Setting DEBUG logging. 2016-10-17 06:17:45,540 attempt 1/10 2016-10-17 06:17:45,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/78bd3dbc3dde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 06:17:45,847 unpacking tar archive at: fx-team-78bd3dbc3dde/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632710 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:45.376219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:45.376521) ========= script_repo_revision: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:45.376933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:45.377195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:45.386666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-17 06:17:45.387053) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:17:46 INFO - MultiFileLogger online at 20161017 06:17:46 in /builds/slave/test 06:17:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:17:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:46 INFO - {'append_to_log': False, 06:17:46 INFO - 'base_work_dir': '/builds/slave/test', 06:17:46 INFO - 'blob_upload_branch': 'Fx-Team', 06:17:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:46 INFO - 'branch': 'Fx-Team', 06:17:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:46 INFO - 'config_files': ('talos/linux_config.py',), 06:17:46 INFO - 'default_actions': ('clobber', 06:17:46 INFO - 'read-buildbot-config', 06:17:46 INFO - 'download-and-extract', 06:17:46 INFO - 'populate-webroot', 06:17:46 INFO - 'create-virtualenv', 06:17:46 INFO - 'install', 06:17:46 INFO - 'run-tests'), 06:17:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:46 INFO - 'download_minidump_stackwalk': True, 06:17:46 INFO - 'download_symbols': 'ondemand', 06:17:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:46 INFO - 'installer_path': 'installer.exe', 06:17:46 INFO - 'log_level': 'info', 06:17:46 INFO - 'log_name': 'talos', 06:17:46 INFO - 'log_to_console': True, 06:17:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:17:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:17:46 INFO - 'opt_config_files': (), 06:17:46 INFO - 'pip_index': False, 06:17:46 INFO - 'sps_profile': False, 06:17:46 INFO - 'sps_profile_interval': 0, 06:17:46 INFO - 'suite': 'dromaeojs', 06:17:46 INFO - 'system_bits': '32', 06:17:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:46 INFO - 'title': 'talos-linux64-ix-059', 06:17:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:46 INFO - 'use_talos_json': True, 06:17:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:46 INFO - 'work_dir': 'build'} 06:17:46 INFO - [mozharness: 2016-10-17 13:17:46.299861Z] Running clobber step. 06:17:46 INFO - Running pre-action listener: _resource_record_pre_action 06:17:46 INFO - Running main action method: clobber 06:17:46 INFO - rmtree: /builds/slave/test/build 06:17:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:17:47 INFO - Running post-action listener: _resource_record_post_action 06:17:47 INFO - [mozharness: 2016-10-17 13:17:47.279890Z] Finished clobber step (success) 06:17:47 INFO - [mozharness: 2016-10-17 13:17:47.279990Z] Running read-buildbot-config step. 06:17:47 INFO - Running pre-action listener: _resource_record_pre_action 06:17:47 INFO - Running main action method: read_buildbot_config 06:17:47 INFO - Using buildbot properties: 06:17:47 INFO - { 06:17:47 INFO - "project": "", 06:17:47 INFO - "product": "firefox", 06:17:47 INFO - "script_repo_revision": "production", 06:17:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:17:47 INFO - "repository": "", 06:17:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:17:47 INFO - "buildid": "20161017033008", 06:17:47 INFO - "pgo_build": "True", 06:17:47 INFO - "basedir": "/builds/slave/test", 06:17:47 INFO - "buildnumber": 1637, 06:17:47 INFO - "slavename": "talos-linux64-ix-059", 06:17:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:17:47 INFO - "platform": "ubuntu64_hw", 06:17:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:17:47 INFO - "branch": "fx-team", 06:17:47 INFO - "repo_path": "integration/fx-team", 06:17:47 INFO - "revision": "78bd3dbc3ddee84be7d9b79fde3614eec50d39a9", 06:17:47 INFO - "stage_platform": "linux64-pgo", 06:17:47 INFO - "builduid": "5eb17a58d3d447358ad7092f15f945ce", 06:17:47 INFO - "slavebuilddir": "test" 06:17:47 INFO - } 06:17:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:17:47 INFO - Running post-action listener: _resource_record_post_action 06:17:47 INFO - [mozharness: 2016-10-17 13:17:47.282456Z] Finished read-buildbot-config step (success) 06:17:47 INFO - [mozharness: 2016-10-17 13:17:47.282544Z] Running download-and-extract step. 06:17:47 INFO - Running pre-action listener: _resource_record_pre_action 06:17:47 INFO - Running main action method: download_and_extract 06:17:47 INFO - mkdir: /builds/slave/test/build/tests 06:17:47 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')]} 06:17:47 INFO - trying https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:17:47 INFO - Downloading https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:17:47 INFO - Downloaded 1361 bytes. 06:17:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:17:47 INFO - Using the following test package requirements: 06:17:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:17:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:17:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'jsshell-linux-x86_64.zip'], 06:17:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:17:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:17:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:17:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:17:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:17:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:17:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:17:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:17:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:47 INFO - Fetch https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:17:48 INFO - Http code: 200 06:17:48 INFO - via: 1.1 96255a5b0caf50bcafcd101c1ff13691.cloudfront.net (CloudFront) 06:17:48 INFO - x-amz-cf-id: 6hrBTUlSe-3cktsw3owJHBVLkrgCZ_gW9M5X6VX8SditSrakLTjYjA== 06:17:48 INFO - x-amz-version-id: 1C90RD_4zCWNPdEhajACMtI0vyWFPxXG 06:17:48 INFO - Expected file size: 22089665 06:17:48 INFO - Obtained file size: 22089665 06:17:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:17:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:17:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:52 INFO - Fetch https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:17:53 INFO - Http code: 200 06:17:53 INFO - via: 1.1 02192a27c967e955f8c815efa939bfc8.cloudfront.net (CloudFront) 06:17:53 INFO - x-amz-cf-id: 9jPV-EpjquCQHEQDqXJcAe73YJ6Ve3R58cyTaFcJXYOBQ9akmCOAdg== 06:17:53 INFO - x-amz-version-id: 1C90RD_4zCWNPdEhajACMtI0vyWFPxXG 06:17:53 INFO - Expected file size: 22089665 06:17:53 INFO - Obtained file size: 22089665 06:17:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:17:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:17:57 INFO - Fetch https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:17:58 INFO - Http code: 200 06:17:58 INFO - via: 1.1 ca024aca72de992a25bcd7fdcfe84b67.cloudfront.net (CloudFront) 06:17:58 INFO - x-amz-cf-id: yurkOyK2Zb6OYuWiBldZ0fdDAyVRjN6Q_1iBid83KbRAixuv64_BSw== 06:17:58 INFO - x-amz-version-id: 6xOAfMl.xcZKqgSaeNSwwOjKyK_DWZtK 06:17:58 INFO - Expected file size: 14409028 06:17:58 INFO - Obtained file size: 14409028 06:17: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')]} 06:17:59 INFO - trying https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:17:59 INFO - Downloading https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:18:01 INFO - Downloaded 59497589 bytes. 06:18:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:18:01 INFO - mkdir: /builds/slave/test/properties 06:18:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:01 INFO - Contents: 06:18:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:18:02 INFO - Running post-action listener: _resource_record_post_action 06:18:02 INFO - Running post-action listener: set_extra_try_arguments 06:18:02 INFO - [mozharness: 2016-10-17 13:18:02.284385Z] Finished download-and-extract step (success) 06:18:02 INFO - [mozharness: 2016-10-17 13:18:02.284616Z] Running populate-webroot step. 06:18:02 INFO - Running pre-action listener: _resource_record_pre_action 06:18:02 INFO - Running main action method: populate_webroot 06:18:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:02 INFO - '--tppagecycles', 06:18:02 INFO - '7'], 06:18:02 INFO - 'tests': ['tsvgm']}}, 06:18:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:18:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:18:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['damp', 'tps']}, 06:18:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'tests': ['damp', 'tps']}, 06:18:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['dromaeo_dom']}, 06:18:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['basic_compositor_video']}, 06:18:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:18:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['a11yr', 06:18:02 INFO - 'ts_paint', 06:18:02 INFO - 'tpaint', 06:18:02 INFO - 'sessionrestore', 06:18:02 INFO - 'sessionrestore_no_auto_restore', 06:18:02 INFO - 'tabpaint']}, 06:18:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:18:02 INFO - 'ts_paint', 06:18:02 INFO - 'tpaint', 06:18:02 INFO - 'sessionrestore', 06:18:02 INFO - 'sessionrestore_no_auto_restore', 06:18:02 INFO - 'tabpaint']}, 06:18:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:18:02 INFO - 'ts_paint', 06:18:02 INFO - 'tpaint', 06:18:02 INFO - 'sessionrestore', 06:18:02 INFO - 'sessionrestore_no_auto_restore', 06:18:02 INFO - 'tabpaint']}, 06:18:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:18:02 INFO - 'ts_paint', 06:18:02 INFO - 'tpaint', 06:18:02 INFO - 'sessionrestore', 06:18:02 INFO - 'sessionrestore_no_auto_restore', 06:18:02 INFO - 'tabpaint']}, 06:18:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['a11yr', 06:18:02 INFO - 'ts_paint', 06:18:02 INFO - 'tpaint', 06:18:02 INFO - 'sessionrestore', 06:18:02 INFO - 'sessionrestore_no_auto_restore', 06:18:02 INFO - 'tabpaint']}, 06:18:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['a11yr', 06:18:02 INFO - 'ts_paint', 06:18:02 INFO - 'tpaint', 06:18:02 INFO - 'sessionrestore', 06:18:02 INFO - 'sessionrestore_no_auto_restore', 06:18:02 INFO - 'tabpaint']}, 06:18:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['tsvgx', 06:18:02 INFO - 'tsvgr_opacity', 06:18:02 INFO - 'tart', 06:18:02 INFO - 'tscrollx', 06:18:02 INFO - 'cart']}, 06:18:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:18:02 INFO - 'tsvgr_opacity', 06:18:02 INFO - 'tart', 06:18:02 INFO - 'tscrollx', 06:18:02 INFO - 'cart']}, 06:18:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'talos_options': ['--disable-e10s'], 06:18:02 INFO - 'tests': ['tp5o']}, 06:18:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'tests': ['tp5o']}, 06:18:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'talos_options': ['--disable-e10s', 06:18:02 INFO - '--xperf_path', 06:18:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:02 INFO - 'tests': ['tp5n']}, 06:18:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:02 INFO - 'talos_options': ['--xperf_path', 06:18:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:02 INFO - 'tests': ['tp5n']}}, 06:18:02 INFO - 'talos.zip': {'path': '', 06:18:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:02 INFO - Running post-action listener: _resource_record_post_action 06:18:02 INFO - [mozharness: 2016-10-17 13:18:02.302819Z] Finished populate-webroot step (success) 06:18:02 INFO - [mozharness: 2016-10-17 13:18:02.302908Z] Running create-virtualenv step. 06:18:02 INFO - Running pre-action listener: _resource_record_pre_action 06:18:02 INFO - Running main action method: create_virtualenv 06:18:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:02 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 06:18:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:02 INFO - Using real prefix '/usr' 06:18:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:04 INFO - Installing pip.................done. 06:18:04 INFO - Return code: 0 06:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:18:05 INFO - Reading from file tmpfile_stdout 06:18:05 INFO - Output received: 06:18:05 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) 06:18:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:05 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:05 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 06:18:05 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 06:18:05 INFO - Using env: {'DISPLAY': ':0', 06:18:05 INFO - 'HOME': '/home/cltbld', 06:18:05 INFO - 'LANG': 'en_US.UTF-8', 06:18:05 INFO - 'LANGUAGE': 'en_US:en', 06:18:05 INFO - 'LOGNAME': 'cltbld', 06:18:05 INFO - 'MAIL': '/var/mail/cltbld', 06:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:05 INFO - 'MOZ_NO_REMOTE': '1', 06:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:05 INFO - 'NO_EM_RESTART': '1', 06:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:05 INFO - 'PWD': '/builds/slave/test', 06:18:05 INFO - 'SHELL': '/bin/bash', 06:18:05 INFO - 'SHLVL': '1', 06:18:05 INFO - 'TERM': 'linux', 06:18:05 INFO - 'TMOUT': '86400', 06:18:05 INFO - 'USER': 'cltbld', 06:18:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:05 INFO - '_': '/tools/buildbot/bin/python'} 06:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:05 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 06:18:05 INFO - Cleaning up... 06:18:05 INFO - Return code: 0 06:18:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:05 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:05 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 06:18:05 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 06:18:05 INFO - Using env: {'DISPLAY': ':0', 06:18:05 INFO - 'HOME': '/home/cltbld', 06:18:05 INFO - 'LANG': 'en_US.UTF-8', 06:18:05 INFO - 'LANGUAGE': 'en_US:en', 06:18:05 INFO - 'LOGNAME': 'cltbld', 06:18:05 INFO - 'MAIL': '/var/mail/cltbld', 06:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:05 INFO - 'MOZ_NO_REMOTE': '1', 06:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:05 INFO - 'NO_EM_RESTART': '1', 06:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:05 INFO - 'PWD': '/builds/slave/test', 06:18:05 INFO - 'SHELL': '/bin/bash', 06:18:05 INFO - 'SHLVL': '1', 06:18:05 INFO - 'TERM': 'linux', 06:18:05 INFO - 'TMOUT': '86400', 06:18:05 INFO - 'USER': 'cltbld', 06:18:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:05 INFO - '_': '/tools/buildbot/bin/python'} 06:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:05 INFO - Downloading/unpacking psutil>=3.1.1 06:18:05 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 06:18:05 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 06:18:05 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 06:18:05 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 06:18:05 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 06:18:05 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 06:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:07 INFO - Installing collected packages: psutil 06:18:07 INFO - Running setup.py install for psutil 06:18:07 INFO - building 'psutil._psutil_linux' extension 06:18:07 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 06:18:07 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 06:18:07 INFO - building 'psutil._psutil_posix' extension 06:18:07 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 06:18:07 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 06:18:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:08 INFO - Successfully installed psutil 06:18:08 INFO - Cleaning up... 06:18:08 INFO - Return code: 0 06:18:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:18:08 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')]} 06:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:08 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')]} 06:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:08 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:08 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 06:18:08 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 06:18:08 INFO - Using env: {'DISPLAY': ':0', 06:18:08 INFO - 'HOME': '/home/cltbld', 06:18:08 INFO - 'LANG': 'en_US.UTF-8', 06:18:08 INFO - 'LANGUAGE': 'en_US:en', 06:18:08 INFO - 'LOGNAME': 'cltbld', 06:18:08 INFO - 'MAIL': '/var/mail/cltbld', 06:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:08 INFO - 'MOZ_NO_REMOTE': '1', 06:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:08 INFO - 'NO_EM_RESTART': '1', 06:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:08 INFO - 'PWD': '/builds/slave/test', 06:18:08 INFO - 'SHELL': '/bin/bash', 06:18:08 INFO - 'SHLVL': '1', 06:18:08 INFO - 'TERM': 'linux', 06:18:08 INFO - 'TMOUT': '86400', 06:18:08 INFO - 'USER': 'cltbld', 06:18:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:08 INFO - '_': '/tools/buildbot/bin/python'} 06:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:10 INFO - Installing collected packages: mozsystemmonitor 06:18:10 INFO - Running setup.py install for mozsystemmonitor 06:18:10 INFO - Successfully installed mozsystemmonitor 06:18:10 INFO - Cleaning up... 06:18:10 INFO - Return code: 0 06:18:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18: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==2.5.1'] in /builds/slave/test/build 06:18: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==2.5.1 06:18:10 INFO - Using env: {'DISPLAY': ':0', 06:18:10 INFO - 'HOME': '/home/cltbld', 06:18:10 INFO - 'LANG': 'en_US.UTF-8', 06:18:10 INFO - 'LANGUAGE': 'en_US:en', 06:18:10 INFO - 'LOGNAME': 'cltbld', 06:18:10 INFO - 'MAIL': '/var/mail/cltbld', 06:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:10 INFO - 'MOZ_NO_REMOTE': '1', 06:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:10 INFO - 'NO_EM_RESTART': '1', 06:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:10 INFO - 'PWD': '/builds/slave/test', 06:18:10 INFO - 'SHELL': '/bin/bash', 06:18:10 INFO - 'SHLVL': '1', 06:18:10 INFO - 'TERM': 'linux', 06:18:10 INFO - 'TMOUT': '86400', 06:18:10 INFO - 'USER': 'cltbld', 06:18:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:10 INFO - '_': '/tools/buildbot/bin/python'} 06:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:10 INFO - Downloading/unpacking jsonschema==2.5.1 06:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18:12 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 06:18:12 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 06:18:12 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 06:18:12 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 06:18:12 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 06:18:12 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 06:18:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:13 INFO - warning: no files found matching '*.txt' 06:18:13 INFO - no previously-included directories found matching 'build' 06:18:13 INFO - no previously-included directories found matching 'dist' 06:18:13 INFO - no previously-included directories found matching '.git*' 06:18:13 INFO - Installing collected packages: jsonschema, functools32 06:18:13 INFO - Running setup.py install for functools32 06:18:13 INFO - warning: no files found matching '*.txt' 06:18:13 INFO - no previously-included directories found matching 'build' 06:18:13 INFO - no previously-included directories found matching 'dist' 06:18:13 INFO - no previously-included directories found matching '.git*' 06:18:13 INFO - Successfully installed jsonschema functools32 06:18:13 INFO - Cleaning up... 06:18:13 INFO - Return code: 0 06:18:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:18:13 INFO - Using env: {'DISPLAY': ':0', 06:18:13 INFO - 'HOME': '/home/cltbld', 06:18:13 INFO - 'LANG': 'en_US.UTF-8', 06:18:13 INFO - 'LANGUAGE': 'en_US:en', 06:18:13 INFO - 'LOGNAME': 'cltbld', 06:18:13 INFO - 'MAIL': '/var/mail/cltbld', 06:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:13 INFO - 'MOZ_NO_REMOTE': '1', 06:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:13 INFO - 'NO_EM_RESTART': '1', 06:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:13 INFO - 'PWD': '/builds/slave/test', 06:18:13 INFO - 'SHELL': '/bin/bash', 06:18:13 INFO - 'SHLVL': '1', 06:18:13 INFO - 'TERM': 'linux', 06:18:13 INFO - 'TMOUT': '86400', 06:18:13 INFO - 'USER': 'cltbld', 06:18:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:13 INFO - '_': '/tools/buildbot/bin/python'} 06:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:18:13 INFO - Cleaning up... 06:18:13 INFO - Return code: 0 06:18:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:13 INFO - Using env: {'DISPLAY': ':0', 06:18:13 INFO - 'HOME': '/home/cltbld', 06:18:13 INFO - 'LANG': 'en_US.UTF-8', 06:18:13 INFO - 'LANGUAGE': 'en_US:en', 06:18:13 INFO - 'LOGNAME': 'cltbld', 06:18:13 INFO - 'MAIL': '/var/mail/cltbld', 06:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:13 INFO - 'MOZ_NO_REMOTE': '1', 06:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:13 INFO - 'NO_EM_RESTART': '1', 06:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:13 INFO - 'PWD': '/builds/slave/test', 06:18:13 INFO - 'SHELL': '/bin/bash', 06:18:13 INFO - 'SHLVL': '1', 06:18:13 INFO - 'TERM': 'linux', 06:18:13 INFO - 'TMOUT': '86400', 06:18:13 INFO - 'USER': 'cltbld', 06:18:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:13 INFO - '_': '/tools/buildbot/bin/python'} 06:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:15 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 06:18:15 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 06:18:15 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 06:18:15 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 06:18:15 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 06:18:15 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 06:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:16 INFO - Downloading docopt-0.6.1.tar.gz 06:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:16 INFO - Running setup.py install for blobuploader 06:18:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:16 INFO - Running setup.py install for requests 06:18:16 INFO - Running setup.py install for docopt 06:18:16 INFO - Successfully installed blobuploader requests docopt 06:18:16 INFO - Cleaning up... 06:18:16 INFO - Return code: 0 06:18:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:17 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 06:18:17 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 06:18:17 INFO - Using env: {'DISPLAY': ':0', 06:18:17 INFO - 'HOME': '/home/cltbld', 06:18:17 INFO - 'LANG': 'en_US.UTF-8', 06:18:17 INFO - 'LANGUAGE': 'en_US:en', 06:18:17 INFO - 'LOGNAME': 'cltbld', 06:18:17 INFO - 'MAIL': '/var/mail/cltbld', 06:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:17 INFO - 'MOZ_NO_REMOTE': '1', 06:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:17 INFO - 'NO_EM_RESTART': '1', 06:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:17 INFO - 'PWD': '/builds/slave/test', 06:18:17 INFO - 'SHELL': '/bin/bash', 06:18:17 INFO - 'SHLVL': '1', 06:18:17 INFO - 'TERM': 'linux', 06:18:17 INFO - 'TMOUT': '86400', 06:18:17 INFO - 'USER': 'cltbld', 06:18:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:17 INFO - '_': '/tools/buildbot/bin/python'} 06:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:17 INFO - Running setup.py (path:/tmp/pip-1HUTri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:17 INFO - Running setup.py (path:/tmp/pip-91guv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:17 INFO - Running setup.py (path:/tmp/pip-fSKJDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:17 INFO - Running setup.py (path:/tmp/pip-i9yV1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:17 INFO - Running setup.py (path:/tmp/pip-8ILYsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:17 INFO - Running setup.py (path:/tmp/pip-10hX1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:17 INFO - Running setup.py (path:/tmp/pip-DgBDmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:17 INFO - Running setup.py (path:/tmp/pip-6gVbPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:17 INFO - Running setup.py (path:/tmp/pip-0w85Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:17 INFO - Running setup.py (path:/tmp/pip-lwoooa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:18 INFO - Running setup.py (path:/tmp/pip-KrNSTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:18 INFO - Running setup.py (path:/tmp/pip-Lei4Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:18 INFO - Running setup.py (path:/tmp/pip-BVFR6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:18 INFO - Running setup.py (path:/tmp/pip-GX6NRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:18 INFO - Running setup.py (path:/tmp/pip-IMVcOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:18 INFO - Running setup.py (path:/tmp/pip-XhOCNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:18 INFO - Running setup.py (path:/tmp/pip-8VRQ0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:18 INFO - Running setup.py install for manifestparser 06:18:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:18 INFO - Running setup.py install for mozcrash 06:18:18 INFO - Running setup.py install for mozdebug 06:18:18 INFO - Running setup.py install for mozdevice 06:18:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:18 INFO - Running setup.py install for mozfile 06:18:19 INFO - Running setup.py install for mozhttpd 06:18:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Running setup.py install for mozinfo 06:18:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Running setup.py install for mozInstall 06:18:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Running setup.py install for mozleak 06:18:19 INFO - Running setup.py install for mozlog 06:18:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Running setup.py install for moznetwork 06:18:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Running setup.py install for mozprocess 06:18:19 INFO - Running setup.py install for mozprofile 06:18:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:19 INFO - Running setup.py install for mozrunner 06:18:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:20 INFO - Running setup.py install for mozscreenshot 06:18:20 INFO - Running setup.py install for moztest 06:18:20 INFO - Running setup.py install for mozversion 06:18:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:20 INFO - Cleaning up... 06:18:20 INFO - Return code: 0 06:18:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:20 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:20 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 06:18:20 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 06:18:20 INFO - Using env: {'DISPLAY': ':0', 06:18:20 INFO - 'HOME': '/home/cltbld', 06:18:20 INFO - 'LANG': 'en_US.UTF-8', 06:18:20 INFO - 'LANGUAGE': 'en_US:en', 06:18:20 INFO - 'LOGNAME': 'cltbld', 06:18:20 INFO - 'MAIL': '/var/mail/cltbld', 06:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:20 INFO - 'MOZ_NO_REMOTE': '1', 06:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:20 INFO - 'NO_EM_RESTART': '1', 06:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:20 INFO - 'PWD': '/builds/slave/test', 06:18:20 INFO - 'SHELL': '/bin/bash', 06:18:20 INFO - 'SHLVL': '1', 06:18:20 INFO - 'TERM': 'linux', 06:18:20 INFO - 'TMOUT': '86400', 06:18:20 INFO - 'USER': 'cltbld', 06:18:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:20 INFO - '_': '/tools/buildbot/bin/python'} 06:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:20 INFO - Running setup.py (path:/tmp/pip-xVmIJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:20 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)) 06:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:20 INFO - Running setup.py (path:/tmp/pip-Wps8NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:20 INFO - Running setup.py (path:/tmp/pip-VC7FdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:20 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)) 06:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:20 INFO - Running setup.py (path:/tmp/pip-4LE_nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:20 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)) 06:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:20 INFO - Running setup.py (path:/tmp/pip-RGvPk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:21 INFO - Running setup.py (path:/tmp/pip-BmLnMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:21 INFO - Running setup.py (path:/tmp/pip-y3VhAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:21 INFO - Running setup.py (path:/tmp/pip-IKzyJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:21 INFO - Running setup.py (path:/tmp/pip-BqbbBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:21 INFO - Running setup.py (path:/tmp/pip-PLwYmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:21 INFO - Running setup.py (path:/tmp/pip-gpHsfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:21 INFO - Running setup.py (path:/tmp/pip-u8yG2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:21 INFO - Running setup.py (path:/tmp/pip-ocS7J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:21 INFO - Running setup.py (path:/tmp/pip-ERidBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:21 INFO - Running setup.py (path:/tmp/pip-1s4Rvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:21 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)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:21 INFO - Running setup.py (path:/tmp/pip-7lsvdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:21 INFO - Running setup.py (path:/tmp/pip-zoti_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:21 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)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:21 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)) 06:18:21 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)) 06:18:21 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)) 06:18:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:23 INFO - Downloading blessings-1.6.tar.gz 06:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:24 INFO - Installing collected packages: blessings 06:18:24 INFO - Running setup.py install for blessings 06:18:24 INFO - Successfully installed blessings 06:18:24 INFO - Cleaning up... 06:18:24 INFO - Return code: 0 06:18:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:24 INFO - Reading from file tmpfile_stdout 06:18:24 INFO - Current package versions: 06:18:24 INFO - argparse == 1.2.1 06:18:24 INFO - blessings == 1.6 06:18:24 INFO - blobuploader == 1.2.4 06:18:24 INFO - docopt == 0.6.1 06:18:24 INFO - functools32 == 3.2.3-2 06:18:24 INFO - jsonschema == 2.5.1 06:18:24 INFO - manifestparser == 1.1 06:18:24 INFO - mozInstall == 1.12 06:18:24 INFO - mozcrash == 0.17 06:18:24 INFO - mozdebug == 0.1 06:18:24 INFO - mozdevice == 0.48 06:18:24 INFO - mozfile == 1.2 06:18:24 INFO - mozhttpd == 0.7 06:18:24 INFO - mozinfo == 0.9 06:18:24 INFO - mozleak == 0.1 06:18:24 INFO - mozlog == 3.4 06:18:24 INFO - moznetwork == 0.27 06:18:24 INFO - mozprocess == 0.23 06:18:24 INFO - mozprofile == 0.28 06:18:24 INFO - mozrunner == 6.12 06:18:24 INFO - mozscreenshot == 0.1 06:18:24 INFO - mozsystemmonitor == 0.3 06:18:24 INFO - moztest == 0.7 06:18:24 INFO - mozversion == 1.4 06:18:24 INFO - psutil == 3.1.1 06:18:24 INFO - requests == 1.2.3 06:18:24 INFO - wsgiref == 0.1.2 06:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:24 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:24 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 06:18:24 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 06:18:24 INFO - Using env: {'DISPLAY': ':0', 06:18:24 INFO - 'HOME': '/home/cltbld', 06:18:24 INFO - 'LANG': 'en_US.UTF-8', 06:18:24 INFO - 'LANGUAGE': 'en_US:en', 06:18:24 INFO - 'LOGNAME': 'cltbld', 06:18:24 INFO - 'MAIL': '/var/mail/cltbld', 06:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:24 INFO - 'MOZ_NO_REMOTE': '1', 06:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:24 INFO - 'NO_EM_RESTART': '1', 06:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:24 INFO - 'PWD': '/builds/slave/test', 06:18:24 INFO - 'SHELL': '/bin/bash', 06:18:24 INFO - 'SHLVL': '1', 06:18:24 INFO - 'TERM': 'linux', 06:18:24 INFO - 'TMOUT': '86400', 06:18:24 INFO - 'USER': 'cltbld', 06:18:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:24 INFO - '_': '/tools/buildbot/bin/python'} 06:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 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)) 06:18:24 INFO - Cleaning up... 06:18:24 INFO - Return code: 0 06:18:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:24 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 0x7eff00fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c24790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', '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 06:18:24 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 06:18:24 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 06:18:24 INFO - Using env: {'DISPLAY': ':0', 06:18:24 INFO - 'HOME': '/home/cltbld', 06:18:24 INFO - 'LANG': 'en_US.UTF-8', 06:18:24 INFO - 'LANGUAGE': 'en_US:en', 06:18:24 INFO - 'LOGNAME': 'cltbld', 06:18:24 INFO - 'MAIL': '/var/mail/cltbld', 06:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:24 INFO - 'MOZ_NO_REMOTE': '1', 06:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:24 INFO - 'NO_EM_RESTART': '1', 06:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:24 INFO - 'PWD': '/builds/slave/test', 06:18:24 INFO - 'SHELL': '/bin/bash', 06:18:24 INFO - 'SHLVL': '1', 06:18:24 INFO - 'TERM': 'linux', 06:18:24 INFO - 'TMOUT': '86400', 06:18:24 INFO - 'USER': 'cltbld', 06:18:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:24 INFO - '_': '/tools/buildbot/bin/python'} 06:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:25 INFO - Cleaning up... 06:18:25 INFO - Return code: 0 06:18:25 INFO - Running post-action listener: _resource_record_post_action 06:18:25 INFO - Running post-action listener: _start_resource_monitoring 06:18:25 INFO - Starting resource monitoring. 06:18:25 INFO - [mozharness: 2016-10-17 13:18:25.108862Z] Finished create-virtualenv step (success) 06:18:25 INFO - [mozharness: 2016-10-17 13:18:25.109377Z] Running install step. 06:18:25 INFO - Running pre-action listener: _resource_record_pre_action 06:18:25 INFO - Running main action method: install 06:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:25 INFO - Reading from file tmpfile_stdout 06:18:25 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:25 INFO - Reading from file tmpfile_stdout 06:18:25 INFO - Output received: 06:18:25 INFO - Usage: mozinstall [options] installer 06:18:25 INFO - Options: 06:18:25 INFO - -h, --help show this help message and exit 06:18:25 INFO - -d DEST, --destination=DEST 06:18:25 INFO - Directory to install application into. [default: 06:18:25 INFO - "/builds/slave/test"] 06:18:25 INFO - --app=APP Application being installed. [default: firefox] 06:18:25 INFO - mkdir: /builds/slave/test/build/application 06:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:18:42 INFO - Reading from file tmpfile_stdout 06:18:42 INFO - Output received: 06:18:42 INFO - /builds/slave/test/build/application/firefox/firefox 06:18:42 INFO - Running post-action listener: _resource_record_post_action 06:18:42 INFO - [mozharness: 2016-10-17 13:18:42.366315Z] Finished install step (success) 06:18:42 INFO - [mozharness: 2016-10-17 13:18:42.366562Z] Running run-tests step. 06:18:42 INFO - Running pre-action listener: _resource_record_pre_action 06:18:42 INFO - Running main action method: run_tests 06:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:18:42 INFO - Python 2.7.3 06:18:42 INFO - Return code: 0 06:18:42 INFO - grabbing minidump binary from tooltool 06:18:42 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')]} 06:18:42 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 0x2c21930>, '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 0x2c22830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c22cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:18:42 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 06:18:42 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 06:18:42 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 06:18:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:18:42 INFO - Return code: 0 06:18:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:18:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:18:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:18:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:18:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:18:42 INFO - Using env: {'DISPLAY': ':0', 06:18:42 INFO - 'HOME': '/home/cltbld', 06:18:42 INFO - 'LANG': 'en_US.UTF-8', 06:18:42 INFO - 'LANGUAGE': 'en_US:en', 06:18:42 INFO - 'LOGNAME': 'cltbld', 06:18:42 INFO - 'MAIL': '/var/mail/cltbld', 06:18:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:18:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:42 INFO - 'MOZ_NO_REMOTE': '1', 06:18:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:42 INFO - 'NO_EM_RESTART': '1', 06:18:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:42 INFO - 'PWD': '/builds/slave/test', 06:18:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:18:42 INFO - 'SHELL': '/bin/bash', 06:18:42 INFO - 'SHLVL': '1', 06:18:42 INFO - 'TERM': 'linux', 06:18:42 INFO - 'TMOUT': '86400', 06:18:42 INFO - 'USER': 'cltbld', 06:18:42 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838', 06:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:42 INFO - '_': '/tools/buildbot/bin/python'} 06:18:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:18:42 INFO - mozversion application_buildid: 20161017033008 06:18:42 INFO - mozversion application_changeset: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 06:18:42 INFO - mozversion application_display_name: Nightly 06:18:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:18:42 INFO - mozversion application_name: Firefox 06:18:42 INFO - mozversion application_remotingname: firefox 06:18:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:18:42 INFO - mozversion application_vendor: Mozilla 06:18:42 INFO - mozversion application_version: 52.0a1 06:18:42 INFO - mozversion platform_buildid: 20161017033008 06:18:42 INFO - mozversion platform_changeset: 78bd3dbc3ddee84be7d9b79fde3614eec50d39a9 06:18:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:18:42 INFO - mozversion platform_version: 52.0a1 06:18:42 INFO - using testdate: 1476710322 06:18:42 INFO - actual date: 1476710322 06:18:42 INFO - starting webserver on 'localhost:41155' 06:18:42 INFO - SUITE-START | Running 2 tests 06:18:42 INFO - TEST-START | dromaeo_css 06:18:42 INFO - operating with platform_type : linux_ 06:18:42 INFO - Initialising browser for dromaeo_css test... 06:18:42 INFO - TEST-INFO | started process 16589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmploMa5O/profile http://localhost:41155/getInfo.html) 06:18:46 INFO - PROCESS | 16589 | __metrics Screen width/height:1600/1200 06:18:46 INFO - PROCESS | 16589 | colorDepth:24 06:18:46 INFO - PROCESS | 16589 | Browser inner width/height: 1024/697 06:18:46 INFO - PROCESS | 16589 | __metrics 06:18:47 INFO - PROCESS | 16589 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:47 INFO - PROCESS | 16589 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:47 INFO - PROCESS | 16589 | console.error: PushService: 06:18:47 INFO - PROCESS | 16589 | stateChangeProcessEnqueue: Error transitioning state 06:18:47 INFO - PROCESS | 16589 | UnknownError 06:18:48 INFO - TEST-INFO | 16589: exit 0 06:18:48 INFO - Browser initialized. 06:18:48 INFO - Running cycle 1/1 for dromaeo_css test... 06:18:48 INFO - TEST-INFO | started process 16672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmploMa5O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:00 INFO - PROCESS | 16672 | RSS: Main: 172523520 06:19:00 INFO - PROCESS | 16672 | 06:19:52 INFO - PROCESS | 16672 | 1476710392106 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:22:02 INFO - PROCESS | 16672 | Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41155/tests/dromaeo/cssquery-ext.html) 06:22:04 INFO - PROCESS | 16672 | RSS: Main: 343842816 06:22:04 INFO - PROCESS | 16672 | 06:25:07 INFO - PROCESS | 16672 | Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-ext.html (next: http://localhost:41155/tests/dromaeo/cssquery-jquery.html) 06:25:07 INFO - PROCESS | 16672 | RSS: Main: 279252992 06:25:07 INFO - PROCESS | 16672 | 06:28:09 INFO - PROCESS | 16672 | Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41155/tests/dromaeo/cssquery-mootools.html) 06:28:10 INFO - PROCESS | 16672 | RSS: Main: 259592192 06:28:10 INFO - PROCESS | 16672 | 06:31:12 INFO - PROCESS | 16672 | Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41155/tests/dromaeo/cssquery-prototype.html) 06:31:12 INFO - PROCESS | 16672 | RSS: Main: 243105792 06:31:12 INFO - PROCESS | 16672 | 06:34:15 INFO - PROCESS | 16672 | Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41155/tests/dromaeo/cssquery-yui.html) 06:34:16 INFO - PROCESS | 16672 | RSS: Main: 216555520 06:34:16 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | Cycle 1(1): loaded http://localhost:41155/tests/dromaeo/cssquery-yui.html (next: http://localhost:41155/tests/dromaeo/cssquery-dojo.html) 06:37:19 INFO - PROCESS | 16672 | RSS: Main: 290304000 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | __start_tp_report 06:37:19 INFO - PROCESS | 16672 | _x_x_mozilla_page_load 06:37:19 INFO - PROCESS | 16672 | _x_x_mozilla_page_load_details 06:37:19 INFO - PROCESS | 16672 | |i|pagename|runs| 06:37:19 INFO - PROCESS | 16672 | |0;dojo.html;3078.091962870953;3096.318809861831;3099.442100421924;3132.185631735748;3152.36952609478;5137.306463627409;5214.634975551713;5347.625666203362;5383.730813459331;5426.972865135674;5276.15581506959;5335.893282134355;5404.351477822657;5429.375621803494;5446.455354464551;4753.952460475402;4780.880477988043;4829.661923665345;4866.172750632383;4913.31213630092;4948.331975183341;5029.1199040168;5089.338386009814;5095.643304968635;5154.819581314655;4759.143354196243;4951.059298733229;4951.504849515056;4980.601551875841;5080.517350851663;4808.879778005543;4842.201036828954;4879.024195160947;4903.043906438246;4905.730184839832;4871.824040596881;4890.217565189588;4894.828680996184;4913.361263035818;4953.108440480712;5353.357597088336;5367.75845086972;5382.1926710993275;5383.676979381211;5411;5457.126859702428;5498.147787093007;5664.631798933097;5730.856728581777;5735.713214339266;5778.104393818965;5787.247657804459;5789.797357092481;5851.882962340729;5858.355580886099;5373.167159090347;5374.193870919394;5378.542823859977;5379.784808607612;5380.757865896005;5620.044592419298;5620.887582248332;5682.715864206773;5882.705864706748;5892.086726557391;5617.466340697627;5667.914981275284;5673.858153546194;5678.858028549237;5749.3963133871175;5698.031334673115;5739.512141467939;5740.196372507852;5754.88490230193;5760.855978600569;5486.890262194734;5699.487046165782;5704.258446401941;5708.1723150143;5709.74306156224;5482.122860342326;5622.072358060874;5624.831255062355;5625.606207565431;5630.155476678531;4358.346248062816;4374.759388233678;4375.234333991539;4376.146651402946;4378.912421751611;3961.7226794124713;3964.1080756829483;3965.167314863911;3966.7421617594764;3972.2849887020034;5346.518813306821;5390.757415916293;5391.32608423947;5392.892142157135;5396.514313711785;5720.456556627114;5752.597318187687;5790.420957904176;5806.941930580725;5867.853303667443;5484.369297530755;5501.422350653123;5515.4760297771645;5520.420355862657;5562.721863906789;5054;5068.619853511002;5073.137566613685;5074.949250507521;5133.383993920754;5753.309602847601;5793.159991801165;5800.767969281182;5851.853703657443;6044.455998960027;5690.5163061140265;5752.1659359391815;5799.4780469757925;5824.883502329845;5921.792737254348;6042.395760423922;6047.123167140828;6107.908381374372;6108.236470441195;6116.877662446637;5713.143028545752;5714.342850572238;5716.54267658578;5717.256756621613;5722.055860783091;5568.387477377404;5622.156676498558;5827.213326200908;5828.6502809831545;5833.416658334302;5634;5701.030824759884;5714.657120572779;5746.827595172152;5808.157817116579;5642.23829782974;5679.204911312337;5689.402612725604;5690.118031705092;5693.089105743061;5427.402985671494;5663.66018038919;5679.630823996427;5695.174199741097;5699.715014249188;5528.861778455571;5614.101743720985;5618.016847051831;5621.156826476062;5622.718864056699;5466.699331536644;5497.945020549743;5499.230107784993;5505.201745746765;5506.862328441821 06:37:19 INFO - PROCESS | 16672 | |1;ext.html;544.5793448123094;601.6299975515058;603.3544107804651;608.0180508478808;615.1695211464522;30745.538816917735;40168.799156004214;41256.17487650245;41330;45465;42530.36204456936;42920.14159716811;42998;43046.784766076125;43069.56930430695;7843.843123137533;8704.608292626846;8841.469511829311;8854.955725221396;8859.601317940707;8002.759917202493;8255.628496717662;8257.587120643973;10258.53836577352;10539.525721342558;10637.149028077774;10693.411862347568;10694.893051069468;10708.41103739294;10714.839277410845;10482.475876206197;10606.204534659932;10608.681739547748;10626.893731062706;10627.946860265727;10267.537960791708;10318.484075796181;10332.328398654063;10335.379877207391;10337.276390652658;40576.79711601423;40840.387394188816;40871.59128408707;40964;40993.79503102465;3314.105191598279;3339.916502087443;3430.6569343065744;3632.182758879231;3843.9813449435924;30204.697953020626;31132.8443357784;31390.215244618837;31813.52279715806;32019.679803202136;4156.9792151039355;4159.313713237312;4334.176506463793;4347.543507931685;4396.692231543793;298405;300985;300987;301112.4944375286;302231;31770.205744856565;33171.66828331734;33304.33391332208;54653.180202297;55245;34936;35059.824700876336;35257.64742352595;35278.64721352805;35284.82357588196;14241.359138838778;14285.92857035729;14314.856851431561;14316.570502884722;14330.57008289753;10657.733556661145;11613.30320180792;11616.825747613793;11625.825612615818;11653.242539234923;7492.288232617892;7604.087509498785;8076.8788468173025;8106.392020598479;8157.14349993254;3164.730997865161;3173.5715678383585;3199.3601279744144;3208.9410494537215;3220.468622677232;991.4745185051934;1014.9238807089498;1020.7907378987289;1060.0512541275516;1143.2283208834003;31457.685423145474;31643;31848.36303273968;32520.512192317135;32613.83693081567;1078.2883297023927;1125.791728530208;1146.1976616368574;1159.3217967489113;1206.7646808872362;16566.420175293806;17008.149592520323;17065.744013839554;17203.1398430078;17311.740323895152;502774;506861;508676;509539;510568;54908.725456373264;55140;55298.723506383016;55438.16842747362;55512.722436388365;1185.6502331811964;1244.1539752967888;1251.949922003128;1309.862464441239;1333.1134795360977;29165.7083429163;33042.834785826875;34653.306933861684;34708.82645586756;34808.82595587006;52374.476255238485;53257.733711331195;53259;53284;53370.466295338105;434558;439498;439631;440203.38677985827;441663;25950.610740838525;27402.862985684944;27465.45069098567;27828.165155045383;33524;36099;43688;46197;46211;50995;39026.41460378154;39342.606573933896;40137.82427405082;40277;41187.38218926779;39136.608633913296;39221.2155756889;40178.39732403958;40612.329582098435;41285.58714412817;40037.79981100076;40040;40132.1973560533;41483.37774933318;41682.79158604187;33041.66958330386;34970;35134.472982904765;35917.64082359143;36156;26958;27166.456670866868;27277.454450910474;27467.725322746515;27512.36572570572 06:37:19 INFO - PROCESS | 16672 | |2;jquery.html;375.84026788614847;377.54128733588686;386.87605048284917;396.54793535369663;406.58528301132844;14711.48509802157;15036.774448383283;17019.48941531753;20005.399838004847;20296.59406811863;16452.341906323763;19639.11623976921;19651.21395144196;19787.703184452246;20028.098735556898;5475.808346707876;5630.352509461403;5706.828795136153;5709.343425506078;5713.200151978726;5464.972675136619;5673.461021202979;5720.456556627114;5728.341240757304;5735.942640573603;4060.8578699745517;4267.14657068586;5688.687122208277;5696;5999.580029397944;6235.376462353751;6371.87256254877;6383.968080159592;6386.042093685938;6391.712372943229;4979.278004689299;5249.973750131263;5287.762050707727;5344.278522399465;5351.625386222966;13156;13424.060315777899;15736.763948540782;22346.441338966495;22526.324210273553;2180.095260466904;2193.517426166241;2289.484865905158;2310.9191178308847;2547.274026902324;9219.953900230523;10219.131373833234;10425.947870260676;11673.007794337407;13958.232297223649;1789.4631610516924;1817.781866176054;1842.309134074722;1844.787849397323;1930.7972662870336;77269;77791;78634.8887322328;79150.60424697897;83282.58358708228;10329.741756455998;10439.686809395731;10564.260501764957;10597.502824068039;10807.297525660806;14950.551483455514;14951.850481495263;14975.550733478012;14982.550523484313;14996.175210363317;7459.589722565311;7504.587247701429;7537.057867766529;7699.961500192463;7879.33025692811;7362.77911662651;7366.1528924173335;7484.43866709988;7641.1212710539;7652.426068044919;4423.646108311327;4462.9107417851465;4549.317602359606;4564.794584243717;4593.173228818845;1771.769669942899;1863.64590727764;1865.1047497201148;1892.8296453318992;1905.3426567834076;965.2712202287228;978.8580655804868;1007.5113569918584;1022.9821327778759;1023.3961962442195;18201.908990454962;18903.14935827891;19220.327288544835;19304.32434864773;19606.70589941152;944.4758159221698;952.4618590496348;962.6823148361024;970.2286682087757;978.3689520259393;10276.588936442458;10715.249932504807;10759.594352753995;10793.406362649972;10811.40537270442;375661;430814;434742;440088;445697.65872242086;87827;88946;90385;90411.54794225987;90607.54696226477;981.455292312759;1057.5928267616869;1070.5717712914895;1086.326477583903;1088.3687461272443;16311.26599303058;16904.66190676204;17187.742183867504;17215.22531486061;17348.739768903728;37232;39539;39770.80687579377;40413.393799093625;40687.77936661905;54536.45463545473;55583.44416555944;57093.42906570881;57247.42752572421;58173.709131454074;7450.254974502506;8176.959115204386;8233.917660823316;8266.380021498531;8352.83294334122;12266.877331226573;12952.611421657366;13151.34243287851;13154.868451315364;13835.377408016462;11157.330560166416;11254.437278136224;11263.098952083978;11919.523219071487;11940.58113286514;11322.547098116313;11395.487203075716;11446.027087697306;11626.128040396836;12034.879651203726;11655.708607284885;11677.357745324089;11912.10659200546;11952.820707689218;12164;7523.435742319458;7568.4323675725645;7572.281544979443;7633.465657404151;7960.283574478325;8841.513716745641;10913.618023369145;11513.769724605629;11653.53385864556;11791.587294444997 06:37:19 INFO - PROCESS | 16672 | |3;mootools.html;1289.303775960981;1453.920034398108;1512.969740605188;1658.2454982982745;1793.659204751098;7804.4146688998335;8679;8939.195472407482;8976.057513961037;9203;8939.910600893989;9063.546822658856;9074.455532668044;9079.092090790917;9084.818303633923;2306.1928325086255;2336.8013718833918;2349.9295021149305;2352.329586067971;2353.5175289065787;2322.1175953137786;2348.753380895007;2375.2874137758604;2378.3935096550354;2381.9642705359433;2326.7556906524824;2341.1805867946255;2348.3307257431634;2374.1334412939327;2380.571497130516;2283.406314358279;2304.781045800646;2305.239271040561;2308.4805918668335;2337.8480398774195;2284.4403121235405;2287.867505584746;2287.942801429961;2291.3584196425027;2291.46150654596;8525.786855328604;8591.785205369915;8608.182222688834;8965.910340896573;9015.594298256594;5127.1796512558185;5316.548093412064;5344.732763361816;5358;5373.677579345252;3341.532185494033;3494.7204223662047;3530.1527633368064;3562.928741425157;3577.9105522362147;1020.9132223760989;1068.8931106889327;1069.2675517270695;1092.9344239345664;1103.2828661370093;12476.313802740846;12483.251004939733;12546.68633284166;12565.685857853536;12603.495860165582;4316.589923957219;4496.955030449719;4609.53904609543;4609.792559334838;4637.652176086807;9933.106020458194;9936.850947235796;9940.403575785476;9942.055504727039;9944.25418093646;5259.05337039329;5285.07511185541;5286;5299.735013249322;5329.413764485904;4178.770167640809;4314.827406903689;4764.618830493552;4885.438174609894;4948.90102197954;3621.27574485104;3724.0875985383755;3747.138158223624;3815.8282877270035;3829.368154254517;1160.2110564816005;1163.6334554615269;1174.2191442690687;1175.6663023897556;1184.579474286633;774.2799196747079;823.7816978500703;867.5835598912557;958.6261358070358;986.1420564109271;5822.854428639318;5859.53123750099;5914.781956766213;6050.6672133032225;6215.782447614311;892.9285657147412;904.615538396179;952.7094236258008;953.9618415263451;999.1307562420741;3758.361078616642;3942.231264903374;4005.4792876925812;4056.472658554428;4121.052158003676;10469.9476502617;10874.728131796768;10948.397838118979;10979.133547296979;11140.331580105058;10628.36229826213;10778.137748980063;10807.405592692478;10882.183836212316;10907.454627268606;8276;8445.11326310753;8449.57752112392;8449.704260350858;8461.746147615582;5533.529649979797;5559.610827242054;5695.629784064023;5790.610253539036;5823.534117270693;10188.337758045704;10221.131203847755;10290.176785857264;10365;10366.06705396518;9503.334766566273;9736.318457707892;9935.751606209902;9953.402795831984;10231.795364092824;7471.626418678936;7705.30652241301;7721.691132354643;8489.787755306166;8701.129887011248;7740.225977402215;7801.219878012381;8160.5103693778565;8420.957895210484;8541.572921354033;7625.428092892944;7688.231176882267;7743.341815945708;7854.2145785421;7958.721444749406;7490.625468726651;7648.34989025939;7661.961690191513;7672.194419585863;7750.8449831001935;6682.431993280626;6853.280405557544;6859.5541289816;6865.244823069558;6866.793996180123;5024.673396229234;5234.398044224963;5263.105272103675;5309.309789727311;5380.192971054373;5179.870503237449;5180.766865491138;5189.221616757516;5244.292020577173;5501.037318469332 06:37:19 INFO - PROCESS | 16672 | |4;prototype.html;319.43778949049664;321.52574951945877;328.60895534314164;328.9440795064839;334.2496096263888;5056.696598204101;5130.358705161855;5230.84307470776;5246.18684103964;5281.577473802096;5066.341375621164;5148.510891465305;5162.65770899566;5182.533571978521;5204.8698782530455;4107.473903549326;4123;4125.360569111777;4125.587441255881;4135.503739551258;3804.6385593368586;3963.564007959122;4154.5222299435645;4156.231097247019;4157.62798276568;3996.3406038003695;4080;4103.753774773509;4105.733127346728;4116.855910043149;4096.754194748325;4098.959010409888;4100.487439070116;4103.158852435258;4106.425100485934;3641.8725344612812;3645.8723944662074;3653.269346130758;3659.835307411173;3665.4868318435174;4929.8028078876805;5071.847844564669;5106;5110.48895110486;5123.538881500683;4696.9530304696855;4699.67102302839;4702.388689470381;4707.71753694776;4709.199436095838;5331.256738948128;5488.53347465466;5491.341039075297;5498.5876059295315;5501.359347513176;3901.2587608354606;3930.7641541507314;3935.5474120476224;3946.940795888064;3988.900277493057;5630.198336532311;5649.802256920988;5655.830325090213;5657.462541058593;5692.576855786054;4084.101497670508;4092.4884389451317;4094.651954583834;4098.975256185953;4109.568495308009;3828.5788563258575;4043.029672878547;4077.347624380085;4082.81627326771;4137.262349813086;4651.81378748417;4657.930131048037;4663.48701642819;4665.790039448233;4665.813367465331;5509.834704958857;5511.751971161308;5514;5529.700520377708;5535.806246781343;1373.368250604733;1397.4969011155977;1397.5807257822612;1403.8525954774807;1409.689868228988;872.1714371347118;895.2927187521915;900.3742399032609;906.5014242166782;908.2325435007408;4649.883752906205;4680.485146633868;4702.388689470416;4707.364505791675;4711.717296962193;4923.852284431473;4938.975305123451;4966.850994470172;4968.726720030433;4974.0797952378925;4511.842085527056;4651.62786977041;4687.273472611751;4693.249080147229;4717.976410117996;2653.641758362635;2655.522006038893;2656.2336046529226;2663.2821829919594;2676.906308279201;5083.262926875583;5084.796608135707;5088.92366614501;5110.3356563646485;5142.871428214325;4676.321933319718;5026.949730502648;5044.545990860766;5050.595952323805;5065.772040258197;5061.721605311744;5099.424790480858;5126.5898728101665;5170.767315470737;5204.817831375959;4989.55094041538;4993.275974983534;5000;5000.77496512665;5012.248162775467;4888.242322440027;4890.364252647276;4940.333055037524;5172.7155006475;5597.160425936142;5875.471207591338;5883.882322353444;5884.529237661062;5911.527077833677;5918.674472904032;3722.218334149859;4055.7160998730988;4062.2687916175373;4062.431259623596;4067.389891516178;5219.973900130475;5515.448455154453;5516.469459545814;5635.577331700057;5646.802361917313;5516.310461192351;5525.834224973257;5539.916901246565;5540.556755459635;5549.863302628436;5350.464953504618;5482.533984611353;5487.679953627998;5493.615446918678;5512.503874651301;5458.4814442627885;5463.672179669074;5466.180072989084;5481.369642491005;5507.917381239365;5506.476884695948;5526.585506086979;5562.332520097614;5567.969925563783;5570.6657600544095;5304.522592966651;5414.10667239901;5414.431484694051;5435.701036443033;5445.618806683494 06:37:19 INFO - PROCESS | 16672 | |5;yui.html;693.6843736100075;706.7561691216529;715.2204097533687;733.0470388494955;781.0900301149162;15679.529614111581;16884.577885552866;16922;16928.068956207404;16938.32246710133;14178.574642760734;14244.71510569788;14276;14276.71446571068;14280.214588197645;657.7106073327733;678.6708446403491;801.9959900200491;805.9476134051297;829.1045670675655;808.6239898447221;814.9633266502992;816.1797393619404;819.4673462249526;820.8645573480369;859.7979474823411;864.0365991919028;864.8270345930839;866.7356456280831;871.4335681806813;693.4764252988987;714.2892821642447;821.6631181215732;847.4660963592959;852.8507511185579;612.6079309242089;618.7586841131962;618.9257289125334;624.0825985800866;624.2228425610144;14310;14345.569632911029;14347.06744061643;14365.13809171453;14404.351804168837;13531.932340338333;13795.793063104062;13964.162150271017;13985.650358741012;14297.070690405195;11978.161528692995;12095.516179352815;12431.875681243162;12435.502579896793;12450.750984980341;4292.141571685675;4315.978420107911;4370.7159034662645;4378.627816635558;4389;79626.60186699088;79734.20265797326;80156.59921700413;80278;83974.58012709959;11070.132621792753;11092.168087393478;11183.384913829817;11194.552217911356;11347.37589432589;21537.353879383645;21646;21676.349709508424;21707;21812.672809907865;8039.799005024921;8046.597670116471;8161.79595510117;8173.386995975206;8431.325493960469;4422.447194100738;4451.154280686659;4517.299818528133;4569.543045695404;4576.908461830745;3520.3487354839435;3664;3675.503806986076;3675.889723308305;3683.171286460525;605.8333958161453;608.9695515224221;615.5383462403198;623.6538721009883;624.073251221935;618.9783357582463;673.8551211489553;689.0800780957378;713.3116542536374;743.2604558464254;9394.201492873046;9729.221662267002;10088.344257623232;10192.439415832201;10290.948545257226;675.3280485916545;701.7263267325746;738.6417587470073;743.3347154296874;760.69572171132;4406.603405693503;4650.674452788272;4919.926201106915;4950.059488697208;4960.199596055633;121229;122408.38795806142;122704;124958.3752081252;125925;80669;81033.59483202665;81958;90802;107104.46447767712;52536.999999999236;75832.69171157965;79435.60282198552;79451;81088;9561;9952.452615106238;10351.792964140826;10429.217808664229;10453.68638940833;46195.53804461913;47060.29409558791;47223.76388118038;48018;49135.01729965452;67098.66450667716;71001;73308;74346.62826685832;75658;12706.936465317614;12949.935250324064;13017.674558136123;13059.21644701321;13285.80071298912;14423.711525769635;14534.418623254951;14538.200398977735;14647.560573182822;15619.765703514684;13813.723725525635;14002.929985350416;14338.211398373189;14486.16266457005;14674.413023479368;13599.456021759019;13794.965107676295;13874.375653095432;13893.305334733424;13969.58091257264;13916.017328966502;13922.860771392561;13996.650083747987;14220.075695079786;14689;11184.664460066211;11592.336496740925;11707.239029463399;11903.940480297542;12102.818457722966;11469.885301146882;11900.226485278428;12107.51569937228;12127.878721213028;12419.875801241871 06:37:19 INFO - PROCESS | 16672 | __end_tp_report 06:37:19 INFO - PROCESS | 16672 | __start_cc_report 06:37:19 INFO - PROCESS | 16672 | _x_x_mozilla_cycle_collect,1638 06:37:19 INFO - PROCESS | 16672 | __end_cc_report 06:37:19 INFO - PROCESS | 16672 | __startTimestamp1476711439539__endTimestamp 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | ------- Summary: start ------- 06:37:19 INFO - PROCESS | 16672 | Number of tests: 6 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | [#0] dojo.html Cycles:165 Average:5346.17 Median:5515.48 stddev:599.69 (10.9%) stddev-sans-first:574.53 06:37:19 INFO - PROCESS | 16672 | Values: 3078.1 3096.3 3099.4 3132.2 3152.4 5137.3 5214.6 5347.6 5383.7 5427.0 5276.2 5335.9 5404.4 5429.4 5446.5 4754.0 4780.9 4829.7 4866.2 4913.3 4948.3 5029.1 5089.3 5095.6 5154.8 4759.1 4951.1 4951.5 4980.6 5080.5 4808.9 4842.2 4879.0 4903.0 4905.7 4871.8 4890.2 4894.8 4913.4 4953.1 5353.4 5367.8 5382.2 5383.7 5411.0 5457.1 5498.1 5664.6 5730.9 5735.7 5778.1 5787.2 5789.8 5851.9 5858.4 5373.2 5374.2 5378.5 5379.8 5380.8 5620.0 5620.9 5682.7 5882.7 5892.1 5617.5 5667.9 5673.9 5678.9 5749.4 5698.0 5739.5 5740.2 5754.9 5760.9 5486.9 5699.5 5704.3 5708.2 5709.7 5482.1 5622.1 5624.8 5625.6 5630.2 4358.3 4374.8 4375.2 4376.1 4378.9 3961.7 3964.1 3965.2 3966.7 3972.3 5346.5 5390.8 5391.3 5392.9 5396.5 5720.5 5752.6 5790.4 5806.9 5867.9 5484.4 5501.4 5515.5 5520.4 5562.7 5054.0 5068.6 5073.1 5074.9 5133.4 5753.3 5793.2 5800.8 5851.9 6044.5 5690.5 5752.2 5799.5 5824.9 5921.8 6042.4 6047.1 6107.9 6108.2 6116.9 5713.1 5714.3 5716.5 5717.3 5722.1 5568.4 5622.2 5827.2 5828.7 5833.4 5634.0 5701.0 5714.7 5746.8 5808.2 5642.2 5679.2 5689.4 5690.1 5693.1 5427.4 5663.7 5679.6 5695.2 5699.7 5528.9 5614.1 5618.0 5621.2 5622.7 5466.7 5497.9 5499.2 5505.2 5506.9 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | [#1] ext.html Cycles:180 Average:56221.49 Median:35014.91 stddev:112776.22 (322.1%) stddev-sans-first:113015.11 06:37:19 INFO - PROCESS | 16672 | Values: 544.6 601.6 603.4 608.0 615.2 30745.5 40168.8 41256.2 41330.0 45465.0 42530.4 42920.1 42998.0 43046.8 43069.6 7843.8 8704.6 8841.5 8855.0 8859.6 8002.8 8255.6 8257.6 10258.5 10539.5 10637.1 10693.4 10694.9 10708.4 10714.8 10482.5 10606.2 10608.7 10626.9 10627.9 10267.5 10318.5 10332.3 10335.4 10337.3 40576.8 40840.4 40871.6 40964.0 40993.8 3314.1 3339.9 3430.7 3632.2 3844.0 30204.7 31132.8 31390.2 31813.5 32019.7 4157.0 4159.3 4334.2 4347.5 4396.7 298405.0 300985.0 300987.0 301112.5 302231.0 31770.2 33171.7 33304.3 54653.2 55245.0 34936.0 35059.8 35257.6 35278.6 35284.8 14241.4 14285.9 14314.9 14316.6 14330.6 10657.7 11613.3 11616.8 11625.8 11653.2 7492.3 7604.1 8076.9 8106.4 8157.1 3164.7 3173.6 3199.4 3208.9 3220.5 991.5 1014.9 1020.8 1060.1 1143.2 31457.7 31643.0 31848.4 32520.5 32613.8 1078.3 1125.8 1146.2 1159.3 1206.8 16566.4 17008.1 17065.7 17203.1 17311.7 502774.0 506861.0 508676.0 509539.0 510568.0 54908.7 55140.0 55298.7 55438.2 55512.7 1185.7 1244.2 1251.9 1309.9 1333.1 29165.7 33042.8 34653.3 34708.8 34808.8 52374.5 53257.7 53259.0 53284.0 53370.5 434558.0 439498.0 439631.0 440203.4 441663.0 25950.6 27402.9 27465.5 27828.2 33524.0 36099.0 43688.0 46197.0 46211.0 50995.0 39026.4 39342.6 40137.8 40277.0 41187.4 39136.6 39221.2 40178.4 40612.3 41285.6 40037.8 40040.0 40132.2 41483.4 41682.8 33041.7 34970.0 35134.5 35917.6 36156.0 26958.0 27166.5 27277.5 27467.7 27512.4 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | [#2] jquery.html Cycles:180 Average:26650.57 Median:18803.92 stddev:70606.98 (375.5%) stddev-sans-first:70777.49 06:37:19 INFO - PROCESS | 16672 | Values: 375.8 377.5 386.9 396.5 406.6 14711.5 15036.8 17019.5 20005.4 20296.6 16452.3 19639.1 19651.2 19787.7 20028.1 5475.8 5630.4 5706.8 5709.3 5713.2 5465.0 5673.5 5720.5 5728.3 5735.9 4060.9 4267.1 5688.7 5696.0 5999.6 6235.4 6371.9 6384.0 6386.0 6391.7 4979.3 5250.0 5287.8 5344.3 5351.6 13156.0 13424.1 15736.8 22346.4 22526.3 2180.1 2193.5 2289.5 2310.9 2547.3 9220.0 10219.1 10425.9 11673.0 13958.2 1789.5 1817.8 1842.3 1844.8 1930.8 77269.0 77791.0 78634.9 79150.6 83282.6 10329.7 10439.7 10564.3 10597.5 10807.3 14950.6 14951.9 14975.6 14982.6 14996.2 7459.6 7504.6 7537.1 7700.0 7879.3 7362.8 7366.2 7484.4 7641.1 7652.4 4423.6 4462.9 4549.3 4564.8 4593.2 1771.8 1863.6 1865.1 1892.8 1905.3 965.3 978.9 1007.5 1023.0 1023.4 18201.9 18903.1 19220.3 19304.3 19606.7 944.5 952.5 962.7 970.2 978.4 10276.6 10715.2 10759.6 10793.4 10811.4 375661.0 430814.0 434742.0 440088.0 445697.7 87827.0 88946.0 90385.0 90411.5 90607.5 981.5 1057.6 1070.6 1086.3 1088.4 16311.3 16904.7 17187.7 17215.2 17348.7 37232.0 39539.0 39770.8 40413.4 40687.8 54536.5 55583.4 57093.4 57247.4 58173.7 7450.3 8177.0 8233.9 8266.4 8352.8 12266.9 12952.6 13151.3 13154.9 13835.4 11157.3 11254.4 11263.1 11919.5 11940.6 11322.5 11395.5 11446.0 11626.1 12034.9 11655.7 11677.4 11912.1 11952.8 12164.0 7523.4 7568.4 7572.3 7633.5 7960.3 8841.5 10913.6 11513.8 11653.5 11791.6 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | [#3] mootools.html Cycles:180 Average:5778.48 Median:5211.81 stddev:3305.79 (63.4%) stddev-sans-first:3297.85 06:37:19 INFO - PROCESS | 16672 | Values: 1289.3 1453.9 1513.0 1658.2 1793.7 7804.4 8679.0 8939.2 8976.1 9203.0 8939.9 9063.5 9074.5 9079.1 9084.8 2306.2 2336.8 2349.9 2352.3 2353.5 2322.1 2348.8 2375.3 2378.4 2382.0 2326.8 2341.2 2348.3 2374.1 2380.6 2283.4 2304.8 2305.2 2308.5 2337.8 2284.4 2287.9 2287.9 2291.4 2291.5 8525.8 8591.8 8608.2 8965.9 9015.6 5127.2 5316.5 5344.7 5358.0 5373.7 3341.5 3494.7 3530.2 3562.9 3577.9 1020.9 1068.9 1069.3 1092.9 1103.3 12476.3 12483.3 12546.7 12565.7 12603.5 4316.6 4497.0 4609.5 4609.8 4637.7 9933.1 9936.9 9940.4 9942.1 9944.3 5259.1 5285.1 5286.0 5299.7 5329.4 4178.8 4314.8 4764.6 4885.4 4948.9 3621.3 3724.1 3747.1 3815.8 3829.4 1160.2 1163.6 1174.2 1175.7 1184.6 774.3 823.8 867.6 958.6 986.1 5822.9 5859.5 5914.8 6050.7 6215.8 892.9 904.6 952.7 954.0 999.1 3758.4 3942.2 4005.5 4056.5 4121.1 10469.9 10874.7 10948.4 10979.1 11140.3 10628.4 10778.1 10807.4 10882.2 10907.5 8276.0 8445.1 8449.6 8449.7 8461.7 5533.5 5559.6 5695.6 5790.6 5823.5 10188.3 10221.1 10290.2 10365.0 10366.1 9503.3 9736.3 9935.8 9953.4 10231.8 7471.6 7705.3 7721.7 8489.8 8701.1 7740.2 7801.2 8160.5 8421.0 8541.6 7625.4 7688.2 7743.3 7854.2 7958.7 7490.6 7648.3 7662.0 7672.2 7750.8 6682.4 6853.3 6859.6 6865.2 6866.8 5024.7 5234.4 5263.1 5309.3 5380.2 5179.9 5180.8 5189.2 5244.3 5501.0 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | [#4] prototype.html Cycles:180 Average:4477.59 Median:4991.41 stddev:1297.13 (26.0%) stddev-sans-first:1262.67 06:37:19 INFO - PROCESS | 16672 | Values: 319.4 321.5 328.6 328.9 334.2 5056.7 5130.4 5230.8 5246.2 5281.6 5066.3 5148.5 5162.7 5182.5 5204.9 4107.5 4123.0 4125.4 4125.6 4135.5 3804.6 3963.6 4154.5 4156.2 4157.6 3996.3 4080.0 4103.8 4105.7 4116.9 4096.8 4099.0 4100.5 4103.2 4106.4 3641.9 3645.9 3653.3 3659.8 3665.5 4929.8 5071.8 5106.0 5110.5 5123.5 4697.0 4699.7 4702.4 4707.7 4709.2 5331.3 5488.5 5491.3 5498.6 5501.4 3901.3 3930.8 3935.5 3946.9 3988.9 5630.2 5649.8 5655.8 5657.5 5692.6 4084.1 4092.5 4094.7 4099.0 4109.6 3828.6 4043.0 4077.3 4082.8 4137.3 4651.8 4657.9 4663.5 4665.8 4665.8 5509.8 5511.8 5514.0 5529.7 5535.8 1373.4 1397.5 1397.6 1403.9 1409.7 872.2 895.3 900.4 906.5 908.2 4649.9 4680.5 4702.4 4707.4 4711.7 4923.9 4939.0 4966.9 4968.7 4974.1 4511.8 4651.6 4687.3 4693.2 4718.0 2653.6 2655.5 2656.2 2663.3 2676.9 5083.3 5084.8 5088.9 5110.3 5142.9 4676.3 5026.9 5044.5 5050.6 5065.8 5061.7 5099.4 5126.6 5170.8 5204.8 4989.6 4993.3 5000.0 5000.8 5012.2 4888.2 4890.4 4940.3 5172.7 5597.2 5875.5 5883.9 5884.5 5911.5 5918.7 3722.2 4055.7 4062.3 4062.4 4067.4 5220.0 5515.4 5516.5 5635.6 5646.8 5516.3 5525.8 5539.9 5540.6 5549.9 5350.5 5482.5 5487.7 5493.6 5512.5 5458.5 5463.7 5466.2 5481.4 5507.9 5506.5 5526.6 5562.3 5568.0 5570.7 5304.5 5414.1 5414.4 5435.7 5445.6 06:37:19 INFO - PROCESS | 16672 | 06:37:19 INFO - PROCESS | 16672 | [#5] yui.html Cycles:180 Average:20448.43 Median:4383.81 stddev:29373.38 (670.0%) stddev-sans-first:29418.33 06:37:19 INFO - PROCESS | 16672 | Values: 693.7 706.8 715.2 733.0 781.1 15679.5 16884.6 16922.0 16928.1 16938.3 14178.6 14244.7 14276.0 14276.7 14280.2 657.7 678.7 802.0 805.9 829.1 808.6 815.0 816.2 819.5 820.9 859.8 864.0 864.8 866.7 871.4 693.5 714.3 821.7 847.5 852.9 612.6 618.8 618.9 624.1 624.2 14310.0 14345.6 14347.1 14365.1 14404.4 13531.9 13795.8 13964.2 13985.7 14297.1 11978.2 12095.5 12431.9 12435.5 12450.8 4292.1 4316.0 4370.7 4378.6 4389.0 79626.6 79734.2 80156.6 80278.0 83974.6 11070.1 11092.2 11183.4 11194.6 11347.4 21537.4 21646.0 21676.3 21707.0 21812.7 8039.8 8046.6 8161.8 8173.4 8431.3 4422.4 4451.2 4517.3 4569.5 4576.9 3520.3 3664.0 3675.5 3675.9 3683.2 605.8 609.0 615.5 623.7 624.1 619.0 673.9 689.1 713.3 743.3 9394.2 9729.2 10088.3 10192.4 10290.9 675.3 701.7 738.6 743.3 760.7 4406.6 4650.7 4919.9 4950.1 4960.2 121229.0 122408.4 122704.0 124958.4 125925.0 80669.0 81033.6 81958.0 90802.0 107104.5 52537.0 75832.7 79435.6 79451.0 81088.0 9561.0 9952.5 10351.8 10429.2 10453.7 46195.5 47060.3 47223.8 48018.0 49135.0 67098.7 71001.0 73308.0 74346.6 75658.0 12706.9 12949.9 13017.7 13059.2 13285.8 14423.7 14534.4 14538.2 14647.6 15619.8 13813.7 14002.9 14338.2 14486.2 14674.4 13599.5 13795.0 13874.4 13893.3 13969.6 13916.0 13922.9 13996.7 14220.1 14689.0 11184.7 11592.3 11707.2 11903.9 12102.8 11469.9 11900.2 12107.5 12127.9 12419.9 06:37:19 INFO - PROCESS | 16672 | -------- Summary: end -------- 06:37:19 INFO - PROCESS | 16672 | 06:37:20 INFO - TEST-INFO | 16672: exit 0 06:37:20 INFO - TEST-OK | dromaeo_css | took 1117814ms 06:37:20 INFO - TEST-START | kraken 06:37:20 INFO - operating with platform_type : linux_ 06:37:20 INFO - Initialising browser for kraken test... 06:37:20 INFO - TEST-INFO | started process 16985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckK27I/profile http://localhost:41155/getInfo.html) 06:37:24 INFO - PROCESS | 16985 | __metrics Screen width/height:1600/1200 06:37:24 INFO - PROCESS | 16985 | colorDepth:24 06:37:24 INFO - PROCESS | 16985 | Browser inner width/height: 1024/697 06:37:24 INFO - PROCESS | 16985 | __metrics 06:37:24 INFO - PROCESS | 16985 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:37:24 INFO - PROCESS | 16985 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:37:25 INFO - PROCESS | 16985 | console.error: PushService: 06:37:25 INFO - PROCESS | 16985 | stateChangeProcessEnqueue: Error transitioning state 06:37:25 INFO - PROCESS | 16985 | UnknownError 06:37:25 INFO - TEST-INFO | 16985: exit 0 06:37:25 INFO - Browser initialized. 06:37:25 INFO - Running cycle 1/1 for kraken test... 06:37:25 INFO - TEST-INFO | started process 17071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckK27I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:38 INFO - PROCESS | 17071 | RSS: Main: 172060672 06:37:38 INFO - PROCESS | 17071 | 06:37:40 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-beat-detection) 06:37:41 INFO - PROCESS | 17071 | RSS: Main: 229220352 06:37:41 INFO - PROCESS | 17071 | 06:37:44 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-dft) 06:37:44 INFO - PROCESS | 17071 | RSS: Main: 215711744 06:37:44 INFO - PROCESS | 17071 | 06:37:47 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-fft) 06:37:48 INFO - PROCESS | 17071 | RSS: Main: 297320448 06:37:48 INFO - PROCESS | 17071 | 06:37:50 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41155/tests/kraken/driver.html?testName=audio-oscillator) 06:37:51 INFO - PROCESS | 17071 | RSS: Main: 206299136 06:37:51 INFO - PROCESS | 17071 | 06:37:53 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41155/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:37:53 INFO - PROCESS | 17071 | RSS: Main: 211763200 06:37:53 INFO - PROCESS | 17071 | 06:37:57 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41155/tests/kraken/driver.html?testName=imaging-darkroom) 06:37:57 INFO - PROCESS | 17071 | RSS: Main: 247402496 06:37:57 INFO - PROCESS | 17071 | 06:38:00 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41155/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:01 INFO - PROCESS | 17071 | RSS: Main: 246706176 06:38:01 INFO - PROCESS | 17071 | 06:38:04 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41155/tests/kraken/driver.html?testName=json-parse-financial) 06:38:04 INFO - PROCESS | 17071 | RSS: Main: 246267904 06:38:04 INFO - PROCESS | 17071 | 06:38:06 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41155/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:06 INFO - PROCESS | 17071 | RSS: Main: 208441344 06:38:06 INFO - PROCESS | 17071 | 06:38:08 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:09 INFO - PROCESS | 17071 | RSS: Main: 216125440 06:38:09 INFO - PROCESS | 17071 | 06:38:11 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:11 INFO - PROCESS | 17071 | RSS: Main: 225517568 06:38:11 INFO - PROCESS | 17071 | 06:38:14 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:15 INFO - PROCESS | 17071 | RSS: Main: 234262528 06:38:15 INFO - PROCESS | 17071 | 06:38:18 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:18 INFO - PROCESS | 17071 | RSS: Main: 230543360 06:38:18 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | Cycle 1(1): loaded http://localhost:41155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41155/tests/kraken/driver.html?testName=ai-astar) 06:38:20 INFO - PROCESS | 17071 | RSS: Main: 281694208 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | __start_tp_report 06:38:20 INFO - PROCESS | 17071 | _x_x_mozilla_page_load 06:38:20 INFO - PROCESS | 17071 | _x_x_mozilla_page_load_details 06:38:20 INFO - PROCESS | 17071 | |i|pagename|runs| 06:38:20 INFO - PROCESS | 17071 | |0;ai-astar;105;113;111;110;111;110;110;110;111;110 06:38:20 INFO - PROCESS | 17071 | |1;audio-beat-detection;148;123;125;162;124;125;122;128;175;126 06:38:20 INFO - PROCESS | 17071 | |2;audio-dft;161;162;161;160;162;163;162;163;161;161 06:38:20 INFO - PROCESS | 17071 | |3;audio-fft;76;76;76;112;75;76;76;81;109;75 06:38:20 INFO - PROCESS | 17071 | |4;audio-oscillator;83;83;115;84;82;84;107;82;83;117 06:38:20 INFO - PROCESS | 17071 | |5;imaging-gaussian-blur;117;118;117;117;118;118;118;118;118;117 06:38:20 INFO - PROCESS | 17071 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;146;146 06:38:20 INFO - PROCESS | 17071 | |7;imaging-desaturate;84;85;85;85;84;84;85;85;85;85 06:38:20 INFO - PROCESS | 17071 | |8;json-parse-financial;52;51;52;51;52;52;56;52;52;53 06:38:20 INFO - PROCESS | 17071 | |9;json-stringify-tinderbox;59;60;59;60;60;60;60;64;60;61 06:38:20 INFO - PROCESS | 17071 | |10;stanford-crypto-aes;81;81;84;89;80;80;81;80;80;80 06:38:20 INFO - PROCESS | 17071 | |11;stanford-crypto-ccm;134;140;133;142;138;129;135;140;180;142 06:38:20 INFO - PROCESS | 17071 | |12;stanford-crypto-pbkdf2;172;170;173;169;167;168;165;171;166;169 06:38:20 INFO - PROCESS | 17071 | |13;stanford-crypto-sha256-iterative;67;72;67;66;70;73;67;67;65;64 06:38:20 INFO - PROCESS | 17071 | __end_tp_report 06:38:20 INFO - PROCESS | 17071 | __start_cc_report 06:38:20 INFO - PROCESS | 17071 | _x_x_mozilla_cycle_collect,1687 06:38:20 INFO - PROCESS | 17071 | __end_cc_report 06:38:20 INFO - PROCESS | 17071 | __startTimestamp1476711500645__endTimestamp 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | ------- Summary: start ------- 06:38:20 INFO - PROCESS | 17071 | Number of tests: 14 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.02 (1.8%) stddev-sans-first:1.00 06:38:20 INFO - PROCESS | 17071 | Values: 105.0 113.0 111.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:127.00 stddev:19.02 (15.0%) stddev-sans-first:19.65 06:38:20 INFO - PROCESS | 17071 | Values: 148.0 123.0 125.0 162.0 124.0 125.0 122.0 128.0 175.0 126.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 06:38:20 INFO - PROCESS | 17071 | Values: 161.0 162.0 161.0 160.0 162.0 163.0 162.0 163.0 161.0 161.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:14.51 (19.1%) stddev-sans-first:15.15 06:38:20 INFO - PROCESS | 17071 | Values: 76.0 76.0 76.0 112.0 75.0 76.0 76.0 81.0 109.0 75.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:14.72 (17.7%) stddev-sans-first:15.25 06:38:20 INFO - PROCESS | 17071 | Values: 83.0 83.0 115.0 84.0 82.0 84.0 107.0 82.0 83.0 117.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:38:20 INFO - PROCESS | 17071 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:38:20 INFO - PROCESS | 17071 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 06:38:20 INFO - PROCESS | 17071 | Values: 84.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.42 (2.7%) stddev-sans-first:1.50 06:38:20 INFO - PROCESS | 17071 | Values: 52.0 51.0 52.0 51.0 52.0 52.0 56.0 52.0 52.0 53.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:1.42 (2.4%) stddev-sans-first:1.42 06:38:20 INFO - PROCESS | 17071 | Values: 59.0 60.0 59.0 60.0 60.0 60.0 60.0 64.0 60.0 61.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:2.88 (3.5%) stddev-sans-first:3.04 06:38:20 INFO - PROCESS | 17071 | Values: 81.0 81.0 84.0 89.0 80.0 80.0 81.0 80.0 80.0 80.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:140.00 stddev:14.24 (10.2%) stddev-sans-first:14.86 06:38:20 INFO - PROCESS | 17071 | Values: 134.0 140.0 133.0 142.0 138.0 129.0 135.0 140.0 180.0 142.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:2.58 (1.5%) stddev-sans-first:2.50 06:38:20 INFO - PROCESS | 17071 | Values: 172.0 170.0 173.0 169.0 167.0 168.0 165.0 171.0 166.0 169.0 06:38:20 INFO - PROCESS | 17071 | 06:38:20 INFO - PROCESS | 17071 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.94 (4.4%) stddev-sans-first:3.10 06:38:20 INFO - PROCESS | 17071 | Values: 67.0 72.0 67.0 66.0 70.0 73.0 67.0 67.0 65.0 64.0 06:38:20 INFO - PROCESS | 17071 | -------- Summary: end -------- 06:38:20 INFO - PROCESS | 17071 | 06:38:21 INFO - TEST-INFO | 17071: exit 0 06:38:21 INFO - TEST-OK | kraken | took 61364ms 06:38:21 INFO - SUITE-END | took 1179s 06:38:22 INFO - Completed test suite (00:19:39) 06:38:22 INFO - javascript benchmark 06:38:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.091962870953, 3096.318809861831, 3099.442100421924, 3132.185631735748, 3152.36952609478, 5137.306463627409, 5214.634975551713, 5347.625666203362, 5383.730813459331, 5426.972865135674, 5276.15581506959, 5335.893282134355, 5404.351477822657, 5429.375621803494, 5446.455354464551, 4753.952460475402, 4780.880477988043, 4829.661923665345, 4866.172750632383, 4913.31213630092, 4948.331975183341, 5029.1199040168, 5089.338386009814, 5095.643304968635, 5154.819581314655, 4759.143354196243, 4951.059298733229, 4951.504849515056, 4980.601551875841, 5080.517350851663, 4808.879778005543, 4842.201036828954, 4879.024195160947, 4903.043906438246, 4905.730184839832, 4871.824040596881, 4890.217565189588, 4894.828680996184, 4913.361263035818, 4953.108440480712, 5353.357597088336, 5367.75845086972, 5382.1926710993275, 5383.676979381211, 5411.0, 5457.126859702428, 5498.147787093007, 5664.631798933097, 5730.856728581777, 5735.713214339266, 5778.104393818965, 5787.247657804459, 5789.797357092481, 5851.882962340729, 5858.355580886099, 5373.167159090347, 5374.193870919394, 5378.542823859977, 5379.784808607612, 5380.757865896005, 5620.044592419298, 5620.887582248332, 5682.715864206773, 5882.705864706748, 5892.086726557391, 5617.466340697627, 5667.914981275284, 5673.858153546194, 5678.858028549237, 5749.3963133871175, 5698.031334673115, 5739.512141467939, 5740.196372507852, 5754.88490230193, 5760.855978600569, 5486.890262194734, 5699.487046165782, 5704.258446401941, 5708.1723150143, 5709.74306156224, 5482.122860342326, 5622.072358060874, 5624.831255062355, 5625.606207565431, 5630.155476678531, 4358.346248062816, 4374.759388233678, 4375.234333991539, 4376.146651402946, 4378.912421751611, 3961.7226794124713, 3964.1080756829483, 3965.167314863911, 3966.7421617594764, 3972.2849887020034, 5346.518813306821, 5390.757415916293, 5391.32608423947, 5392.892142157135, 5396.514313711785, 5720.456556627114, 5752.597318187687, 5790.420957904176, 5806.941930580725, 5867.853303667443, 5484.369297530755, 5501.422350653123, 5515.4760297771645, 5520.420355862657, 5562.721863906789, 5054.0, 5068.619853511002, 5073.137566613685, 5074.949250507521, 5133.383993920754, 5753.309602847601, 5793.159991801165, 5800.767969281182, 5851.853703657443, 6044.455998960027, 5690.5163061140265, 5752.1659359391815, 5799.4780469757925, 5824.883502329845, 5921.792737254348, 6042.395760423922, 6047.123167140828, 6107.908381374372, 6108.236470441195, 6116.877662446637, 5713.143028545752, 5714.342850572238, 5716.54267658578, 5717.256756621613, 5722.055860783091, 5568.387477377404, 5622.156676498558, 5827.213326200908, 5828.6502809831545, 5833.416658334302, 5634.0, 5701.030824759884, 5714.657120572779, 5746.827595172152, 5808.157817116579, 5642.23829782974, 5679.204911312337, 5689.402612725604, 5690.118031705092, 5693.089105743061, 5427.402985671494, 5663.66018038919, 5679.630823996427, 5695.174199741097, 5699.715014249188, 5528.861778455571, 5614.101743720985, 5618.016847051831, 5621.156826476062, 5622.718864056699, 5466.699331536644, 5497.945020549743, 5499.230107784993, 5505.201745746765, 5506.862328441821], "value": 5306.177462271822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5793448123094, 601.6299975515058, 603.3544107804651, 608.0180508478808, 615.1695211464522, 30745.538816917735, 40168.799156004214, 41256.17487650245, 41330.0, 45465.0, 42530.36204456936, 42920.14159716811, 42998.0, 43046.784766076125, 43069.56930430695, 7843.843123137533, 8704.608292626846, 8841.469511829311, 8854.955725221396, 8859.601317940707, 8002.759917202493, 8255.628496717662, 8257.587120643973, 10258.53836577352, 10539.525721342558, 10637.149028077774, 10693.411862347568, 10694.893051069468, 10708.41103739294, 10714.839277410845, 10482.475876206197, 10606.204534659932, 10608.681739547748, 10626.893731062706, 10627.946860265727, 10267.537960791708, 10318.484075796181, 10332.328398654063, 10335.379877207391, 10337.276390652658, 40576.79711601423, 40840.387394188816, 40871.59128408707, 40964.0, 40993.79503102465, 3314.105191598279, 3339.916502087443, 3430.6569343065744, 3632.182758879231, 3843.9813449435924, 30204.697953020626, 31132.8443357784, 31390.215244618837, 31813.52279715806, 32019.679803202136, 4156.9792151039355, 4159.313713237312, 4334.176506463793, 4347.543507931685, 4396.692231543793, 298405.0, 300985.0, 300987.0, 301112.4944375286, 302231.0, 31770.205744856565, 33171.66828331734, 33304.33391332208, 54653.180202297, 55245.0, 34936.0, 35059.824700876336, 35257.64742352595, 35278.64721352805, 35284.82357588196, 14241.359138838778, 14285.92857035729, 14314.856851431561, 14316.570502884722, 14330.57008289753, 10657.733556661145, 11613.30320180792, 11616.825747613793, 11625.825612615818, 11653.242539234923, 7492.288232617892, 7604.087509498785, 8076.8788468173025, 8106.392020598479, 8157.14349993254, 3164.730997865161, 3173.5715678383585, 3199.3601279744144, 3208.9410494537215, 3220.468622677232, 991.4745185051934, 1014.9238807089498, 1020.7907378987289, 1060.0512541275516, 1143.2283208834003, 31457.685423145474, 31643.0, 31848.36303273968, 32520.512192317135, 32613.83693081567, 1078.2883297023927, 1125.791728530208, 1146.1976616368574, 1159.3217967489113, 1206.7646808872362, 16566.420175293806, 17008.149592520323, 17065.744013839554, 17203.1398430078, 17311.740323895152, 502774.0, 506861.0, 508676.0, 509539.0, 510568.0, 54908.725456373264, 55140.0, 55298.723506383016, 55438.16842747362, 55512.722436388365, 1185.6502331811964, 1244.1539752967888, 1251.949922003128, 1309.862464441239, 1333.1134795360977, 29165.7083429163, 33042.834785826875, 34653.306933861684, 34708.82645586756, 34808.82595587006, 52374.476255238485, 53257.733711331195, 53259.0, 53284.0, 53370.466295338105, 434558.0, 439498.0, 439631.0, 440203.38677985827, 441663.0, 25950.610740838525, 27402.862985684944, 27465.45069098567, 27828.165155045383, 33524.0, 36099.0, 43688.0, 46197.0, 46211.0, 50995.0, 39026.41460378154, 39342.606573933896, 40137.82427405082, 40277.0, 41187.38218926779, 39136.608633913296, 39221.2155756889, 40178.39732403958, 40612.329582098435, 41285.58714412817, 40037.79981100076, 40040.0, 40132.1973560533, 41483.37774933318, 41682.79158604187, 33041.66958330386, 34970.0, 35134.472982904765, 35917.64082359143, 36156.0, 26958.0, 27166.456670866868, 27277.454450910474, 27467.725322746515, 27512.36572570572], "value": 18553.73344541486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.84026788614847, 377.54128733588686, 386.87605048284917, 396.54793535369663, 406.58528301132844, 14711.48509802157, 15036.774448383283, 17019.48941531753, 20005.399838004847, 20296.59406811863, 16452.341906323763, 19639.11623976921, 19651.21395144196, 19787.703184452246, 20028.098735556898, 5475.808346707876, 5630.352509461403, 5706.828795136153, 5709.343425506078, 5713.200151978726, 5464.972675136619, 5673.461021202979, 5720.456556627114, 5728.341240757304, 5735.942640573603, 4060.8578699745517, 4267.14657068586, 5688.687122208277, 5696.0, 5999.580029397944, 6235.376462353751, 6371.87256254877, 6383.968080159592, 6386.042093685938, 6391.712372943229, 4979.278004689299, 5249.973750131263, 5287.762050707727, 5344.278522399465, 5351.625386222966, 13156.0, 13424.060315777899, 15736.763948540782, 22346.441338966495, 22526.324210273553, 2180.095260466904, 2193.517426166241, 2289.484865905158, 2310.9191178308847, 2547.274026902324, 9219.953900230523, 10219.131373833234, 10425.947870260676, 11673.007794337407, 13958.232297223649, 1789.4631610516924, 1817.781866176054, 1842.309134074722, 1844.787849397323, 1930.7972662870336, 77269.0, 77791.0, 78634.8887322328, 79150.60424697897, 83282.58358708228, 10329.741756455998, 10439.686809395731, 10564.260501764957, 10597.502824068039, 10807.297525660806, 14950.551483455514, 14951.850481495263, 14975.550733478012, 14982.550523484313, 14996.175210363317, 7459.589722565311, 7504.587247701429, 7537.057867766529, 7699.961500192463, 7879.33025692811, 7362.77911662651, 7366.1528924173335, 7484.43866709988, 7641.1212710539, 7652.426068044919, 4423.646108311327, 4462.9107417851465, 4549.317602359606, 4564.794584243717, 4593.173228818845, 1771.769669942899, 1863.64590727764, 1865.1047497201148, 1892.8296453318992, 1905.3426567834076, 965.2712202287228, 978.8580655804868, 1007.5113569918584, 1022.9821327778759, 1023.3961962442195, 18201.908990454962, 18903.14935827891, 19220.327288544835, 19304.32434864773, 19606.70589941152, 944.4758159221698, 952.4618590496348, 962.6823148361024, 970.2286682087757, 978.3689520259393, 10276.588936442458, 10715.249932504807, 10759.594352753995, 10793.406362649972, 10811.40537270442, 375661.0, 430814.0, 434742.0, 440088.0, 445697.65872242086, 87827.0, 88946.0, 90385.0, 90411.54794225987, 90607.54696226477, 981.455292312759, 1057.5928267616869, 1070.5717712914895, 1086.326477583903, 1088.3687461272443, 16311.26599303058, 16904.66190676204, 17187.742183867504, 17215.22531486061, 17348.739768903728, 37232.0, 39539.0, 39770.80687579377, 40413.393799093625, 40687.77936661905, 54536.45463545473, 55583.44416555944, 57093.42906570881, 57247.42752572421, 58173.709131454074, 7450.254974502506, 8176.959115204386, 8233.917660823316, 8266.380021498531, 8352.83294334122, 12266.877331226573, 12952.611421657366, 13151.34243287851, 13154.868451315364, 13835.377408016462, 11157.330560166416, 11254.437278136224, 11263.098952083978, 11919.523219071487, 11940.58113286514, 11322.547098116313, 11395.487203075716, 11446.027087697306, 11626.128040396836, 12034.879651203726, 11655.708607284885, 11677.357745324089, 11912.10659200546, 11952.820707689218, 12164.0, 7523.435742319458, 7568.4323675725645, 7572.281544979443, 7633.465657404151, 7960.283574478325, 8841.513716745641, 10913.618023369145, 11513.769724605629, 11653.53385864556, 11791.587294444997], "value": 8894.730549844557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.303775960981, 1453.920034398108, 1512.969740605188, 1658.2454982982745, 1793.659204751098, 7804.4146688998335, 8679.0, 8939.195472407482, 8976.057513961037, 9203.0, 8939.910600893989, 9063.546822658856, 9074.455532668044, 9079.092090790917, 9084.818303633923, 2306.1928325086255, 2336.8013718833918, 2349.9295021149305, 2352.329586067971, 2353.5175289065787, 2322.1175953137786, 2348.753380895007, 2375.2874137758604, 2378.3935096550354, 2381.9642705359433, 2326.7556906524824, 2341.1805867946255, 2348.3307257431634, 2374.1334412939327, 2380.571497130516, 2283.406314358279, 2304.781045800646, 2305.239271040561, 2308.4805918668335, 2337.8480398774195, 2284.4403121235405, 2287.867505584746, 2287.942801429961, 2291.3584196425027, 2291.46150654596, 8525.786855328604, 8591.785205369915, 8608.182222688834, 8965.910340896573, 9015.594298256594, 5127.1796512558185, 5316.548093412064, 5344.732763361816, 5358.0, 5373.677579345252, 3341.532185494033, 3494.7204223662047, 3530.1527633368064, 3562.928741425157, 3577.9105522362147, 1020.9132223760989, 1068.8931106889327, 1069.2675517270695, 1092.9344239345664, 1103.2828661370093, 12476.313802740846, 12483.251004939733, 12546.68633284166, 12565.685857853536, 12603.495860165582, 4316.589923957219, 4496.955030449719, 4609.53904609543, 4609.792559334838, 4637.652176086807, 9933.106020458194, 9936.850947235796, 9940.403575785476, 9942.055504727039, 9944.25418093646, 5259.05337039329, 5285.07511185541, 5286.0, 5299.735013249322, 5329.413764485904, 4178.770167640809, 4314.827406903689, 4764.618830493552, 4885.438174609894, 4948.90102197954, 3621.27574485104, 3724.0875985383755, 3747.138158223624, 3815.8282877270035, 3829.368154254517, 1160.2110564816005, 1163.6334554615269, 1174.2191442690687, 1175.6663023897556, 1184.579474286633, 774.2799196747079, 823.7816978500703, 867.5835598912557, 958.6261358070358, 986.1420564109271, 5822.854428639318, 5859.53123750099, 5914.781956766213, 6050.6672133032225, 6215.782447614311, 892.9285657147412, 904.615538396179, 952.7094236258008, 953.9618415263451, 999.1307562420741, 3758.361078616642, 3942.231264903374, 4005.4792876925812, 4056.472658554428, 4121.052158003676, 10469.9476502617, 10874.728131796768, 10948.397838118979, 10979.133547296979, 11140.331580105058, 10628.36229826213, 10778.137748980063, 10807.405592692478, 10882.183836212316, 10907.454627268606, 8276.0, 8445.11326310753, 8449.57752112392, 8449.704260350858, 8461.746147615582, 5533.529649979797, 5559.610827242054, 5695.629784064023, 5790.610253539036, 5823.534117270693, 10188.337758045704, 10221.131203847755, 10290.176785857264, 10365.0, 10366.06705396518, 9503.334766566273, 9736.318457707892, 9935.751606209902, 9953.402795831984, 10231.795364092824, 7471.626418678936, 7705.30652241301, 7721.691132354643, 8489.787755306166, 8701.129887011248, 7740.225977402215, 7801.219878012381, 8160.5103693778565, 8420.957895210484, 8541.572921354033, 7625.428092892944, 7688.231176882267, 7743.341815945708, 7854.2145785421, 7958.721444749406, 7490.625468726651, 7648.34989025939, 7661.961690191513, 7672.194419585863, 7750.8449831001935, 6682.431993280626, 6853.280405557544, 6859.5541289816, 6865.244823069558, 6866.793996180123, 5024.673396229234, 5234.398044224963, 5263.105272103675, 5309.309789727311, 5380.192971054373, 5179.870503237449, 5180.766865491138, 5189.221616757516, 5244.292020577173, 5501.037318469332], "value": 4600.242456985007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.43778949049664, 321.52574951945877, 328.60895534314164, 328.9440795064839, 334.2496096263888, 5056.696598204101, 5130.358705161855, 5230.84307470776, 5246.18684103964, 5281.577473802096, 5066.341375621164, 5148.510891465305, 5162.65770899566, 5182.533571978521, 5204.8698782530455, 4107.473903549326, 4123.0, 4125.360569111777, 4125.587441255881, 4135.503739551258, 3804.6385593368586, 3963.564007959122, 4154.5222299435645, 4156.231097247019, 4157.62798276568, 3996.3406038003695, 4080.0, 4103.753774773509, 4105.733127346728, 4116.855910043149, 4096.754194748325, 4098.959010409888, 4100.487439070116, 4103.158852435258, 4106.425100485934, 3641.8725344612812, 3645.8723944662074, 3653.269346130758, 3659.835307411173, 3665.4868318435174, 4929.8028078876805, 5071.847844564669, 5106.0, 5110.48895110486, 5123.538881500683, 4696.9530304696855, 4699.67102302839, 4702.388689470381, 4707.71753694776, 4709.199436095838, 5331.256738948128, 5488.53347465466, 5491.341039075297, 5498.5876059295315, 5501.359347513176, 3901.2587608354606, 3930.7641541507314, 3935.5474120476224, 3946.940795888064, 3988.900277493057, 5630.198336532311, 5649.802256920988, 5655.830325090213, 5657.462541058593, 5692.576855786054, 4084.101497670508, 4092.4884389451317, 4094.651954583834, 4098.975256185953, 4109.568495308009, 3828.5788563258575, 4043.029672878547, 4077.347624380085, 4082.81627326771, 4137.262349813086, 4651.81378748417, 4657.930131048037, 4663.48701642819, 4665.790039448233, 4665.813367465331, 5509.834704958857, 5511.751971161308, 5514.0, 5529.700520377708, 5535.806246781343, 1373.368250604733, 1397.4969011155977, 1397.5807257822612, 1403.8525954774807, 1409.689868228988, 872.1714371347118, 895.2927187521915, 900.3742399032609, 906.5014242166782, 908.2325435007408, 4649.883752906205, 4680.485146633868, 4702.388689470416, 4707.364505791675, 4711.717296962193, 4923.852284431473, 4938.975305123451, 4966.850994470172, 4968.726720030433, 4974.0797952378925, 4511.842085527056, 4651.62786977041, 4687.273472611751, 4693.249080147229, 4717.976410117996, 2653.641758362635, 2655.522006038893, 2656.2336046529226, 2663.2821829919594, 2676.906308279201, 5083.262926875583, 5084.796608135707, 5088.92366614501, 5110.3356563646485, 5142.871428214325, 4676.321933319718, 5026.949730502648, 5044.545990860766, 5050.595952323805, 5065.772040258197, 5061.721605311744, 5099.424790480858, 5126.5898728101665, 5170.767315470737, 5204.817831375959, 4989.55094041538, 4993.275974983534, 5000.0, 5000.77496512665, 5012.248162775467, 4888.242322440027, 4890.364252647276, 4940.333055037524, 5172.7155006475, 5597.160425936142, 5875.471207591338, 5883.882322353444, 5884.529237661062, 5911.527077833677, 5918.674472904032, 3722.218334149859, 4055.7160998730988, 4062.2687916175373, 4062.431259623596, 4067.389891516178, 5219.973900130475, 5515.448455154453, 5516.469459545814, 5635.577331700057, 5646.802361917313, 5516.310461192351, 5525.834224973257, 5539.916901246565, 5540.556755459635, 5549.863302628436, 5350.464953504618, 5482.533984611353, 5487.679953627998, 5493.615446918678, 5512.503874651301, 5458.4814442627885, 5463.672179669074, 5466.180072989084, 5481.369642491005, 5507.917381239365, 5506.476884695948, 5526.585506086979, 5562.332520097614, 5567.969925563783, 5570.6657600544095, 5304.522592966651, 5414.10667239901, 5414.431484694051, 5435.701036443033, 5445.618806683494], "value": 4065.611374664347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.6843736100075, 706.7561691216529, 715.2204097533687, 733.0470388494955, 781.0900301149162, 15679.529614111581, 16884.577885552866, 16922.0, 16928.068956207404, 16938.32246710133, 14178.574642760734, 14244.71510569788, 14276.0, 14276.71446571068, 14280.214588197645, 657.7106073327733, 678.6708446403491, 801.9959900200491, 805.9476134051297, 829.1045670675655, 808.6239898447221, 814.9633266502992, 816.1797393619404, 819.4673462249526, 820.8645573480369, 859.7979474823411, 864.0365991919028, 864.8270345930839, 866.7356456280831, 871.4335681806813, 693.4764252988987, 714.2892821642447, 821.6631181215732, 847.4660963592959, 852.8507511185579, 612.6079309242089, 618.7586841131962, 618.9257289125334, 624.0825985800866, 624.2228425610144, 14310.0, 14345.569632911029, 14347.06744061643, 14365.13809171453, 14404.351804168837, 13531.932340338333, 13795.793063104062, 13964.162150271017, 13985.650358741012, 14297.070690405195, 11978.161528692995, 12095.516179352815, 12431.875681243162, 12435.502579896793, 12450.750984980341, 4292.141571685675, 4315.978420107911, 4370.7159034662645, 4378.627816635558, 4389.0, 79626.60186699088, 79734.20265797326, 80156.59921700413, 80278.0, 83974.58012709959, 11070.132621792753, 11092.168087393478, 11183.384913829817, 11194.552217911356, 11347.37589432589, 21537.353879383645, 21646.0, 21676.349709508424, 21707.0, 21812.672809907865, 8039.799005024921, 8046.597670116471, 8161.79595510117, 8173.386995975206, 8431.325493960469, 4422.447194100738, 4451.154280686659, 4517.299818528133, 4569.543045695404, 4576.908461830745, 3520.3487354839435, 3664.0, 3675.503806986076, 3675.889723308305, 3683.171286460525, 605.8333958161453, 608.9695515224221, 615.5383462403198, 623.6538721009883, 624.073251221935, 618.9783357582463, 673.8551211489553, 689.0800780957378, 713.3116542536374, 743.2604558464254, 9394.201492873046, 9729.221662267002, 10088.344257623232, 10192.439415832201, 10290.948545257226, 675.3280485916545, 701.7263267325746, 738.6417587470073, 743.3347154296874, 760.69572171132, 4406.603405693503, 4650.674452788272, 4919.926201106915, 4950.059488697208, 4960.199596055633, 121229.0, 122408.38795806142, 122704.0, 124958.3752081252, 125925.0, 80669.0, 81033.59483202665, 81958.0, 90802.0, 107104.46447767712, 52536.999999999236, 75832.69171157965, 79435.60282198552, 79451.0, 81088.0, 9561.0, 9952.452615106238, 10351.792964140826, 10429.217808664229, 10453.68638940833, 46195.53804461913, 47060.29409558791, 47223.76388118038, 48018.0, 49135.01729965452, 67098.66450667716, 71001.0, 73308.0, 74346.62826685832, 75658.0, 12706.936465317614, 12949.935250324064, 13017.674558136123, 13059.21644701321, 13285.80071298912, 14423.711525769635, 14534.418623254951, 14538.200398977735, 14647.560573182822, 15619.765703514684, 13813.723725525635, 14002.929985350416, 14338.211398373189, 14486.16266457005, 14674.413023479368, 13599.456021759019, 13794.965107676295, 13874.375653095432, 13893.305334733424, 13969.58091257264, 13916.017328966502, 13922.860771392561, 13996.650083747987, 14220.075695079786, 14689.0, 11184.664460066211, 11592.336496740925, 11707.239029463399, 11903.940480297542, 12102.818457722966, 11469.885301146882, 11900.226485278428, 12107.51569937228, 12127.878721213028, 12419.875801241871], "value": 7541.653322410975, "unit": "score"}], "name": "dromaeo_css", "value": 7057.113658884848, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 125.0, 162.0, 124.0, 125.0, 122.0, 128.0, 175.0, 126.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 162.0, 163.0, 162.0, 163.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 112.0, 75.0, 76.0, 76.0, 81.0, 109.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 84.0, 82.0, 84.0, 107.0, 82.0, 83.0, 117.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 52.0, 52.0, 56.0, 52.0, 52.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 64.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 84.0, 89.0, 80.0, 80.0, 81.0, 80.0, 80.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 133.0, 142.0, 138.0, 129.0, 135.0, 140.0, 180.0, 142.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 173.0, 169.0, 167.0, 168.0, 165.0, 171.0, 166.0, 169.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 67.0, 66.0, 70.0, 73.0, 67.0, 67.0, 65.0, 64.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1504.1, "alertThreshold": 2.0}]} 06:38:22 INFO - Return code: 0 06:38:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:22 INFO - # TBPL SUCCESS # 06:38:22 INFO - Running post-action listener: _resource_record_post_action 06:38:22 INFO - [mozharness: 2016-10-17 13:38:22.474285Z] Finished run-tests step (success) 06:38:22 INFO - Running post-run listener: _resource_record_post_run 06:38:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409554944; Read time: 12; Write time: 238032 06:38:22 INFO - TinderboxPrint: CPU usage
13.1% 06:38:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:38:22 INFO - TinderboxPrint: I/O write bytes / time
409,554,944 / 238,032 06:38:22 INFO - TinderboxPrint: CPU idle
8,297.4 (86.9%) 06:38:22 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 06:38:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:38:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103747584; Read time: 0; Write time: 61124 06:38:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289267712; Read time: 0; Write time: 170756 06:38:23 INFO - Running post-run listener: _upload_blobber_files 06:38:23 INFO - Blob upload gear active. 06:38:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:23 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 06:38:23 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:38:23 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:38:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:38:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:26 INFO - (blobuploader) - INFO - Done attempting. 06:38:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:38:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:38:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:27 INFO - (blobuploader) - INFO - Done attempting. 06:38:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:38:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:38:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:28 INFO - (blobuploader) - INFO - Done attempting. 06:38:28 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:28 INFO - Return code: 0 06:38:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea865fbd505af6ee689bd68e99d24d41bd2dd67a39ead21c9ed78a3a25c57bdf1e7fb6db89c258ff84095ec0ea5e0e876874a156fa020d9f5f08497785413fd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec9dc6bdb61ab3daff016baeb664cc9582e6e35728ac9a254a3818d9927f8ced494ccc28d1a84f9348297b9ddddc68c64c65c2863c53c220909c3dcf30b51f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4d52cfd645b9f66bccd54a7a691989c323b5365112610d5b9ac176b7fd4fa5e258d5a175b80bb407da143d0f9d9efa4f1667deaa6beff748540bd20d04f35c"} 06:38:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:28 INFO - Contents: 06:38:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea865fbd505af6ee689bd68e99d24d41bd2dd67a39ead21c9ed78a3a25c57bdf1e7fb6db89c258ff84095ec0ea5e0e876874a156fa020d9f5f08497785413fd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec9dc6bdb61ab3daff016baeb664cc9582e6e35728ac9a254a3818d9927f8ced494ccc28d1a84f9348297b9ddddc68c64c65c2863c53c220909c3dcf30b51f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4d52cfd645b9f66bccd54a7a691989c323b5365112610d5b9ac176b7fd4fa5e258d5a175b80bb407da143d0f9d9efa4f1667deaa6beff748540bd20d04f35c"} 06:38:28 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:28 INFO - Copying logs to upload dir... 06:38:28 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.200906 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-17 06:38:27.582023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:38:27.585082) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea865fbd505af6ee689bd68e99d24d41bd2dd67a39ead21c9ed78a3a25c57bdf1e7fb6db89c258ff84095ec0ea5e0e876874a156fa020d9f5f08497785413fd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec9dc6bdb61ab3daff016baeb664cc9582e6e35728ac9a254a3818d9927f8ced494ccc28d1a84f9348297b9ddddc68c64c65c2863c53c220909c3dcf30b51f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4d52cfd645b9f66bccd54a7a691989c323b5365112610d5b9ac176b7fd4fa5e258d5a175b80bb407da143d0f9d9efa4f1667deaa6beff748540bd20d04f35c"} build_url:https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/CACWdTbxQO6ZMAZkeKf8oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea865fbd505af6ee689bd68e99d24d41bd2dd67a39ead21c9ed78a3a25c57bdf1e7fb6db89c258ff84095ec0ea5e0e876874a156fa020d9f5f08497785413fd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ec9dc6bdb61ab3daff016baeb664cc9582e6e35728ac9a254a3818d9927f8ced494ccc28d1a84f9348297b9ddddc68c64c65c2863c53c220909c3dcf30b51f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4d52cfd645b9f66bccd54a7a691989c323b5365112610d5b9ac176b7fd4fa5e258d5a175b80bb407da143d0f9d9efa4f1667deaa6beff748540bd20d04f35c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:38:27.610753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:38:27.611143) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1476710034.514871-1409316838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:38:27.694013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:38:27.694381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:38:27.694724) ========= ========= Total master_lag: 0.16 =========